builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1482067013.7 results: success (0) buildid: 20161218030213 builduid: 044addfe7d694445be6b59f4f9a3192a revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.696428) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.696889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.697332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.717968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.718308) ========= 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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-18 05:16:54-- 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% 40.2M=0s 2016-12-18 05:16:54 (40.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.851769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.852087) ========= 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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017178 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:53.902384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 05:16:53.902693) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --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 a3ce1fce4f15616f66ac328e4a562d0117c93a0d --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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-18 05:16:54,533 truncating revision to first 12 chars 2016-12-18 05:16:54,533 Setting DEBUG logging. 2016-12-18 05:16:54,533 attempt 1/10 2016-12-18 05:16:54,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3ce1fce4f15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 05:16:55,398 unpacking tar archive at: mozilla-central-a3ce1fce4f15/testing/mozharness/ program finished with exit code 0 elapsedTime=1.179790 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 05:16:55.094536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:55.094828) ========= script_repo_revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:55.095205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:55.095464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 05:16:55.104305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-18 05:16:55.104569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:55 INFO - MultiFileLogger online at 20161218 05:16:55 in /builds/slave/test 05:16:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:16:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:55 INFO - {'append_to_log': False, 05:16:55 INFO - 'base_work_dir': '/builds/slave/test', 05:16:55 INFO - 'blob_upload_branch': 'Firefox', 05:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:55 INFO - 'branch': 'Firefox', 05:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:55 INFO - 'config_files': ('talos/linux_config.py',), 05:16:55 INFO - 'default_actions': ('clobber', 05:16:55 INFO - 'read-buildbot-config', 05:16:55 INFO - 'download-and-extract', 05:16:55 INFO - 'populate-webroot', 05:16:55 INFO - 'create-virtualenv', 05:16:55 INFO - 'install', 05:16:55 INFO - 'run-tests'), 05:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:55 INFO - 'download_minidump_stackwalk': True, 05:16:55 INFO - 'download_symbols': 'ondemand', 05:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:55 INFO - 'installer_path': 'installer.exe', 05:16:55 INFO - 'log_level': 'info', 05:16:55 INFO - 'log_name': 'talos', 05:16:55 INFO - 'log_to_console': True, 05:16:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:55 INFO - 'opt_config_files': (), 05:16:55 INFO - 'pip_index': False, 05:16:55 INFO - 'sps_profile': False, 05:16:55 INFO - 'sps_profile_interval': 0, 05:16:55 INFO - 'suite': 'dromaeojs', 05:16:55 INFO - 'system_bits': '32', 05:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:55 INFO - 'title': 'talos-linux64-ix-010', 05:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:55 INFO - 'use_talos_json': True, 05:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:55 INFO - 'work_dir': 'build'} 05:16:55 INFO - [mozharness: 2016-12-18 13:16:55.832279Z] Running clobber step. 05:16:55 INFO - Running pre-action listener: _resource_record_pre_action 05:16:55 INFO - Running main action method: clobber 05:16:55 INFO - rmtree: /builds/slave/test/build 05:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:56 INFO - Running post-action listener: _resource_record_post_action 05:16:56 INFO - [mozharness: 2016-12-18 13:16:56.300548Z] Finished clobber step (success) 05:16:56 INFO - [mozharness: 2016-12-18 13:16:56.300651Z] Running read-buildbot-config step. 05:16:56 INFO - Running pre-action listener: _resource_record_pre_action 05:16:56 INFO - Running main action method: read_buildbot_config 05:16:56 INFO - Using buildbot properties: 05:16:56 INFO - { 05:16:56 INFO - "project": "", 05:16:56 INFO - "product": "firefox", 05:16:56 INFO - "script_repo_revision": "production", 05:16:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:16:56 INFO - "repository": "", 05:16:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:16:56 INFO - "buildid": "20161218030213", 05:16:56 INFO - "stage_platform": "linux64-pgo", 05:16:56 INFO - "basedir": "/builds/slave/test", 05:16:56 INFO - "nightly_build": "True", 05:16:56 INFO - "buildnumber": 12, 05:16:56 INFO - "slavename": "talos-linux64-ix-010", 05:16:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:16:56 INFO - "platform": "ubuntu64_hw", 05:16:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:16:56 INFO - "branch": "mozilla-central", 05:16:56 INFO - "repo_path": "mozilla-central", 05:16:56 INFO - "revision": "a3ce1fce4f15616f66ac328e4a562d0117c93a0d", 05:16:56 INFO - "pgo_build": "True", 05:16:56 INFO - "builduid": "044addfe7d694445be6b59f4f9a3192a", 05:16:56 INFO - "slavebuilddir": "test" 05:16:56 INFO - } 05:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:16:56 INFO - Running post-action listener: _resource_record_post_action 05:16:56 INFO - [mozharness: 2016-12-18 13:16:56.303185Z] Finished read-buildbot-config step (success) 05:16:56 INFO - [mozharness: 2016-12-18 13:16:56.303275Z] Running download-and-extract step. 05:16:56 INFO - Running pre-action listener: _resource_record_pre_action 05:16:56 INFO - Running main action method: download_and_extract 05:16:56 INFO - mkdir: /builds/slave/test/build/tests 05:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:56 INFO - trying https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/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 05:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/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 05:16:56 INFO - Downloaded 1361 bytes. 05:16:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:16:56 INFO - Using the following test package requirements: 05:16:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'jsshell-linux-x86_64.zip'], 05:16:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:16:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:16:57 INFO - Expected file size: 21828600 05:16:57 INFO - Obtained file size: 21828600 05:17:01 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 05:17:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:17:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:01 INFO - Fetch https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:17:02 INFO - Expected file size: 21828600 05:17:02 INFO - Obtained file size: 21828600 05:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:17:07 INFO - Expected file size: 14409734 05:17:07 INFO - Obtained file size: 14409734 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:07 INFO - trying https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:17:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/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 05:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/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 05:17:09 INFO - Downloaded 59698613 bytes. 05:17:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:17:09 INFO - mkdir: /builds/slave/test/properties 05:17:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:09 INFO - Contents: 05:17:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:17:09 INFO - Running post-action listener: _resource_record_post_action 05:17:09 INFO - Running post-action listener: set_extra_try_arguments 05:17:09 INFO - [mozharness: 2016-12-18 13:17:09.739092Z] Finished download-and-extract step (success) 05:17:09 INFO - [mozharness: 2016-12-18 13:17:09.739394Z] Running populate-webroot step. 05:17:09 INFO - Running pre-action listener: _resource_record_pre_action 05:17:09 INFO - Running main action method: populate_webroot 05:17:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:09 INFO - '--tppagecycles', 05:17:09 INFO - '7'], 05:17:09 INFO - 'tests': ['tsvgm']}}, 05:17:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['damp', 'tps']}, 05:17:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'tests': ['damp', 'tps']}, 05:17:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['dromaeo_dom']}, 05:17:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['basic_compositor_video']}, 05:17:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:17:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['a11yr', 05:17:09 INFO - 'ts_paint', 05:17:09 INFO - 'tpaint', 05:17:09 INFO - 'sessionrestore', 05:17:09 INFO - 'sessionrestore_no_auto_restore', 05:17:09 INFO - 'tabpaint']}, 05:17:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['tsvgx', 05:17:09 INFO - 'tsvgr_opacity', 05:17:09 INFO - 'tart', 05:17:09 INFO - 'tscrollx', 05:17:09 INFO - 'cart', 05:17:09 INFO - 'tsvg_static']}, 05:17:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:09 INFO - 'tsvgr_opacity', 05:17:09 INFO - 'tart', 05:17:09 INFO - 'tscrollx', 05:17:09 INFO - 'cart', 05:17:09 INFO - 'tsvg_static']}, 05:17:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'talos_options': ['--disable-e10s'], 05:17:09 INFO - 'tests': ['tp5o']}, 05:17:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:17:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'talos_options': ['--disable-e10s', 05:17:09 INFO - '--xperf_path', 05:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:09 INFO - 'tests': ['tp5n']}, 05:17:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:17:09 INFO - 'talos_options': ['--xperf_path', 05:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:09 INFO - 'tests': ['tp5n']}}, 05:17:09 INFO - 'talos.zip': {'path': '', 05:17:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:09 INFO - Running post-action listener: _resource_record_post_action 05:17:09 INFO - [mozharness: 2016-12-18 13:17:09.759835Z] Finished populate-webroot step (success) 05:17:09 INFO - [mozharness: 2016-12-18 13:17:09.759948Z] Running create-virtualenv step. 05:17:09 INFO - Running pre-action listener: _resource_record_pre_action 05:17:09 INFO - Running main action method: create_virtualenv 05:17:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:17:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:09 INFO - Using real prefix '/usr' 05:17:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:12 INFO - Installing pip.................done. 05:17:12 INFO - Return code: 0 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Output received: 05:17:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:17:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Downloading/unpacking psutil>=3.1.1 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:15 INFO - Installing collected packages: psutil 05:17:15 INFO - Running setup.py install for psutil 05:17:15 INFO - building 'psutil._psutil_linux' extension 05:17:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:17:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:17:15 INFO - building 'psutil._psutil_posix' extension 05:17:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:17:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:15 INFO - Successfully installed psutil 05:17:15 INFO - Cleaning up... 05:17:15 INFO - Return code: 0 05:17:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:15 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:17:15 INFO - Using env: {'DISPLAY': ':0', 05:17:15 INFO - 'HOME': '/home/cltbld', 05:17:15 INFO - 'LANG': 'en_US.UTF-8', 05:17:15 INFO - 'LANGUAGE': 'en_US:en', 05:17:15 INFO - 'LOGNAME': 'cltbld', 05:17:15 INFO - 'MAIL': '/var/mail/cltbld', 05:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:15 INFO - 'MOZ_NO_REMOTE': '1', 05:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:15 INFO - 'NO_EM_RESTART': '1', 05:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:15 INFO - 'PWD': '/builds/slave/test', 05:17:15 INFO - 'SHELL': '/bin/bash', 05:17:15 INFO - 'SHLVL': '1', 05:17:15 INFO - 'TERM': 'linux', 05:17:15 INFO - 'TMOUT': '86400', 05:17:15 INFO - 'USER': 'cltbld', 05:17:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:15 INFO - '_': '/tools/buildbot/bin/python'} 05:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:17 INFO - Installing collected packages: mozsystemmonitor 05:17:17 INFO - Running setup.py install for mozsystemmonitor 05:17:17 INFO - Successfully installed mozsystemmonitor 05:17:17 INFO - Cleaning up... 05:17:17 INFO - Return code: 0 05:17:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:17:18 INFO - Using env: {'DISPLAY': ':0', 05:17:18 INFO - 'HOME': '/home/cltbld', 05:17:18 INFO - 'LANG': 'en_US.UTF-8', 05:17:18 INFO - 'LANGUAGE': 'en_US:en', 05:17:18 INFO - 'LOGNAME': 'cltbld', 05:17:18 INFO - 'MAIL': '/var/mail/cltbld', 05:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:18 INFO - 'MOZ_NO_REMOTE': '1', 05:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:18 INFO - 'NO_EM_RESTART': '1', 05:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:18 INFO - 'PWD': '/builds/slave/test', 05:17:18 INFO - 'SHELL': '/bin/bash', 05:17:18 INFO - 'SHLVL': '1', 05:17:18 INFO - 'TERM': 'linux', 05:17:18 INFO - 'TMOUT': '86400', 05:17:18 INFO - 'USER': 'cltbld', 05:17:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:18 INFO - '_': '/tools/buildbot/bin/python'} 05:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:20 INFO - warning: no files found matching '*.txt' 05:17:20 INFO - no previously-included directories found matching 'build' 05:17:20 INFO - no previously-included directories found matching 'dist' 05:17:20 INFO - no previously-included directories found matching '.git*' 05:17:20 INFO - Installing collected packages: jsonschema, functools32 05:17:20 INFO - Running setup.py install for functools32 05:17:20 INFO - warning: no files found matching '*.txt' 05:17:20 INFO - no previously-included directories found matching 'build' 05:17:20 INFO - no previously-included directories found matching 'dist' 05:17:20 INFO - no previously-included directories found matching '.git*' 05:17:20 INFO - Successfully installed jsonschema functools32 05:17:20 INFO - Cleaning up... 05:17:20 INFO - Return code: 0 05:17:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:17:20 INFO - Using env: {'DISPLAY': ':0', 05:17:20 INFO - 'HOME': '/home/cltbld', 05:17:20 INFO - 'LANG': 'en_US.UTF-8', 05:17:20 INFO - 'LANGUAGE': 'en_US:en', 05:17:20 INFO - 'LOGNAME': 'cltbld', 05:17:20 INFO - 'MAIL': '/var/mail/cltbld', 05:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:20 INFO - 'MOZ_NO_REMOTE': '1', 05:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:20 INFO - 'NO_EM_RESTART': '1', 05:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:20 INFO - 'PWD': '/builds/slave/test', 05:17:20 INFO - 'SHELL': '/bin/bash', 05:17:20 INFO - 'SHLVL': '1', 05:17:20 INFO - 'TERM': 'linux', 05:17:20 INFO - 'TMOUT': '86400', 05:17:20 INFO - 'USER': 'cltbld', 05:17:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:20 INFO - '_': '/tools/buildbot/bin/python'} 05:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:17:20 INFO - Cleaning up... 05:17:20 INFO - Return code: 0 05:17:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:20 INFO - Using env: {'DISPLAY': ':0', 05:17:20 INFO - 'HOME': '/home/cltbld', 05:17:20 INFO - 'LANG': 'en_US.UTF-8', 05:17:20 INFO - 'LANGUAGE': 'en_US:en', 05:17:20 INFO - 'LOGNAME': 'cltbld', 05:17:20 INFO - 'MAIL': '/var/mail/cltbld', 05:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:20 INFO - 'MOZ_NO_REMOTE': '1', 05:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:20 INFO - 'NO_EM_RESTART': '1', 05:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:20 INFO - 'PWD': '/builds/slave/test', 05:17:20 INFO - 'SHELL': '/bin/bash', 05:17:20 INFO - 'SHLVL': '1', 05:17:20 INFO - 'TERM': 'linux', 05:17:20 INFO - 'TMOUT': '86400', 05:17:20 INFO - 'USER': 'cltbld', 05:17:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:20 INFO - '_': '/tools/buildbot/bin/python'} 05:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:23 INFO - Downloading docopt-0.6.1.tar.gz 05:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:23 INFO - Running setup.py install for blobuploader 05:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:23 INFO - Running setup.py install for requests 05:17:24 INFO - Running setup.py install for docopt 05:17:24 INFO - Successfully installed blobuploader requests docopt 05:17:24 INFO - Cleaning up... 05:17:24 INFO - Return code: 0 05:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:24 INFO - Using env: {'DISPLAY': ':0', 05:17:24 INFO - 'HOME': '/home/cltbld', 05:17:24 INFO - 'LANG': 'en_US.UTF-8', 05:17:24 INFO - 'LANGUAGE': 'en_US:en', 05:17:24 INFO - 'LOGNAME': 'cltbld', 05:17:24 INFO - 'MAIL': '/var/mail/cltbld', 05:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:24 INFO - 'MOZ_NO_REMOTE': '1', 05:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:24 INFO - 'NO_EM_RESTART': '1', 05:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:24 INFO - 'PWD': '/builds/slave/test', 05:17:24 INFO - 'SHELL': '/bin/bash', 05:17:24 INFO - 'SHLVL': '1', 05:17:24 INFO - 'TERM': 'linux', 05:17:24 INFO - 'TMOUT': '86400', 05:17:24 INFO - 'USER': 'cltbld', 05:17:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:24 INFO - '_': '/tools/buildbot/bin/python'} 05:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:24 INFO - Running setup.py (path:/tmp/pip-CJPhGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:24 INFO - Running setup.py (path:/tmp/pip-by9yhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:24 INFO - Running setup.py (path:/tmp/pip-kL_J03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:24 INFO - Running setup.py (path:/tmp/pip-w8ubKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:24 INFO - Running setup.py (path:/tmp/pip-96irON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:25 INFO - Running setup.py (path:/tmp/pip-IX__S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:25 INFO - Running setup.py (path:/tmp/pip-KP_TGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:25 INFO - Running setup.py (path:/tmp/pip-FlEf2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:25 INFO - Running setup.py (path:/tmp/pip-s1eXx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:25 INFO - Running setup.py (path:/tmp/pip-Y4_FYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:25 INFO - Running setup.py (path:/tmp/pip-HyogGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:25 INFO - Running setup.py (path:/tmp/pip-FbNk6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:25 INFO - Running setup.py (path:/tmp/pip-1yzvTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:25 INFO - Running setup.py (path:/tmp/pip-vNNsq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:25 INFO - Running setup.py (path:/tmp/pip-2m3s8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:25 INFO - Running setup.py (path:/tmp/pip-s6PzN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:25 INFO - Running setup.py (path:/tmp/pip-GwGGqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:25 INFO - Running setup.py install for manifestparser 05:17:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:25 INFO - Running setup.py install for mozcrash 05:17:26 INFO - Running setup.py install for mozdebug 05:17:26 INFO - Running setup.py install for mozdevice 05:17:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Running setup.py install for mozfile 05:17:26 INFO - Running setup.py install for mozhttpd 05:17:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Running setup.py install for mozinfo 05:17:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Running setup.py install for mozInstall 05:17:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Running setup.py install for mozleak 05:17:26 INFO - Running setup.py install for mozlog 05:17:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:26 INFO - Running setup.py install for moznetwork 05:17:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Running setup.py install for mozprocess 05:17:27 INFO - Running setup.py install for mozprofile 05:17:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Running setup.py install for mozrunner 05:17:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Running setup.py install for mozscreenshot 05:17:27 INFO - Running setup.py install for moztest 05:17:27 INFO - Running setup.py install for mozversion 05:17:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:27 INFO - Cleaning up... 05:17:27 INFO - Return code: 0 05:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:27 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:27 INFO - Using env: {'DISPLAY': ':0', 05:17:27 INFO - 'HOME': '/home/cltbld', 05:17:27 INFO - 'LANG': 'en_US.UTF-8', 05:17:27 INFO - 'LANGUAGE': 'en_US:en', 05:17:27 INFO - 'LOGNAME': 'cltbld', 05:17:27 INFO - 'MAIL': '/var/mail/cltbld', 05:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:27 INFO - 'MOZ_NO_REMOTE': '1', 05:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:27 INFO - 'NO_EM_RESTART': '1', 05:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:27 INFO - 'PWD': '/builds/slave/test', 05:17:27 INFO - 'SHELL': '/bin/bash', 05:17:27 INFO - 'SHLVL': '1', 05:17:27 INFO - 'TERM': 'linux', 05:17:27 INFO - 'TMOUT': '86400', 05:17:27 INFO - 'USER': 'cltbld', 05:17:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:27 INFO - '_': '/tools/buildbot/bin/python'} 05:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:27 INFO - Running setup.py (path:/tmp/pip-GLn_Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:27 INFO - Running setup.py (path:/tmp/pip-Epp3DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:28 INFO - Running setup.py (path:/tmp/pip-k247t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:28 INFO - Running setup.py (path:/tmp/pip-_b7C_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:28 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)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:28 INFO - Running setup.py (path:/tmp/pip-oJkY2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:28 INFO - Running setup.py (path:/tmp/pip-fMfi6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:28 INFO - Running setup.py (path:/tmp/pip-J7xFWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:28 INFO - Running setup.py (path:/tmp/pip-PQEXHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:28 INFO - Running setup.py (path:/tmp/pip-wl09qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:28 INFO - Running setup.py (path:/tmp/pip-sIieTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:28 INFO - Running setup.py (path:/tmp/pip-k5xn5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:28 INFO - Running setup.py (path:/tmp/pip-mdN1dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:28 INFO - Running setup.py (path:/tmp/pip-LWziMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:28 INFO - Running setup.py (path:/tmp/pip-pIXGM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:28 INFO - Running setup.py (path:/tmp/pip-1eyAbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:29 INFO - Running setup.py (path:/tmp/pip-ziN_cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:29 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)) 05:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:29 INFO - Running setup.py (path:/tmp/pip-SGhY1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:29 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)) 05:17:29 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)) 05:17:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:31 INFO - Downloading blessings-1.6.tar.gz 05:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:31 INFO - Installing collected packages: blessings 05:17:31 INFO - Running setup.py install for blessings 05:17:31 INFO - Successfully installed blessings 05:17:31 INFO - Cleaning up... 05:17:31 INFO - Return code: 0 05:17:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:31 INFO - Reading from file tmpfile_stdout 05:17:31 INFO - Current package versions: 05:17:31 INFO - argparse == 1.2.1 05:17:31 INFO - blessings == 1.6 05:17:31 INFO - blobuploader == 1.2.4 05:17:31 INFO - docopt == 0.6.1 05:17:31 INFO - functools32 == 3.2.3-2 05:17:31 INFO - jsonschema == 2.5.1 05:17:31 INFO - manifestparser == 1.1 05:17:31 INFO - mozInstall == 1.12 05:17:31 INFO - mozcrash == 1.0 05:17:31 INFO - mozdebug == 0.1 05:17:31 INFO - mozdevice == 0.49 05:17:31 INFO - mozfile == 1.2 05:17:31 INFO - mozhttpd == 0.7 05:17:31 INFO - mozinfo == 0.9 05:17:31 INFO - mozleak == 0.1 05:17:31 INFO - mozlog == 3.4 05:17:31 INFO - moznetwork == 0.27 05:17:31 INFO - mozprocess == 0.23 05:17:31 INFO - mozprofile == 0.28 05:17:31 INFO - mozrunner == 6.13 05:17:31 INFO - mozscreenshot == 0.1 05:17:31 INFO - mozsystemmonitor == 0.3 05:17:31 INFO - moztest == 0.7 05:17:31 INFO - mozversion == 1.4 05:17:31 INFO - psutil == 3.1.1 05:17:31 INFO - requests == 1.2.3 05:17:31 INFO - wsgiref == 0.1.2 05:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:31 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 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:31 INFO - Using env: {'DISPLAY': ':0', 05:17:31 INFO - 'HOME': '/home/cltbld', 05:17:31 INFO - 'LANG': 'en_US.UTF-8', 05:17:31 INFO - 'LANGUAGE': 'en_US:en', 05:17:31 INFO - 'LOGNAME': 'cltbld', 05:17:31 INFO - 'MAIL': '/var/mail/cltbld', 05:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:31 INFO - 'MOZ_NO_REMOTE': '1', 05:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:31 INFO - 'NO_EM_RESTART': '1', 05:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:31 INFO - 'PWD': '/builds/slave/test', 05:17:31 INFO - 'SHELL': '/bin/bash', 05:17:31 INFO - 'SHLVL': '1', 05:17:31 INFO - 'TERM': 'linux', 05:17:31 INFO - 'TMOUT': '86400', 05:17:31 INFO - 'USER': 'cltbld', 05:17:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:31 INFO - '_': '/tools/buildbot/bin/python'} 05:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:31 INFO - Cleaning up... 05:17:31 INFO - Return code: 0 05:17:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17: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', 'jsonschema'] in /builds/slave/test/build 05:17: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 jsonschema 05:17:31 INFO - Using env: {'DISPLAY': ':0', 05:17:31 INFO - 'HOME': '/home/cltbld', 05:17:31 INFO - 'LANG': 'en_US.UTF-8', 05:17:31 INFO - 'LANGUAGE': 'en_US:en', 05:17:31 INFO - 'LOGNAME': 'cltbld', 05:17:31 INFO - 'MAIL': '/var/mail/cltbld', 05:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:31 INFO - 'MOZ_NO_REMOTE': '1', 05:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:31 INFO - 'NO_EM_RESTART': '1', 05:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:31 INFO - 'PWD': '/builds/slave/test', 05:17:31 INFO - 'SHELL': '/bin/bash', 05:17:31 INFO - 'SHLVL': '1', 05:17:31 INFO - 'TERM': 'linux', 05:17:31 INFO - 'TMOUT': '86400', 05:17:31 INFO - 'USER': 'cltbld', 05:17:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:31 INFO - '_': '/tools/buildbot/bin/python'} 05:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:32 INFO - Cleaning up... 05:17:32 INFO - Return code: 0 05:17:32 INFO - Running post-action listener: _resource_record_post_action 05:17:32 INFO - Running post-action listener: _start_resource_monitoring 05:17:32 INFO - Starting resource monitoring. 05:17:32 INFO - [mozharness: 2016-12-18 13:17:32.108702Z] Finished create-virtualenv step (success) 05:17:32 INFO - [mozharness: 2016-12-18 13:17:32.109182Z] Running install step. 05:17:32 INFO - Running pre-action listener: _resource_record_pre_action 05:17:32 INFO - Running main action method: install 05:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:32 INFO - Reading from file tmpfile_stdout 05:17:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:32 INFO - Reading from file tmpfile_stdout 05:17:32 INFO - Output received: 05:17:32 INFO - Usage: mozinstall [options] installer 05:17:32 INFO - Options: 05:17:32 INFO - -h, --help show this help message and exit 05:17:32 INFO - -d DEST, --destination=DEST 05:17:32 INFO - Directory to install application into. [default: 05:17:32 INFO - "/builds/slave/test"] 05:17:32 INFO - --app=APP Application being installed. [default: firefox] 05:17:32 INFO - mkdir: /builds/slave/test/build/application 05:17:32 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'] 05:17:32 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 05:17:49 INFO - Reading from file tmpfile_stdout 05:17:49 INFO - Output received: 05:17:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:49 INFO - Running post-action listener: _resource_record_post_action 05:17:49 INFO - [mozharness: 2016-12-18 13:17:49.344473Z] Finished install step (success) 05:17:49 INFO - [mozharness: 2016-12-18 13:17:49.344722Z] Running run-tests step. 05:17:49 INFO - Running pre-action listener: _resource_record_pre_action 05:17:49 INFO - Running main action method: run_tests 05:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:49 INFO - Python 2.7.3 05:17:49 INFO - Return code: 0 05:17:49 INFO - grabbing minidump binary from tooltool 05:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:49 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 0x2c463f0>, '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 0x2c46cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c471a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:17:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:17:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:49 INFO - Return code: 0 05:17:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 05:17:49 INFO - Using env: {'DISPLAY': ':0', 05:17:49 INFO - 'HOME': '/home/cltbld', 05:17:49 INFO - 'LANG': 'en_US.UTF-8', 05:17:49 INFO - 'LANGUAGE': 'en_US:en', 05:17:49 INFO - 'LOGNAME': 'cltbld', 05:17:49 INFO - 'MAIL': '/var/mail/cltbld', 05:17:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:49 INFO - 'MOZ_NO_REMOTE': '1', 05:17:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:49 INFO - 'NO_EM_RESTART': '1', 05:17:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:49 INFO - 'PWD': '/builds/slave/test', 05:17:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:49 INFO - 'SHELL': '/bin/bash', 05:17:49 INFO - 'SHLVL': '1', 05:17:49 INFO - 'TERM': 'linux', 05:17:49 INFO - 'TMOUT': '86400', 05:17:49 INFO - 'USER': 'cltbld', 05:17:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571', 05:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:49 INFO - '_': '/tools/buildbot/bin/python'} 05:17:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:17:49 INFO - mozversion application_buildid: 20161218030213 05:17:49 INFO - mozversion application_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 05:17:49 INFO - mozversion application_display_name: Nightly 05:17:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:49 INFO - mozversion application_name: Firefox 05:17:49 INFO - mozversion application_remotingname: firefox 05:17:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:49 INFO - mozversion application_vendor: Mozilla 05:17:49 INFO - mozversion application_version: 53.0a1 05:17:49 INFO - mozversion platform_buildid: 20161218030213 05:17:49 INFO - mozversion platform_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 05:17:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:49 INFO - mozversion platform_version: 53.0a1 05:17:49 INFO - using testdate: 1482067069 05:17:49 INFO - actual date: 1482067069 05:17:49 INFO - starting webserver on 'localhost:46651' 05:17:49 INFO - SUITE-START | Running 2 tests 05:17:49 INFO - TEST-START | dromaeo_css 05:17:49 INFO - operating with platform_type : linux_ 05:17:49 INFO - Initialising browser for dromaeo_css test... 05:17:49 INFO - TEST-INFO | started process 9926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6WZLHO/profile http://localhost:46651/getInfo.html) 05:17:53 INFO - PROCESS | 9926 | __metrics Screen width/height:1600/1200 05:17:53 INFO - PROCESS | 9926 | colorDepth:24 05:17:53 INFO - PROCESS | 9926 | Browser inner width/height: 1024/697 05:17:53 INFO - PROCESS | 9926 | __metrics 05:17:54 INFO - PROCESS | 9926 | 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" 05:17:54 INFO - PROCESS | 9926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:55 INFO - PROCESS | 9926 | console.error: PushService: 05:17:55 INFO - PROCESS | 9926 | stateChangeProcessEnqueue: Error transitioning state 05:17:55 INFO - PROCESS | 9926 | UnknownError 05:17:55 INFO - TEST-INFO | 9926: exit 0 05:17:55 INFO - Browser initialized. 05:17:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:55 INFO - TEST-INFO | started process 10010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6WZLHO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:07 INFO - PROCESS | 10010 | RSS: Main: 154116096 05:18:07 INFO - PROCESS | 10010 | 05:18:59 INFO - PROCESS | 10010 | 1482067139018 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] 05:21:09 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46651/tests/dromaeo/cssquery-ext.html) 05:21:11 INFO - PROCESS | 10010 | RSS: Main: 299532288 05:21:11 INFO - PROCESS | 10010 | 05:24:13 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-ext.html (next: http://localhost:46651/tests/dromaeo/cssquery-jquery.html) 05:24:14 INFO - PROCESS | 10010 | RSS: Main: 252772352 05:24:14 INFO - PROCESS | 10010 | 05:27:16 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46651/tests/dromaeo/cssquery-mootools.html) 05:27:17 INFO - PROCESS | 10010 | RSS: Main: 192131072 05:27:17 INFO - PROCESS | 10010 | 05:30:19 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46651/tests/dromaeo/cssquery-prototype.html) 05:30:19 INFO - PROCESS | 10010 | RSS: Main: 199741440 05:30:19 INFO - PROCESS | 10010 | 05:33:22 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46651/tests/dromaeo/cssquery-yui.html) 05:33:23 INFO - PROCESS | 10010 | RSS: Main: 190423040 05:33:23 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:46651/tests/dromaeo/cssquery-yui.html (next: http://localhost:46651/tests/dromaeo/cssquery-dojo.html) 05:36:26 INFO - PROCESS | 10010 | RSS: Main: 280440832 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | __start_tp_report 05:36:26 INFO - PROCESS | 10010 | _x_x_mozilla_page_load 05:36:26 INFO - PROCESS | 10010 | _x_x_mozilla_page_load_details 05:36:26 INFO - PROCESS | 10010 | |i|pagename|runs| 05:36:26 INFO - PROCESS | 10010 | |0;dojo.html;3017.0948715385384;3055.5569442430833;3058.373033528126;3080.3993221321825;3094.504879219325;5106.208537676657;5128.333316668828;5137.717425541594;5173.042987047399;5178.326817513723;5093.668911520748;5219.086659834523;5237.214417837326;5238.8690282742955;5241.42344342122;4608.078384323132;4654.255319148945;4701.2478003519445;4702.05958808238;4738.502457241992;4675.438947326325;4707.505711900252;4739.549742774431;4755.429348478187;4798.5201479852085;4800.711957282557;4813.446453657822;4826.276058591205;4874.683145595525;4883.340748998893;4628.467726211495;4654.557817007379;4663.720176789404;4693.296005599153;4753.168195565762;4694.43666759991;4710.717356958594;4716.363290955712;4745.786439610226;4788.425388953313;5163.406208286057;5192.506711862367;5194.194899790501;5198.740062996835;5253.658512196733;5415.9458405415835;5569.275994120779;5599.216109744639;5605.215269862222;5618.269624948731;5491.121420572689;5569.693666848321;5576.665400076008;5578.470045345685;5581.6930068846195;5159.484051594811;5218.843434696965;5225.843224703265;5228.2680424740565;5229.294045303874;5633.042382794934;5638;5664.291963504562;5668.744906479218;5704;5389.27244821944;5408.296921400193;5433.8369848904595;5450.264214331094;5464.9180262296095;5299.205119232146;5316;5504.504594586427;5528.281323427928;5576.832695019156;5427.592930530226;5435.7825686972865;5470.152126420411;5497.670139791625;5551.278333816578;5473.808416705396;5520.696361700145;5521.420250873681;5523.613347065747;5573.916391254134;4165.583441655871;4242.215190189825;4246.596573325529;4258.190943720683;4288.949207444134;3776;3779.8677046303796;3797.6202379761803;3816.561095474056;3817.8854634361014;5246.580273578181;5257.316548848626;5260.684358938476;5264.842054738364;5292.761825717852;5512.5589952803675;5523.088690366125;5525.281713377235;5526.834194974157;5571.526420254324;5090.440051594322;5124.077666020077;5144.202648589475;5161.354830646169;5192.792288308426;4773;4775.880602984884;4777.665563410528;4810.39870016248;4821.493743156918;5612.5229355504425;5644.153376993484;5649.293838270216;5655.886882262332;5706.457886500776;5300.416954135119;5316.521513063843;5465.781368745205;5527.53015993645;5531.308586426697;5613.691246981455;5668.801591944262;5669.376368599368;5734.168545560787;5740.827775166752;5408.215808707794;5456.42707515721;5457.099578569491;5461.044317244387;5462.562994960473;5412.702301373462;5449.945500544944;5536.695481748542;5554.694491802989;5562.415946325739;5321.920171197513;5358.249845021622;5362.0616392132;5365.061114304903;5442.346918369821;5331.466853314638;5375.650582712111;5382.73086345689;5383;5384.838454846361;5328.973355133199;5382.3541175059245;5386.838394848004;5388.24564560954;5399.487048730364;5283.89432211346;5324.920126198032;5429.67421954684;5440.428754980829;5477.424870388551;5384.919226211531;5385.40760516335;5389.919151212656;5423.891522169613;5447.536959358499 05:36:26 INFO - PROCESS | 10010 | |1;ext.html;555.3752028967411;570.3070769015645;576.3314555116066;585.1106318396036;594.23640621801;31228.68771312286;40079;41828.58171418285;41860.37209441857;45200;42512.787436062856;42611.78694106533;42694.78652606733;42841;42903.35644965328;8649;8800.207981281683;8820.779480512974;8823.161799629024;8830.47017178968;7651.081870175559;7913.406494512906;10125.746856328577;10386.63646772363;10386.948065259701;10509.527071281773;10568.682939511827;10577.84133238002;10582.259241853073;10588.576456941713;10457.320274182153;10470.581176752921;10507.684769456928;10521.158307335394;10522.210834187466;10325.43210123443;10393.48032598367;10401.375917444977;10402.843957340647;10412.895871041268;39460.802695986626;39758.40362394566;39758.60241397607;39782.20435591301;39814.407423703015;3266.869325226988;3319.767616266862;3348.765586408928;3363.2768954674616;3386.9661303387143;28788.712112878813;28790.712092879014;30542.113261877992;30620.387592248255;30732.38535229305;4137.40007698885;4138.689598280141;4198.8320467181275;4285.764282964436;4384.101259241847;335200.1839852806;336704;340225;340559.2972035149;342435;50377.49622503728;50735;50797;50920;50932;53146.73426632842;53181.2022819658;53188.010899182715;53246.46753532415;53276;13645.931770341085;13887.166769993833;13930;13938.442462301597;13977.86022139786;10162.085412312927;10826.025657690689;10895.128389728803;10905.182111341523;10915.563377464812;14512.492062777752;16206.675866482605;16492.917535412485;16676.33294668224;16793.328266869434;6548.312427195171;6659.368454728622;6662.533622646368;6706.524564595781;6814.625195614289;854.598338780772;934.7289286107089;1015.456730649114;1042.9739256518496;1058.4125810175274;31075.533866992013;31172.233136869752;31242.843785780926;31620;32044.19889502781;1003.307717674802;1008.6268080810147;1031.5564307347763;1074.6668532754716;1085.7394225385851;16072;16545.25546350417;16606.916965415097;16634.75047874283;16658.97439714956;514597;517718;518814;520647;520781;56750;57508.13737793936;57529;57590.13614795781;57664.71167644135;1203.5787474384072;1243.5088140184757;1271.1356277731231;1301.7136230029378;1309.7904335306305;28970.42059158847;31599;32373.51439728453;33735.83132084324;33813.323733525685;54395;55053;55080.449195509136;55109.448905510435;55135.172972406246;418896;419466;422111;423652;425507;25198.74801251964;25817;27407.314817129733;27815.16554503368;32248.83875580607;34760.304793904485;35957.20213989342;37201.6279837209;39706.2058758829;40759;34764.47853282152;36635;36758.44862327121;36883;36956.26087478289;35983.100422489646;36031.81984090063;36188.819055904554;36316;36490.45264320984;35961.640383596874;36166.63833361633;36221.45667814932;36270.09324766902;36369.45445818262;30993.225169370045;32667.836660816545;33075.66924330822;33199.66800331966;33310;25366.239012829643;25522;25531.23406297814;25831.870840645675;25953.091641792445 05:36:26 INFO - PROCESS | 10010 | |2;jquery.html;355.5200479352872;369.70977782440787;378.9412641040638;381.427858212681;397.4832717467292;13963.790543141848;17292.221850016766;17544.912275438604;18127;19099.618007639838;17861.7320740189;17932.64134717308;18321;18438.44684659459;18652.720209196872;5386.919196212069;5519.172124181365;5542.473465020817;5547.472990065938;5555.972220138894;4067.715259931791;4253.51084625269;5454.91817622736;5549.667019978814;5898.469137777599;6100.877982440348;6210.4100110489435;6214.042576588383;6218.626882387071;6218.844528886769;5955.136505206742;6068.484178844804;6091.329953705089;6099.9085013724825;6207.410296021871;5416.891662166735;5419.376771671269;5420.620556561043;5420.945790542123;5422.755975981051;21801;22010.707911957175;22169.224077157385;22212.222572210056;22347.776522234893;1981.73246611707;2380.595298799208;2398.0647547456506;2550.744925507453;2666.3334166458385;9846.556904939294;9918.702438926844;10214.846777298271;10527.420991845445;11415.885841141566;1883.9811601883944;1913.8181872722068;1914.2056046740724;1921.3659492367485;1928.1708865187964;64437;76264;78617.60691196565;79988.20011799865;82034.17965820325;10438.164946804238;10539.789204216026;10711.410872401937;10802.459877006118;10916.890831091747;14621.19583422922;14699.26503674812;14740.631484212981;14758.188299643409;14782.556523304318;7582.203868593719;7735.187805280365;7762.534247945141;7795.922040779633;7880.566568838769;7281.5631062136445;7352;7551.697932082655;7571.318581327707;7588.506747061423;4405.823767049282;4512.278035514302;4545.909081818345;4583.106294272651;4611.515790841913;1841.2082804393972;1889.6315218532254;1900.0503687893115;1915.789263181049;1929.4501067195781;805.1023109233163;947.6920000999564;958.9978472496258;1016.8474728790741;1064.797688439194;18114.63770724578;18839.152238149316;18945;18948.43154705361;19337.903310483358;932.1889955738551;940.8071345374182;941.4586612697726;955.8040601676639;989.5398639632606;10005.299629026043;10455.686329409978;10547.208959328082;10579.100776433936;10581.947090264499;315685;327437;428162;428563;433086;64212;68977.65511172412;91252;92808;93071.53464232635;948.9383190092622;971.0823272008026;1009.7021378693303;1009.7728011197569;1013.381837079381;16429.58926026859;16656.41702540454;16915.830841691426;17301.307947682457;17374.652506950042;37933.430998534495;38216.61783382242;38469.00913912825;38730;40372.596274036885;50934.49065509297;52707.47292527179;53027.73486132699;54971.175432367745;55183.72408137934;7992.600369981594;8121.106678265504;8156.510609363457;8179.836403271782;8361.790955226168;10637.787244255227;11936.4031798408;12464.815842494949;12525.248485090924;12539.686507837378;11113.271415681065;11204.831927521256;11274.661760147208;11471.598494053002;11563.6530904073;10906.61826836057;11009.724756881142;11068.944655276995;11164.609238676607;11230.382328971986;10995.065419439437;11083.113350931744;11193.384363860067;11384.316940983568;11404.771904562029;7845.490043147177;8059.717909873127;8186.058603260463;8236.846841442082;8270.048944371474;9632.855507167538;10531.157507399543;10818.783624327312;11111.499982500645;11290.548378064785 05:36:26 INFO - PROCESS | 10010 | |3;mootools.html;1280.5710087120815;1342.0873805812048;1365.4333451617576;1454.2510607037377;1659.1289572974188;6673.599584024956;7266;7495.100587929443;7510.81222969426;7659.578723170223;7489.812754681136;7559;7567.62161891906;7569.243075692441;7574.545527268368;1808.9185986630566;1876.55900863297;2053.4455696961772;2087.551176497053;2089.1747759634936;2041.1937284772505;2111.0711287033655;2120.639491286485;2129.127057906259;2131.2221039320693;2049.579836133589;2057.2799520167973;2059.289545106943;2060.2274147194803;2061.7525896892394;2076.522399848036;2101.3800928726064;2104.4844013216784;2105.1789801977243;2107.95784084319;2055.3011975928107;2055.732754741889;2061.093119027623;2065.328768150357;2072.295419557358;7250.202477727498;7402.666879990414;7405.74079907206;7410.147832999221;7410.481266311361;4597.195490789132;4708.646851486153;4717.174494463455;4718.504557021498;4718.811247550094;2957.3050333171686;3104.161876293388;3104.5343198520177;3109.2693217093965;3109.8445077746023;934.7709811096325;962.273483519945;986.7779749556364;1013.5287091502487;1021.8109649714827;10016.849747253797;10059.597616095347;10063.597456101747;10076.143527800146;10095;3993.5838817514987;4165;4241.597048280409;4244.3209086546;4335.414719012893;8589.871151932726;8590.35572332065;8607.61265743043;8614.05245423003;8643.17889800468;4650.790714417859;4665.486796452387;4725.8582242532775;4730.101280756645;4732.124556956974;3990.541087774885;4005.459262999516;4220.493540775126;4351.3255445405375;4356.215881141425;3437.9312413751586;3507.3511400391008;3538.3807833629526;3538.7522873398616;3566.144125409883;1127.8026345389524;1154.8267759836092;1156.040486396289;1164.5865717670274;1166.6733314671906;804.939629527776;873.8033942362918;903.76953876761;941.5245301123026;944.390867890207;5180.145276029489;5271.920921186185;5306.416294207634;5369.40936496985;5420.24116623673;400.22756080764407;402.3582386094175;410.20625090450073;946.7159852044359;963.3545524498603;3669.9816500917323;3776.2258736958856;3791.867284645024;3807.2385522895534;3828.885133446001;8777.561121944005;8948.328875334377;8981.820363592822;8999.730008099768;9064.456132632064;8966.68616598416;8967.910320896837;8969.775755606162;8971.730848074569;8995.685151019683;6747.932520674731;7050.964745176241;7136.928630713626;7140.5358651687475;7146.606936618536;5099.36257967754;5171.586273098218;5173.663711858868;5251.133562962068;5269.8682532935445;8372.497650140767;8470.915290847259;8501.95749021251;8558;8572.485650860968;8221.260086592236;8273.379496537904;8282.958585207036;8579.184977427383;8583.914160858312;6292.622442653455;6452.774152904626;6457.4511166551365;6766.594004359754;6912.688928998106;6869.553479023847;6914;7008.649567521706;7174.1032370953635;7232.312930271616;6577.901331480128;6579.374959378852;6605.768798092044;6658.700358483977;6836;6370;6469.126667899774;6473.838154045998;6515.771947981798;6521.250056243403;6056.788012419544;6060.272767267956;6074.544409169418;6119.816405507842;6122.326544080059;4377.1683380157665;4443.222436073739;4475.753833539056;4491.932621010622;4586.174488592085;4518.43519560055;4564.201264778584;4623.583877451046;4676.3686902267755;4844.249141383091 05:36:26 INFO - PROCESS | 10010 | |4;prototype.html;357.9946300805487;362.76782858970245;364.218750779578;374.7451732821682;374.82383279858465;5236.659617124884;5267.52592266696;5276.947230527693;5290.947090529094;5300.330395925285;4938.407391113072;5063.493650634944;5074.492550744923;5114.616403769723;5210.8697282567955;4120.402541631476;4137.9172416551655;4138.937915931264;4141.585841415849;4153.4392856964305;4126.587341265879;4132.710710250284;4140.157629854716;4140.896477588054;4146.232946904832;3870.574236833946;3898.966773804944;4093.529244136918;4101.569335219804;4108.67130629549;4112.157007813391;4116.662084822445;4120.855770048064;4126.3397856343145;4142.715758114979;3700.7224458165747;3703.3148867459336;3707.8887633370773;3711.981440092782;3718.4980027696183;4840.419149702023;5024.773885175176;5033.6224783141415;5046.44489106198;5063.594912406998;4557.630032383142;4557.886052848672;4594.333821595883;4601.631869450436;4622.95377046232;5418.864528386783;5421.403645598981;5427.782888684448;5432.456754324576;5436.456354364572;3822.178231680174;3878.437626544135;3897.8830635080994;3904.9219015619815;3922.37242041272;5518.255035570187;5586.37994981459;5590.524805391547;5596.972015139898;5612.579056570774;3941.270864889947;3950.0914789598555;3954.2486927483687;3962.4650672159464;3971.815501474178;3941.4876066111224;4027;4032.737872038308;4040.2121586290978;4043.4137050128156;4530.708748006802;4543.7728113594185;4551.6117584137155;4567.680262381601;4570;5399.973000135053;5402.459754024645;5411.350637923474;5419.991904493044;5439.88482361115;1353.7766268565774;1364.167857606879;1364.5292374130909;1366.8701473360015;1367.0908845617753;867.9132086791396;876.1413814461863;877.2937785083069;916.6241840845222;926.7312479380904;5063.8480845574695;5083.567896728746;5087.440381558025;5095.745212739348;5114.616403769732;5380.946190538045;5385.434529374359;5386.622936394493;5393.7303134843105;5418.4039755626845;4921.729304888266;5079.97460012705;5091.5672167865405;5144.71704056273;5161.948380516222;2794.6646402431434;2827.2790438438064;2830.7735381169455;2844.928876778097;2860.3993161435915;5308.681479111188;5470;5476.2333273341765;5492.752826122834;5505.587080968943;5333.839984800462;5380.838574842761;5401.7299135043095;5422.593305502103;5434.8913021739345;5400.515762749101;5417.10617748075;5440.483154100354;5453.318335208099;5477.890442191214;4997.250962163213;5295.814646487354;5304.814331498379;5323.6273460857365;5347.224652425454;5238.528532432099;5311.49540793624;5318.335208098988;5337.866553336197;5359.892802143857;5422.132458806572;5428.945710542844;5471.823557935063;5473.781048758005;5506.174073888948;3761.191343861083;3877.340852055214;3898.3957486589625;3901.941470877996;3918.4122381642983;5328.573714102785;5329.227262047059;5353.759080841293;5376.274202982548;5397.59518036141;5223.589630799739;5223.712695801767;5225.6603320784025;5261.000819688494;5299.648589609625;5181.922271166011;5209.4009188943755;5231.241469986754;5470.835874923759;5495.203195536545;5179.715115668674;5301.5493683037375;5405.513463806693;5418.667519475573;5438.293021907127;5323.547498462674;5455.481729235717;5498.202760599611;5502.449755024466;5512.173174023928;5385.353757549119;5396.514313711785;5400.621956463167;5403.351597808131;5413.269208656781 05:36:26 INFO - PROCESS | 10010 | |5;yui.html;721.3219573600815;729.6278897762139;755.2485277149237;783.8118851475648;797.5294576200042;15403.69192616147;15741.842581574181;16610.086445245506;16644.1677916104;16658;14093.859061409383;14206.786898196535;14226.288685565707;14236.857631423683;14243.71512569748;635.2757856044125;670.3464122480591;756.4100001998422;780.2782426255719;784.0669603172207;779.9298063174314;782.1513657681422;784.4587234807992;785.2461636828623;787.0633945604741;827.1149869639488;829.2246749289434;831.1978940322588;833.1044127562864;835.5321020228691;688.3873352716087;712.8146681862701;834.2075028722737;834.3908946469081;835.7283882738074;591.8845825064114;598.2193237824681;607.6475644126396;608.1728848765675;609.1198218574162;13496;13590.932045339809;13620.250886201255;13626;13641.931790341085;13497.392617332145;13556.322183890865;13580.1851888886;13619.455221791215;13720.382582783799;12529.498820047187;12566.68583285416;12575.748485030339;12881.484740610458;12962;4259.254630439692;4296.505901821268;4346.835016501345;4373.431453910971;4492.034212644265;68457;69912.650436748;71109;71678.64160679163;72623.63688181526;10665.146788257076;10705;10720.142388608892;11078.113750899909;11264.887351126548;19798;19819.405417837486;19839.900800496194;19999.600007999758;20001.099950502263;7505.587192704454;7579.696812127453;7686;7789.883151752728;8033.3974951878845;4049.331860243086;4103.322951712934;4213.789310534461;4250.829966801293;4290.785460726951;3056.3581647853757;3110.8755649774207;3140.1364624727926;3142.245860993345;3159.0996565979044;544.6976927805106;550.8457631863084;551.2117671729385;565.197419664078;568.2726110578466;546.9781208751685;559.2561892682803;650.8145178624069;657.2868437745004;667.4393509452084;8238.711381040459;8681.652733890574;8765.780855478537;8784.824303514022;8972.102789720975;545.9535939445192;567.296552275184;595.5860676829649;609.3479976425272;621.487272999777;4064.4919385076864;4302.419173411549;4351.926303145836;4362.825486980485;4489;71531;71988;72905.2709472909;73908;74920.62539687267;63964;66760.33239667541;66925.6576019837;67216;67331.66334168297;58135.418645813;58369.70815145897;59124;59223.40776592179;59505.999999999134;8009.5995200238585;8257.42198046131;8481.40630155883;8496.362772791941;8642.88102688494;40232.19535609213;40751.1849763009;41799;41892.581074190086;42028.15943681171;50981;55047;56637.15044274257;56689.716551416976;58473.70763146157;11404.031377221989;11415.543378264776;11688.357140357362;11766.470508827295;11908.225965312227;12922.547710830077;12948.223106613634;13017.544385946447;13117.08180427361;13793.655158621115;11852.940735296268;12210.328431936328;12319.815202772144;12665.176763510342;12690.175138615961;11100.389478578756;11528.308301501937;11675.941620292184;12044.337561434206;12052.939735301268;11624.244424112405;12049.277043377426;12410.5656302029;12431.875681243071;12540.561080362144;10027.799444011225;10106.494675266355;10318.329308594917;10551.30704253505;10782.353058816496;9258.768530786785;9520.952395237979;9691.321607487409;10274.948625256826;10615.840762388725 05:36:26 INFO - PROCESS | 10010 | __end_tp_report 05:36:26 INFO - PROCESS | 10010 | __start_cc_report 05:36:26 INFO - PROCESS | 10010 | _x_x_mozilla_cycle_collect,1600 05:36:26 INFO - PROCESS | 10010 | __end_cc_report 05:36:26 INFO - PROCESS | 10010 | __startTimestamp1482068186563__endTimestamp 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | ------- Summary: start ------- 05:36:26 INFO - PROCESS | 10010 | Number of tests: 6 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#0] dojo.html Cycles:165 Average:5137.91 Median:5328.97 stddev:562.57 (10.6%) stddev-sans-first:539.14 05:36:26 INFO - PROCESS | 10010 | Values: 3017.1 3055.6 3058.4 3080.4 3094.5 5106.2 5128.3 5137.7 5173.0 5178.3 5093.7 5219.1 5237.2 5238.9 5241.4 4608.1 4654.3 4701.2 4702.1 4738.5 4675.4 4707.5 4739.5 4755.4 4798.5 4800.7 4813.4 4826.3 4874.7 4883.3 4628.5 4654.6 4663.7 4693.3 4753.2 4694.4 4710.7 4716.4 4745.8 4788.4 5163.4 5192.5 5194.2 5198.7 5253.7 5415.9 5569.3 5599.2 5605.2 5618.3 5491.1 5569.7 5576.7 5578.5 5581.7 5159.5 5218.8 5225.8 5228.3 5229.3 5633.0 5638.0 5664.3 5668.7 5704.0 5389.3 5408.3 5433.8 5450.3 5464.9 5299.2 5316.0 5504.5 5528.3 5576.8 5427.6 5435.8 5470.2 5497.7 5551.3 5473.8 5520.7 5521.4 5523.6 5573.9 4165.6 4242.2 4246.6 4258.2 4288.9 3776.0 3779.9 3797.6 3816.6 3817.9 5246.6 5257.3 5260.7 5264.8 5292.8 5512.6 5523.1 5525.3 5526.8 5571.5 5090.4 5124.1 5144.2 5161.4 5192.8 4773.0 4775.9 4777.7 4810.4 4821.5 5612.5 5644.2 5649.3 5655.9 5706.5 5300.4 5316.5 5465.8 5527.5 5531.3 5613.7 5668.8 5669.4 5734.2 5740.8 5408.2 5456.4 5457.1 5461.0 5462.6 5412.7 5449.9 5536.7 5554.7 5562.4 5321.9 5358.2 5362.1 5365.1 5442.3 5331.5 5375.7 5382.7 5383.0 5384.8 5329.0 5382.4 5386.8 5388.2 5399.5 5283.9 5324.9 5429.7 5440.4 5477.4 5384.9 5385.4 5389.9 5423.9 5447.5 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#1] ext.html Cycles:180 Average:57473.10 Median:341497.15 stddev:114806.96 (33.6%) stddev-sans-first:115049.48 05:36:26 INFO - PROCESS | 10010 | Values: 555.4 570.3 576.3 585.1 594.2 31228.7 40079.0 41828.6 41860.4 45200.0 42512.8 42611.8 42694.8 42841.0 42903.4 8649.0 8800.2 8820.8 8823.2 8830.5 7651.1 7913.4 10125.7 10386.6 10386.9 10509.5 10568.7 10577.8 10582.3 10588.6 10457.3 10470.6 10507.7 10521.2 10522.2 10325.4 10393.5 10401.4 10402.8 10412.9 39460.8 39758.4 39758.6 39782.2 39814.4 3266.9 3319.8 3348.8 3363.3 3387.0 28788.7 28790.7 30542.1 30620.4 30732.4 4137.4 4138.7 4198.8 4285.8 4384.1 335200.2 336704.0 340225.0 340559.3 342435.0 50377.5 50735.0 50797.0 50920.0 50932.0 53146.7 53181.2 53188.0 53246.5 53276.0 13645.9 13887.2 13930.0 13938.4 13977.9 10162.1 10826.0 10895.1 10905.2 10915.6 14512.5 16206.7 16492.9 16676.3 16793.3 6548.3 6659.4 6662.5 6706.5 6814.6 854.6 934.7 1015.5 1043.0 1058.4 31075.5 31172.2 31242.8 31620.0 32044.2 1003.3 1008.6 1031.6 1074.7 1085.7 16072.0 16545.3 16606.9 16634.8 16659.0 514597.0 517718.0 518814.0 520647.0 520781.0 56750.0 57508.1 57529.0 57590.1 57664.7 1203.6 1243.5 1271.1 1301.7 1309.8 28970.4 31599.0 32373.5 33735.8 33813.3 54395.0 55053.0 55080.4 55109.4 55135.2 418896.0 419466.0 422111.0 423652.0 425507.0 25198.7 25817.0 27407.3 27815.2 32248.8 34760.3 35957.2 37201.6 39706.2 40759.0 34764.5 36635.0 36758.4 36883.0 36956.3 35983.1 36031.8 36188.8 36316.0 36490.5 35961.6 36166.6 36221.5 36270.1 36369.5 30993.2 32667.8 33075.7 33199.7 33310.0 25366.2 25522.0 25531.2 25831.9 25953.1 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#2] jquery.html Cycles:180 Average:25184.87 Median:374.33 stddev:64718.53 (17289.4%) stddev-sans-first:64873.23 05:36:26 INFO - PROCESS | 10010 | Values: 355.5 369.7 378.9 381.4 397.5 13963.8 17292.2 17544.9 18127.0 19099.6 17861.7 17932.6 18321.0 18438.4 18652.7 5386.9 5519.2 5542.5 5547.5 5556.0 4067.7 4253.5 5454.9 5549.7 5898.5 6100.9 6210.4 6214.0 6218.6 6218.8 5955.1 6068.5 6091.3 6099.9 6207.4 5416.9 5419.4 5420.6 5420.9 5422.8 21801.0 22010.7 22169.2 22212.2 22347.8 1981.7 2380.6 2398.1 2550.7 2666.3 9846.6 9918.7 10214.8 10527.4 11415.9 1884.0 1913.8 1914.2 1921.4 1928.2 64437.0 76264.0 78617.6 79988.2 82034.2 10438.2 10539.8 10711.4 10802.5 10916.9 14621.2 14699.3 14740.6 14758.2 14782.6 7582.2 7735.2 7762.5 7795.9 7880.6 7281.6 7352.0 7551.7 7571.3 7588.5 4405.8 4512.3 4545.9 4583.1 4611.5 1841.2 1889.6 1900.1 1915.8 1929.5 805.1 947.7 959.0 1016.8 1064.8 18114.6 18839.2 18945.0 18948.4 19337.9 932.2 940.8 941.5 955.8 989.5 10005.3 10455.7 10547.2 10579.1 10581.9 315685.0 327437.0 428162.0 428563.0 433086.0 64212.0 68977.7 91252.0 92808.0 93071.5 948.9 971.1 1009.7 1009.8 1013.4 16429.6 16656.4 16915.8 17301.3 17374.7 37933.4 38216.6 38469.0 38730.0 40372.6 50934.5 52707.5 53027.7 54971.2 55183.7 7992.6 8121.1 8156.5 8179.8 8361.8 10637.8 11936.4 12464.8 12525.2 12539.7 11113.3 11204.8 11274.7 11471.6 11563.7 10906.6 11009.7 11068.9 11164.6 11230.4 10995.1 11083.1 11193.4 11384.3 11404.8 7845.5 8059.7 8186.1 8236.8 8270.0 9632.9 10531.2 10818.8 11111.5 11290.5 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#3] mootools.html Cycles:180 Average:4965.34 Median:5135.47 stddev:2700.02 (52.6%) stddev-sans-first:2693.39 05:36:26 INFO - PROCESS | 10010 | Values: 1280.6 1342.1 1365.4 1454.3 1659.1 6673.6 7266.0 7495.1 7510.8 7659.6 7489.8 7559.0 7567.6 7569.2 7574.5 1808.9 1876.6 2053.4 2087.6 2089.2 2041.2 2111.1 2120.6 2129.1 2131.2 2049.6 2057.3 2059.3 2060.2 2061.8 2076.5 2101.4 2104.5 2105.2 2108.0 2055.3 2055.7 2061.1 2065.3 2072.3 7250.2 7402.7 7405.7 7410.1 7410.5 4597.2 4708.6 4717.2 4718.5 4718.8 2957.3 3104.2 3104.5 3109.3 3109.8 934.8 962.3 986.8 1013.5 1021.8 10016.8 10059.6 10063.6 10076.1 10095.0 3993.6 4165.0 4241.6 4244.3 4335.4 8589.9 8590.4 8607.6 8614.1 8643.2 4650.8 4665.5 4725.9 4730.1 4732.1 3990.5 4005.5 4220.5 4351.3 4356.2 3437.9 3507.4 3538.4 3538.8 3566.1 1127.8 1154.8 1156.0 1164.6 1166.7 804.9 873.8 903.8 941.5 944.4 5180.1 5271.9 5306.4 5369.4 5420.2 400.2 402.4 410.2 946.7 963.4 3670.0 3776.2 3791.9 3807.2 3828.9 8777.6 8948.3 8981.8 8999.7 9064.5 8966.7 8967.9 8969.8 8971.7 8995.7 6747.9 7051.0 7136.9 7140.5 7146.6 5099.4 5171.6 5173.7 5251.1 5269.9 8372.5 8470.9 8502.0 8558.0 8572.5 8221.3 8273.4 8283.0 8579.2 8583.9 6292.6 6452.8 6457.5 6766.6 6912.7 6869.6 6914.0 7008.6 7174.1 7232.3 6577.9 6579.4 6605.8 6658.7 6836.0 6370.0 6469.1 6473.8 6515.8 6521.3 6056.8 6060.3 6074.5 6119.8 6122.3 4377.2 4443.2 4475.8 4491.9 4586.2 4518.4 4564.2 4623.6 4676.4 4844.2 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#4] prototype.html Cycles:180 Average:4506.32 Median:5180.82 stddev:1295.43 (25.0%) stddev-sans-first:1261.09 05:36:26 INFO - PROCESS | 10010 | Values: 358.0 362.8 364.2 374.7 374.8 5236.7 5267.5 5276.9 5290.9 5300.3 4938.4 5063.5 5074.5 5114.6 5210.9 4120.4 4137.9 4138.9 4141.6 4153.4 4126.6 4132.7 4140.2 4140.9 4146.2 3870.6 3899.0 4093.5 4101.6 4108.7 4112.2 4116.7 4120.9 4126.3 4142.7 3700.7 3703.3 3707.9 3712.0 3718.5 4840.4 5024.8 5033.6 5046.4 5063.6 4557.6 4557.9 4594.3 4601.6 4623.0 5418.9 5421.4 5427.8 5432.5 5436.5 3822.2 3878.4 3897.9 3904.9 3922.4 5518.3 5586.4 5590.5 5597.0 5612.6 3941.3 3950.1 3954.2 3962.5 3971.8 3941.5 4027.0 4032.7 4040.2 4043.4 4530.7 4543.8 4551.6 4567.7 4570.0 5400.0 5402.5 5411.4 5420.0 5439.9 1353.8 1364.2 1364.5 1366.9 1367.1 867.9 876.1 877.3 916.6 926.7 5063.8 5083.6 5087.4 5095.7 5114.6 5380.9 5385.4 5386.6 5393.7 5418.4 4921.7 5080.0 5091.6 5144.7 5161.9 2794.7 2827.3 2830.8 2844.9 2860.4 5308.7 5470.0 5476.2 5492.8 5505.6 5333.8 5380.8 5401.7 5422.6 5434.9 5400.5 5417.1 5440.5 5453.3 5477.9 4997.3 5295.8 5304.8 5323.6 5347.2 5238.5 5311.5 5318.3 5337.9 5359.9 5422.1 5428.9 5471.8 5473.8 5506.2 3761.2 3877.3 3898.4 3901.9 3918.4 5328.6 5329.2 5353.8 5376.3 5397.6 5223.6 5223.7 5225.7 5261.0 5299.6 5181.9 5209.4 5231.2 5470.8 5495.2 5179.7 5301.5 5405.5 5418.7 5438.3 5323.5 5455.5 5498.2 5502.4 5512.2 5385.4 5396.5 5400.6 5403.4 5413.3 05:36:26 INFO - PROCESS | 10010 | 05:36:26 INFO - PROCESS | 10010 | [#5] yui.html Cycles:180 Average:16538.12 Median:4490.52 stddev:21089.39 (469.6%) stddev-sans-first:21115.11 05:36:26 INFO - PROCESS | 10010 | Values: 721.3 729.6 755.2 783.8 797.5 15403.7 15741.8 16610.1 16644.2 16658.0 14093.9 14206.8 14226.3 14236.9 14243.7 635.3 670.3 756.4 780.3 784.1 779.9 782.2 784.5 785.2 787.1 827.1 829.2 831.2 833.1 835.5 688.4 712.8 834.2 834.4 835.7 591.9 598.2 607.6 608.2 609.1 13496.0 13590.9 13620.3 13626.0 13641.9 13497.4 13556.3 13580.2 13619.5 13720.4 12529.5 12566.7 12575.7 12881.5 12962.0 4259.3 4296.5 4346.8 4373.4 4492.0 68457.0 69912.7 71109.0 71678.6 72623.6 10665.1 10705.0 10720.1 11078.1 11264.9 19798.0 19819.4 19839.9 19999.6 20001.1 7505.6 7579.7 7686.0 7789.9 8033.4 4049.3 4103.3 4213.8 4250.8 4290.8 3056.4 3110.9 3140.1 3142.2 3159.1 544.7 550.8 551.2 565.2 568.3 547.0 559.3 650.8 657.3 667.4 8238.7 8681.7 8765.8 8784.8 8972.1 546.0 567.3 595.6 609.3 621.5 4064.5 4302.4 4351.9 4362.8 4489.0 71531.0 71988.0 72905.3 73908.0 74920.6 63964.0 66760.3 66925.7 67216.0 67331.7 58135.4 58369.7 59124.0 59223.4 59506.0 8009.6 8257.4 8481.4 8496.4 8642.9 40232.2 40751.2 41799.0 41892.6 42028.2 50981.0 55047.0 56637.2 56689.7 58473.7 11404.0 11415.5 11688.4 11766.5 11908.2 12922.5 12948.2 13017.5 13117.1 13793.7 11852.9 12210.3 12319.8 12665.2 12690.2 11100.4 11528.3 11675.9 12044.3 12052.9 11624.2 12049.3 12410.6 12431.9 12540.6 10027.8 10106.5 10318.3 10551.3 10782.4 9258.8 9521.0 9691.3 10274.9 10615.8 05:36:26 INFO - PROCESS | 10010 | -------- Summary: end -------- 05:36:26 INFO - PROCESS | 10010 | 05:36:27 INFO - TEST-INFO | 10010: exit 0 05:36:27 INFO - TEST-OK | dromaeo_css | took 1117758ms 05:36:27 INFO - TEST-START | kraken 05:36:27 INFO - operating with platform_type : linux_ 05:36:27 INFO - Initialising browser for kraken test... 05:36:27 INFO - TEST-INFO | started process 10307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQplmjz/profile http://localhost:46651/getInfo.html) 05:36:31 INFO - PROCESS | 10307 | __metrics Screen width/height:1600/1200 05:36:31 INFO - PROCESS | 10307 | colorDepth:24 05:36:31 INFO - PROCESS | 10307 | Browser inner width/height: 1024/697 05:36:31 INFO - PROCESS | 10307 | __metrics 05:36:32 INFO - PROCESS | 10307 | 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" 05:36:32 INFO - PROCESS | 10307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:32 INFO - PROCESS | 10307 | console.error: PushService: 05:36:32 INFO - PROCESS | 10307 | stateChangeProcessEnqueue: Error transitioning state 05:36:32 INFO - PROCESS | 10307 | UnknownError 05:36:33 INFO - TEST-INFO | 10307: exit 0 05:36:33 INFO - Browser initialized. 05:36:33 INFO - Running cycle 1/1 for kraken test... 05:36:33 INFO - TEST-INFO | started process 10390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQplmjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:45 INFO - PROCESS | 10390 | RSS: Main: 154284032 05:36:45 INFO - PROCESS | 10390 | 05:36:47 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46651/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:48 INFO - PROCESS | 10390 | RSS: Main: 208240640 05:36:48 INFO - PROCESS | 10390 | 05:36:51 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46651/tests/kraken/driver.html?testName=audio-dft) 05:36:52 INFO - PROCESS | 10390 | RSS: Main: 186290176 05:36:52 INFO - PROCESS | 10390 | 05:36:54 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46651/tests/kraken/driver.html?testName=audio-fft) 05:36:55 INFO - PROCESS | 10390 | RSS: Main: 266985472 05:36:55 INFO - PROCESS | 10390 | 05:36:57 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46651/tests/kraken/driver.html?testName=audio-oscillator) 05:36:58 INFO - PROCESS | 10390 | RSS: Main: 179523584 05:36:58 INFO - PROCESS | 10390 | 05:37:00 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:01 INFO - PROCESS | 10390 | RSS: Main: 182484992 05:37:01 INFO - PROCESS | 10390 | 05:37:04 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46651/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:04 INFO - PROCESS | 10390 | RSS: Main: 222531584 05:37:04 INFO - PROCESS | 10390 | 05:37:08 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46651/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:08 INFO - PROCESS | 10390 | RSS: Main: 222040064 05:37:08 INFO - PROCESS | 10390 | 05:37:11 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46651/tests/kraken/driver.html?testName=json-parse-financial) 05:37:12 INFO - PROCESS | 10390 | RSS: Main: 220971008 05:37:12 INFO - PROCESS | 10390 | 05:37:13 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:14 INFO - PROCESS | 10390 | RSS: Main: 182792192 05:37:14 INFO - PROCESS | 10390 | 05:37:16 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:16 INFO - PROCESS | 10390 | RSS: Main: 190373888 05:37:16 INFO - PROCESS | 10390 | 05:37:18 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:19 INFO - PROCESS | 10390 | RSS: Main: 198713344 05:37:19 INFO - PROCESS | 10390 | 05:37:22 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:22 INFO - PROCESS | 10390 | RSS: Main: 208580608 05:37:22 INFO - PROCESS | 10390 | 05:37:25 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:26 INFO - PROCESS | 10390 | RSS: Main: 204611584 05:37:26 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | Cycle 1(1): loaded http://localhost:46651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46651/tests/kraken/driver.html?testName=ai-astar) 05:37:28 INFO - PROCESS | 10390 | RSS: Main: 255492096 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | __start_tp_report 05:37:28 INFO - PROCESS | 10390 | _x_x_mozilla_page_load 05:37:28 INFO - PROCESS | 10390 | _x_x_mozilla_page_load_details 05:37:28 INFO - PROCESS | 10390 | |i|pagename|runs| 05:37:28 INFO - PROCESS | 10390 | |0;ai-astar;111;113;113;113;112;112;111;113;114;111 05:37:28 INFO - PROCESS | 10390 | |1;audio-beat-detection;155;121;120;176;122;120;126;121;143;125 05:37:28 INFO - PROCESS | 10390 | |2;audio-dft;160;163;160;160;163;164;164;161;160;161 05:37:28 INFO - PROCESS | 10390 | |3;audio-fft;74;77;74;105;76;75;75;74;102;77 05:37:28 INFO - PROCESS | 10390 | |4;audio-oscillator;84;84;106;84;85;84;107;84;85;121 05:37:28 INFO - PROCESS | 10390 | |5;imaging-gaussian-blur;129;127;127;127;128;128;127;127;128;128 05:37:28 INFO - PROCESS | 10390 | |6;imaging-darkroom;148;149;149;147;148;149;148;148;147;148 05:37:28 INFO - PROCESS | 10390 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;95;95 05:37:28 INFO - PROCESS | 10390 | |8;json-parse-financial;52;52;52;53;54;53;53;53;55;54 05:37:28 INFO - PROCESS | 10390 | |9;json-stringify-tinderbox;65;65;64;65;66;65;64;64;65;64 05:37:28 INFO - PROCESS | 10390 | |10;stanford-crypto-aes;80;80;81;81;80;80;79;80;81;81 05:37:28 INFO - PROCESS | 10390 | |11;stanford-crypto-ccm;135;129;125;126;139;129;132;127;174;143 05:37:28 INFO - PROCESS | 10390 | |12;stanford-crypto-pbkdf2;173;175;169;168;173;174;166;169;173;169 05:37:28 INFO - PROCESS | 10390 | |13;stanford-crypto-sha256-iterative;68;69;70;64;64;64;64;63;63;63 05:37:28 INFO - PROCESS | 10390 | __end_tp_report 05:37:28 INFO - PROCESS | 10390 | __start_cc_report 05:37:28 INFO - PROCESS | 10390 | _x_x_mozilla_cycle_collect,1689 05:37:28 INFO - PROCESS | 10390 | __end_cc_report 05:37:28 INFO - PROCESS | 10390 | __startTimestamp1482068248263__endTimestamp 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | ------- Summary: start ------- 05:37:28 INFO - PROCESS | 10390 | Number of tests: 14 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 05:37:28 INFO - PROCESS | 10390 | Values: 111.0 113.0 113.0 113.0 112.0 112.0 111.0 113.0 114.0 111.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:125.50 stddev:19.13 (15.2%) stddev-sans-first:18.54 05:37:28 INFO - PROCESS | 10390 | Values: 155.0 121.0 120.0 176.0 122.0 120.0 126.0 121.0 143.0 125.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.71 (1.1%) stddev-sans-first:1.72 05:37:28 INFO - PROCESS | 10390 | Values: 160.0 163.0 160.0 160.0 163.0 164.0 164.0 161.0 160.0 161.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:11.99 (16.0%) stddev-sans-first:12.45 05:37:28 INFO - PROCESS | 10390 | Values: 74.0 77.0 74.0 105.0 76.0 75.0 75.0 74.0 102.0 77.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:13.66 (16.3%) stddev-sans-first:14.14 05:37:28 INFO - PROCESS | 10390 | Values: 84.0 84.0 106.0 84.0 85.0 84.0 107.0 84.0 85.0 121.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#5] imaging-gaussian-blur Cycles:10 Average:127.60 Median:128.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:37:28 INFO - PROCESS | 10390 | Values: 129.0 127.0 127.0 127.0 128.0 128.0 127.0 127.0 128.0 128.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:37:28 INFO - PROCESS | 10390 | Values: 148.0 149.0 149.0 147.0 148.0 149.0 148.0 148.0 147.0 148.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:37:28 INFO - PROCESS | 10390 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 05:37:28 INFO - PROCESS | 10390 | Values: 52.0 52.0 52.0 53.0 54.0 53.0 53.0 53.0 55.0 54.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:37:28 INFO - PROCESS | 10390 | Values: 65.0 65.0 64.0 65.0 66.0 65.0 64.0 64.0 65.0 64.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 05:37:28 INFO - PROCESS | 10390 | Values: 80.0 80.0 81.0 81.0 80.0 80.0 79.0 80.0 81.0 81.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:133.50 stddev:14.60 (10.9%) stddev-sans-first:15.48 05:37:28 INFO - PROCESS | 10390 | Values: 135.0 129.0 125.0 126.0 139.0 129.0 132.0 127.0 174.0 143.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:173.00 stddev:3.03 (1.8%) stddev-sans-first:3.12 05:37:28 INFO - PROCESS | 10390 | Values: 173.0 175.0 169.0 168.0 173.0 174.0 166.0 169.0 173.0 169.0 05:37:28 INFO - PROCESS | 10390 | 05:37:28 INFO - PROCESS | 10390 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.00 stddev:2.70 (4.2%) stddev-sans-first:2.67 05:37:28 INFO - PROCESS | 10390 | Values: 68.0 69.0 70.0 64.0 64.0 64.0 64.0 63.0 63.0 63.0 05:37:28 INFO - PROCESS | 10390 | -------- Summary: end -------- 05:37:28 INFO - PROCESS | 10390 | 05:37:29 INFO - TEST-INFO | 10390: exit 0 05:37:29 INFO - TEST-OK | kraken | took 61997ms 05:37:29 INFO - SUITE-END | took 1179s 05:37:29 INFO - Completed test suite (00:19:39) 05:37:29 INFO - javascript benchmark 05:37:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.0948715385384, 3055.5569442430833, 3058.373033528126, 3080.3993221321825, 3094.504879219325, 5106.208537676657, 5128.333316668828, 5137.717425541594, 5173.042987047399, 5178.326817513723, 5093.668911520748, 5219.086659834523, 5237.214417837326, 5238.8690282742955, 5241.42344342122, 4608.078384323132, 4654.255319148945, 4701.2478003519445, 4702.05958808238, 4738.502457241992, 4675.438947326325, 4707.505711900252, 4739.549742774431, 4755.429348478187, 4798.5201479852085, 4800.711957282557, 4813.446453657822, 4826.276058591205, 4874.683145595525, 4883.340748998893, 4628.467726211495, 4654.557817007379, 4663.720176789404, 4693.296005599153, 4753.168195565762, 4694.43666759991, 4710.717356958594, 4716.363290955712, 4745.786439610226, 4788.425388953313, 5163.406208286057, 5192.506711862367, 5194.194899790501, 5198.740062996835, 5253.658512196733, 5415.9458405415835, 5569.275994120779, 5599.216109744639, 5605.215269862222, 5618.269624948731, 5491.121420572689, 5569.693666848321, 5576.665400076008, 5578.470045345685, 5581.6930068846195, 5159.484051594811, 5218.843434696965, 5225.843224703265, 5228.2680424740565, 5229.294045303874, 5633.042382794934, 5638.0, 5664.291963504562, 5668.744906479218, 5704.0, 5389.27244821944, 5408.296921400193, 5433.8369848904595, 5450.264214331094, 5464.9180262296095, 5299.205119232146, 5316.0, 5504.504594586427, 5528.281323427928, 5576.832695019156, 5427.592930530226, 5435.7825686972865, 5470.152126420411, 5497.670139791625, 5551.278333816578, 5473.808416705396, 5520.696361700145, 5521.420250873681, 5523.613347065747, 5573.916391254134, 4165.583441655871, 4242.215190189825, 4246.596573325529, 4258.190943720683, 4288.949207444134, 3776.0, 3779.8677046303796, 3797.6202379761803, 3816.561095474056, 3817.8854634361014, 5246.580273578181, 5257.316548848626, 5260.684358938476, 5264.842054738364, 5292.761825717852, 5512.5589952803675, 5523.088690366125, 5525.281713377235, 5526.834194974157, 5571.526420254324, 5090.440051594322, 5124.077666020077, 5144.202648589475, 5161.354830646169, 5192.792288308426, 4773.0, 4775.880602984884, 4777.665563410528, 4810.39870016248, 4821.493743156918, 5612.5229355504425, 5644.153376993484, 5649.293838270216, 5655.886882262332, 5706.457886500776, 5300.416954135119, 5316.521513063843, 5465.781368745205, 5527.53015993645, 5531.308586426697, 5613.691246981455, 5668.801591944262, 5669.376368599368, 5734.168545560787, 5740.827775166752, 5408.215808707794, 5456.42707515721, 5457.099578569491, 5461.044317244387, 5462.562994960473, 5412.702301373462, 5449.945500544944, 5536.695481748542, 5554.694491802989, 5562.415946325739, 5321.920171197513, 5358.249845021622, 5362.0616392132, 5365.061114304903, 5442.346918369821, 5331.466853314638, 5375.650582712111, 5382.73086345689, 5383.0, 5384.838454846361, 5328.973355133199, 5382.3541175059245, 5386.838394848004, 5388.24564560954, 5399.487048730364, 5283.89432211346, 5324.920126198032, 5429.67421954684, 5440.428754980829, 5477.424870388551, 5384.919226211531, 5385.40760516335, 5389.919151212656, 5423.891522169613, 5447.536959358499], "value": 5101.388950969161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3752028967411, 570.3070769015645, 576.3314555116066, 585.1106318396036, 594.23640621801, 31228.68771312286, 40079.0, 41828.58171418285, 41860.37209441857, 45200.0, 42512.787436062856, 42611.78694106533, 42694.78652606733, 42841.0, 42903.35644965328, 8649.0, 8800.207981281683, 8820.779480512974, 8823.161799629024, 8830.47017178968, 7651.081870175559, 7913.406494512906, 10125.746856328577, 10386.63646772363, 10386.948065259701, 10509.527071281773, 10568.682939511827, 10577.84133238002, 10582.259241853073, 10588.576456941713, 10457.320274182153, 10470.581176752921, 10507.684769456928, 10521.158307335394, 10522.210834187466, 10325.43210123443, 10393.48032598367, 10401.375917444977, 10402.843957340647, 10412.895871041268, 39460.802695986626, 39758.40362394566, 39758.60241397607, 39782.20435591301, 39814.407423703015, 3266.869325226988, 3319.767616266862, 3348.765586408928, 3363.2768954674616, 3386.9661303387143, 28788.712112878813, 28790.712092879014, 30542.113261877992, 30620.387592248255, 30732.38535229305, 4137.40007698885, 4138.689598280141, 4198.8320467181275, 4285.764282964436, 4384.101259241847, 335200.1839852806, 336704.0, 340225.0, 340559.2972035149, 342435.0, 50377.49622503728, 50735.0, 50797.0, 50920.0, 50932.0, 53146.73426632842, 53181.2022819658, 53188.010899182715, 53246.46753532415, 53276.0, 13645.931770341085, 13887.166769993833, 13930.0, 13938.442462301597, 13977.86022139786, 10162.085412312927, 10826.025657690689, 10895.128389728803, 10905.182111341523, 10915.563377464812, 14512.492062777752, 16206.675866482605, 16492.917535412485, 16676.33294668224, 16793.328266869434, 6548.312427195171, 6659.368454728622, 6662.533622646368, 6706.524564595781, 6814.625195614289, 854.598338780772, 934.7289286107089, 1015.456730649114, 1042.9739256518496, 1058.4125810175274, 31075.533866992013, 31172.233136869752, 31242.843785780926, 31620.0, 32044.19889502781, 1003.307717674802, 1008.6268080810147, 1031.5564307347763, 1074.6668532754716, 1085.7394225385851, 16072.0, 16545.25546350417, 16606.916965415097, 16634.75047874283, 16658.97439714956, 514597.0, 517718.0, 518814.0, 520647.0, 520781.0, 56750.0, 57508.13737793936, 57529.0, 57590.13614795781, 57664.71167644135, 1203.5787474384072, 1243.5088140184757, 1271.1356277731231, 1301.7136230029378, 1309.7904335306305, 28970.42059158847, 31599.0, 32373.51439728453, 33735.83132084324, 33813.323733525685, 54395.0, 55053.0, 55080.449195509136, 55109.448905510435, 55135.172972406246, 418896.0, 419466.0, 422111.0, 423652.0, 425507.0, 25198.74801251964, 25817.0, 27407.314817129733, 27815.16554503368, 32248.83875580607, 34760.304793904485, 35957.20213989342, 37201.6279837209, 39706.2058758829, 40759.0, 34764.47853282152, 36635.0, 36758.44862327121, 36883.0, 36956.26087478289, 35983.100422489646, 36031.81984090063, 36188.819055904554, 36316.0, 36490.45264320984, 35961.640383596874, 36166.63833361633, 36221.45667814932, 36270.09324766902, 36369.45445818262, 30993.225169370045, 32667.836660816545, 33075.66924330822, 33199.66800331966, 33310.0, 25366.239012829643, 25522.0, 25531.23406297814, 25831.870840645675, 25953.091641792445], "value": 19142.906867559675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5200479352872, 369.70977782440787, 378.9412641040638, 381.427858212681, 397.4832717467292, 13963.790543141848, 17292.221850016766, 17544.912275438604, 18127.0, 19099.618007639838, 17861.7320740189, 17932.64134717308, 18321.0, 18438.44684659459, 18652.720209196872, 5386.919196212069, 5519.172124181365, 5542.473465020817, 5547.472990065938, 5555.972220138894, 4067.715259931791, 4253.51084625269, 5454.91817622736, 5549.667019978814, 5898.469137777599, 6100.877982440348, 6210.4100110489435, 6214.042576588383, 6218.626882387071, 6218.844528886769, 5955.136505206742, 6068.484178844804, 6091.329953705089, 6099.9085013724825, 6207.410296021871, 5416.891662166735, 5419.376771671269, 5420.620556561043, 5420.945790542123, 5422.755975981051, 21801.0, 22010.707911957175, 22169.224077157385, 22212.222572210056, 22347.776522234893, 1981.73246611707, 2380.595298799208, 2398.0647547456506, 2550.744925507453, 2666.3334166458385, 9846.556904939294, 9918.702438926844, 10214.846777298271, 10527.420991845445, 11415.885841141566, 1883.9811601883944, 1913.8181872722068, 1914.2056046740724, 1921.3659492367485, 1928.1708865187964, 64437.0, 76264.0, 78617.60691196565, 79988.20011799865, 82034.17965820325, 10438.164946804238, 10539.789204216026, 10711.410872401937, 10802.459877006118, 10916.890831091747, 14621.19583422922, 14699.26503674812, 14740.631484212981, 14758.188299643409, 14782.556523304318, 7582.203868593719, 7735.187805280365, 7762.534247945141, 7795.922040779633, 7880.566568838769, 7281.5631062136445, 7352.0, 7551.697932082655, 7571.318581327707, 7588.506747061423, 4405.823767049282, 4512.278035514302, 4545.909081818345, 4583.106294272651, 4611.515790841913, 1841.2082804393972, 1889.6315218532254, 1900.0503687893115, 1915.789263181049, 1929.4501067195781, 805.1023109233163, 947.6920000999564, 958.9978472496258, 1016.8474728790741, 1064.797688439194, 18114.63770724578, 18839.152238149316, 18945.0, 18948.43154705361, 19337.903310483358, 932.1889955738551, 940.8071345374182, 941.4586612697726, 955.8040601676639, 989.5398639632606, 10005.299629026043, 10455.686329409978, 10547.208959328082, 10579.100776433936, 10581.947090264499, 315685.0, 327437.0, 428162.0, 428563.0, 433086.0, 64212.0, 68977.65511172412, 91252.0, 92808.0, 93071.53464232635, 948.9383190092622, 971.0823272008026, 1009.7021378693303, 1009.7728011197569, 1013.381837079381, 16429.58926026859, 16656.41702540454, 16915.830841691426, 17301.307947682457, 17374.652506950042, 37933.430998534495, 38216.61783382242, 38469.00913912825, 38730.0, 40372.596274036885, 50934.49065509297, 52707.47292527179, 53027.73486132699, 54971.175432367745, 55183.72408137934, 7992.600369981594, 8121.106678265504, 8156.510609363457, 8179.836403271782, 8361.790955226168, 10637.787244255227, 11936.4031798408, 12464.815842494949, 12525.248485090924, 12539.686507837378, 11113.271415681065, 11204.831927521256, 11274.661760147208, 11471.598494053002, 11563.6530904073, 10906.61826836057, 11009.724756881142, 11068.944655276995, 11164.609238676607, 11230.382328971986, 10995.065419439437, 11083.113350931744, 11193.384363860067, 11384.316940983568, 11404.771904562029, 7845.490043147177, 8059.717909873127, 8186.058603260463, 8236.846841442082, 8270.048944371474, 9632.855507167538, 10531.157507399543, 10818.783624327312, 11111.499982500645, 11290.548378064785], "value": 8799.14173572149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.5710087120815, 1342.0873805812048, 1365.4333451617576, 1454.2510607037377, 1659.1289572974188, 6673.599584024956, 7266.0, 7495.100587929443, 7510.81222969426, 7659.578723170223, 7489.812754681136, 7559.0, 7567.62161891906, 7569.243075692441, 7574.545527268368, 1808.9185986630566, 1876.55900863297, 2053.4455696961772, 2087.551176497053, 2089.1747759634936, 2041.1937284772505, 2111.0711287033655, 2120.639491286485, 2129.127057906259, 2131.2221039320693, 2049.579836133589, 2057.2799520167973, 2059.289545106943, 2060.2274147194803, 2061.7525896892394, 2076.522399848036, 2101.3800928726064, 2104.4844013216784, 2105.1789801977243, 2107.95784084319, 2055.3011975928107, 2055.732754741889, 2061.093119027623, 2065.328768150357, 2072.295419557358, 7250.202477727498, 7402.666879990414, 7405.74079907206, 7410.147832999221, 7410.481266311361, 4597.195490789132, 4708.646851486153, 4717.174494463455, 4718.504557021498, 4718.811247550094, 2957.3050333171686, 3104.161876293388, 3104.5343198520177, 3109.2693217093965, 3109.8445077746023, 934.7709811096325, 962.273483519945, 986.7779749556364, 1013.5287091502487, 1021.8109649714827, 10016.849747253797, 10059.597616095347, 10063.597456101747, 10076.143527800146, 10095.0, 3993.5838817514987, 4165.0, 4241.597048280409, 4244.3209086546, 4335.414719012893, 8589.871151932726, 8590.35572332065, 8607.61265743043, 8614.05245423003, 8643.17889800468, 4650.790714417859, 4665.486796452387, 4725.8582242532775, 4730.101280756645, 4732.124556956974, 3990.541087774885, 4005.459262999516, 4220.493540775126, 4351.3255445405375, 4356.215881141425, 3437.9312413751586, 3507.3511400391008, 3538.3807833629526, 3538.7522873398616, 3566.144125409883, 1127.8026345389524, 1154.8267759836092, 1156.040486396289, 1164.5865717670274, 1166.6733314671906, 804.939629527776, 873.8033942362918, 903.76953876761, 941.5245301123026, 944.390867890207, 5180.145276029489, 5271.920921186185, 5306.416294207634, 5369.40936496985, 5420.24116623673, 400.22756080764407, 402.3582386094175, 410.20625090450073, 946.7159852044359, 963.3545524498603, 3669.9816500917323, 3776.2258736958856, 3791.867284645024, 3807.2385522895534, 3828.885133446001, 8777.561121944005, 8948.328875334377, 8981.820363592822, 8999.730008099768, 9064.456132632064, 8966.68616598416, 8967.910320896837, 8969.775755606162, 8971.730848074569, 8995.685151019683, 6747.932520674731, 7050.964745176241, 7136.928630713626, 7140.5358651687475, 7146.606936618536, 5099.36257967754, 5171.586273098218, 5173.663711858868, 5251.133562962068, 5269.8682532935445, 8372.497650140767, 8470.915290847259, 8501.95749021251, 8558.0, 8572.485650860968, 8221.260086592236, 8273.379496537904, 8282.958585207036, 8579.184977427383, 8583.914160858312, 6292.622442653455, 6452.774152904626, 6457.4511166551365, 6766.594004359754, 6912.688928998106, 6869.553479023847, 6914.0, 7008.649567521706, 7174.1032370953635, 7232.312930271616, 6577.901331480128, 6579.374959378852, 6605.768798092044, 6658.700358483977, 6836.0, 6370.0, 6469.126667899774, 6473.838154045998, 6515.771947981798, 6521.250056243403, 6056.788012419544, 6060.272767267956, 6074.544409169418, 6119.816405507842, 6122.326544080059, 4377.1683380157665, 4443.222436073739, 4475.753833539056, 4491.932621010622, 4586.174488592085, 4518.43519560055, 4564.201264778584, 4623.583877451046, 4676.3686902267755, 4844.249141383091], "value": 4012.145328543452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.9946300805487, 362.76782858970245, 364.218750779578, 374.7451732821682, 374.82383279858465, 5236.659617124884, 5267.52592266696, 5276.947230527693, 5290.947090529094, 5300.330395925285, 4938.407391113072, 5063.493650634944, 5074.492550744923, 5114.616403769723, 5210.8697282567955, 4120.402541631476, 4137.9172416551655, 4138.937915931264, 4141.585841415849, 4153.4392856964305, 4126.587341265879, 4132.710710250284, 4140.157629854716, 4140.896477588054, 4146.232946904832, 3870.574236833946, 3898.966773804944, 4093.529244136918, 4101.569335219804, 4108.67130629549, 4112.157007813391, 4116.662084822445, 4120.855770048064, 4126.3397856343145, 4142.715758114979, 3700.7224458165747, 3703.3148867459336, 3707.8887633370773, 3711.981440092782, 3718.4980027696183, 4840.419149702023, 5024.773885175176, 5033.6224783141415, 5046.44489106198, 5063.594912406998, 4557.630032383142, 4557.886052848672, 4594.333821595883, 4601.631869450436, 4622.95377046232, 5418.864528386783, 5421.403645598981, 5427.782888684448, 5432.456754324576, 5436.456354364572, 3822.178231680174, 3878.437626544135, 3897.8830635080994, 3904.9219015619815, 3922.37242041272, 5518.255035570187, 5586.37994981459, 5590.524805391547, 5596.972015139898, 5612.579056570774, 3941.270864889947, 3950.0914789598555, 3954.2486927483687, 3962.4650672159464, 3971.815501474178, 3941.4876066111224, 4027.0, 4032.737872038308, 4040.2121586290978, 4043.4137050128156, 4530.708748006802, 4543.7728113594185, 4551.6117584137155, 4567.680262381601, 4570.0, 5399.973000135053, 5402.459754024645, 5411.350637923474, 5419.991904493044, 5439.88482361115, 1353.7766268565774, 1364.167857606879, 1364.5292374130909, 1366.8701473360015, 1367.0908845617753, 867.9132086791396, 876.1413814461863, 877.2937785083069, 916.6241840845222, 926.7312479380904, 5063.8480845574695, 5083.567896728746, 5087.440381558025, 5095.745212739348, 5114.616403769732, 5380.946190538045, 5385.434529374359, 5386.622936394493, 5393.7303134843105, 5418.4039755626845, 4921.729304888266, 5079.97460012705, 5091.5672167865405, 5144.71704056273, 5161.948380516222, 2794.6646402431434, 2827.2790438438064, 2830.7735381169455, 2844.928876778097, 2860.3993161435915, 5308.681479111188, 5470.0, 5476.2333273341765, 5492.752826122834, 5505.587080968943, 5333.839984800462, 5380.838574842761, 5401.7299135043095, 5422.593305502103, 5434.8913021739345, 5400.515762749101, 5417.10617748075, 5440.483154100354, 5453.318335208099, 5477.890442191214, 4997.250962163213, 5295.814646487354, 5304.814331498379, 5323.6273460857365, 5347.224652425454, 5238.528532432099, 5311.49540793624, 5318.335208098988, 5337.866553336197, 5359.892802143857, 5422.132458806572, 5428.945710542844, 5471.823557935063, 5473.781048758005, 5506.174073888948, 3761.191343861083, 3877.340852055214, 3898.3957486589625, 3901.941470877996, 3918.4122381642983, 5328.573714102785, 5329.227262047059, 5353.759080841293, 5376.274202982548, 5397.59518036141, 5223.589630799739, 5223.712695801767, 5225.6603320784025, 5261.000819688494, 5299.648589609625, 5181.922271166011, 5209.4009188943755, 5231.241469986754, 5470.835874923759, 5495.203195536545, 5179.715115668674, 5301.5493683037375, 5405.513463806693, 5418.667519475573, 5438.293021907127, 5323.547498462674, 5455.481729235717, 5498.202760599611, 5502.449755024466, 5512.173174023928, 5385.353757549119, 5396.514313711785, 5400.621956463167, 5403.351597808131, 5413.269208656781], "value": 4102.224700070262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.3219573600815, 729.6278897762139, 755.2485277149237, 783.8118851475648, 797.5294576200042, 15403.69192616147, 15741.842581574181, 16610.086445245506, 16644.1677916104, 16658.0, 14093.859061409383, 14206.786898196535, 14226.288685565707, 14236.857631423683, 14243.71512569748, 635.2757856044125, 670.3464122480591, 756.4100001998422, 780.2782426255719, 784.0669603172207, 779.9298063174314, 782.1513657681422, 784.4587234807992, 785.2461636828623, 787.0633945604741, 827.1149869639488, 829.2246749289434, 831.1978940322588, 833.1044127562864, 835.5321020228691, 688.3873352716087, 712.8146681862701, 834.2075028722737, 834.3908946469081, 835.7283882738074, 591.8845825064114, 598.2193237824681, 607.6475644126396, 608.1728848765675, 609.1198218574162, 13496.0, 13590.932045339809, 13620.250886201255, 13626.0, 13641.931790341085, 13497.392617332145, 13556.322183890865, 13580.1851888886, 13619.455221791215, 13720.382582783799, 12529.498820047187, 12566.68583285416, 12575.748485030339, 12881.484740610458, 12962.0, 4259.254630439692, 4296.505901821268, 4346.835016501345, 4373.431453910971, 4492.034212644265, 68457.0, 69912.650436748, 71109.0, 71678.64160679163, 72623.63688181526, 10665.146788257076, 10705.0, 10720.142388608892, 11078.113750899909, 11264.887351126548, 19798.0, 19819.405417837486, 19839.900800496194, 19999.600007999758, 20001.099950502263, 7505.587192704454, 7579.696812127453, 7686.0, 7789.883151752728, 8033.3974951878845, 4049.331860243086, 4103.322951712934, 4213.789310534461, 4250.829966801293, 4290.785460726951, 3056.3581647853757, 3110.8755649774207, 3140.1364624727926, 3142.245860993345, 3159.0996565979044, 544.6976927805106, 550.8457631863084, 551.2117671729385, 565.197419664078, 568.2726110578466, 546.9781208751685, 559.2561892682803, 650.8145178624069, 657.2868437745004, 667.4393509452084, 8238.711381040459, 8681.652733890574, 8765.780855478537, 8784.824303514022, 8972.102789720975, 545.9535939445192, 567.296552275184, 595.5860676829649, 609.3479976425272, 621.487272999777, 4064.4919385076864, 4302.419173411549, 4351.926303145836, 4362.825486980485, 4489.0, 71531.0, 71988.0, 72905.2709472909, 73908.0, 74920.62539687267, 63964.0, 66760.33239667541, 66925.6576019837, 67216.0, 67331.66334168297, 58135.418645813, 58369.70815145897, 59124.0, 59223.40776592179, 59505.999999999134, 8009.5995200238585, 8257.42198046131, 8481.40630155883, 8496.362772791941, 8642.88102688494, 40232.19535609213, 40751.1849763009, 41799.0, 41892.581074190086, 42028.15943681171, 50981.0, 55047.0, 56637.15044274257, 56689.716551416976, 58473.70763146157, 11404.031377221989, 11415.543378264776, 11688.357140357362, 11766.470508827295, 11908.225965312227, 12922.547710830077, 12948.223106613634, 13017.544385946447, 13117.08180427361, 13793.655158621115, 11852.940735296268, 12210.328431936328, 12319.815202772144, 12665.176763510342, 12690.175138615961, 11100.389478578756, 11528.308301501937, 11675.941620292184, 12044.337561434206, 12052.939735301268, 11624.244424112405, 12049.277043377426, 12410.5656302029, 12431.875681243071, 12540.561080362144, 10027.799444011225, 10106.494675266355, 10318.329308594917, 10551.30704253505, 10782.353058816496, 9258.768530786785, 9520.952395237979, 9691.321607487409, 10274.948625256826, 10615.840762388725], "value": 6748.1285667783895, "unit": "score"}], "name": "dromaeo_css", "value": 6760.223335057772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 112.0, 112.0, 111.0, 113.0, 114.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 120.0, 176.0, 122.0, 120.0, 126.0, 121.0, 143.0, 125.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 160.0, 163.0, 164.0, 164.0, 161.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 105.0, 76.0, 75.0, 75.0, 74.0, 102.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 84.0, 85.0, 84.0, 107.0, 84.0, 85.0, 121.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 127.0, 127.0, 128.0, 128.0, 127.0, 127.0, 128.0, 128.0], "value": 127.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 55.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 81.0, 80.0, 80.0, 79.0, 80.0, 81.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 125.0, 126.0, 139.0, 129.0, 132.0, 127.0, 174.0, 143.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 169.0, 168.0, 173.0, 174.0, 166.0, 169.0, 173.0, 169.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1521.5000000000002, "alertThreshold": 2.0}]} 05:37:29 INFO - Return code: 0 05:37:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:29 INFO - # TBPL SUCCESS # 05:37:29 INFO - Running post-action listener: _resource_record_post_action 05:37:29 INFO - [mozharness: 2016-12-18 13:37:29.601545Z] Finished run-tests step (success) 05:37:29 INFO - Running post-run listener: _resource_record_post_run 05:37:29 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404721664; Read time: 20; Write time: 306812 05:37:29 INFO - TinderboxPrint: CPU usage
13.2% 05:37:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:37:29 INFO - TinderboxPrint: I/O write bytes / time
404,721,664 / 306,812 05:37:29 INFO - TinderboxPrint: CPU idle
8,296.6 (86.8%) 05:37:29 INFO - TinderboxPrint: CPU user
1,210.9 (12.7%) 05:37:29 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114503680; Read time: 0; Write time: 91896 05:37:29 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289325056; Read time: 0; Write time: 214896 05:37:30 INFO - Running post-run listener: _upload_blobber_files 05:37:30 INFO - Blob upload gear active. 05:37:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:30 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:30 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:31 INFO - (blobuploader) - INFO - Done attempting. 05:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:34 INFO - (blobuploader) - INFO - Done attempting. 05:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:35 INFO - (blobuploader) - INFO - Done attempting. 05:37:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:36 INFO - (blobuploader) - INFO - Done attempting. 05:37:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:36 INFO - Return code: 0 05:37:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60178601f878d576b19cc656cc65622a16974f0b3a773b1825576ebf71018877e88cbfdcf0fe44ea4d3d63f491061942eabd6feb519e96f1734b5236f6940212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0c5090ce74c4589dc9cf523640fef217aa38529256a306455fd9223bd730f9064c3f410fdd3d742d021e88a58721cb52951940c0d96bd67aa84c9dff8da9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae795bc7da8807a0491d81927adcf5758067472ae2bc381c704b55e13edbb027c4eba11042d03e6ba1f6f99e997fd9bba30cb3a5efc72ee0021ad6350b8d5d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b148fc9262c2c1f060ef51ed7170f8b91088aa71176108ffd16a1400cb89e945385e985e79e8858f953cab5fff29bb2b6cddecc2f4175d93813046751f9e7c2c"} 05:37:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:36 INFO - Contents: 05:37:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60178601f878d576b19cc656cc65622a16974f0b3a773b1825576ebf71018877e88cbfdcf0fe44ea4d3d63f491061942eabd6feb519e96f1734b5236f6940212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0c5090ce74c4589dc9cf523640fef217aa38529256a306455fd9223bd730f9064c3f410fdd3d742d021e88a58721cb52951940c0d96bd67aa84c9dff8da9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae795bc7da8807a0491d81927adcf5758067472ae2bc381c704b55e13edbb027c4eba11042d03e6ba1f6f99e997fd9bba30cb3a5efc72ee0021ad6350b8d5d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b148fc9262c2c1f060ef51ed7170f8b91088aa71176108ffd16a1400cb89e945385e985e79e8858f953cab5fff29bb2b6cddecc2f4175d93813046751f9e7c2c"} 05:37:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:36 INFO - Copying logs to upload dir... 05:37:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.644275 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-18 05:37:35.758210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 05:37:35.761499) ========= 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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 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/sha512/60178601f878d576b19cc656cc65622a16974f0b3a773b1825576ebf71018877e88cbfdcf0fe44ea4d3d63f491061942eabd6feb519e96f1734b5236f6940212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0c5090ce74c4589dc9cf523640fef217aa38529256a306455fd9223bd730f9064c3f410fdd3d742d021e88a58721cb52951940c0d96bd67aa84c9dff8da9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae795bc7da8807a0491d81927adcf5758067472ae2bc381c704b55e13edbb027c4eba11042d03e6ba1f6f99e997fd9bba30cb3a5efc72ee0021ad6350b8d5d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b148fc9262c2c1f060ef51ed7170f8b91088aa71176108ffd16a1400cb89e945385e985e79e8858f953cab5fff29bb2b6cddecc2f4175d93813046751f9e7c2c"} build_url:https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/VERjAQZiRLW651LTKS2HQg/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/sha512/60178601f878d576b19cc656cc65622a16974f0b3a773b1825576ebf71018877e88cbfdcf0fe44ea4d3d63f491061942eabd6feb519e96f1734b5236f6940212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0c5090ce74c4589dc9cf523640fef217aa38529256a306455fd9223bd730f9064c3f410fdd3d742d021e88a58721cb52951940c0d96bd67aa84c9dff8da9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae795bc7da8807a0491d81927adcf5758067472ae2bc381c704b55e13edbb027c4eba11042d03e6ba1f6f99e997fd9bba30cb3a5efc72ee0021ad6350b8d5d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b148fc9262c2c1f060ef51ed7170f8b91088aa71176108ffd16a1400cb89e945385e985e79e8858f953cab5fff29bb2b6cddecc2f4175d93813046751f9e7c2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 05:37:35.786965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:37:35.787334) ========= 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=eca2ab57546de7b41f256b19000001ef-1482046153.710187-1921387571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 05:37:35.869882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 05:37:35.870206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 05:37:35.870505) ========= ========= Total master_lag: 0.16 =========