builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1474456952.53 results: success (0) buildid: 20160921030508 builduid: 3f56d416c7c148db82a7a42f2e9f73f6 revision: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.526448) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.527526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.528219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.543681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.544252) ========= 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-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 04:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.5M=0s 2016-09-21 04:22:33 (95.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.672428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.673096) ========= 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-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.726719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:32.727583) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 --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 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 --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-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 04:22:33,253 truncating revision to first 12 chars 2016-09-21 04:22:33,253 Setting DEBUG logging. 2016-09-21 04:22:33,253 attempt 1/10 2016-09-21 04:22:33,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/560b2c805bf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 04:22:33,540 unpacking tar archive at: mozilla-central-560b2c805bf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:33.349951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:33.350724) ========= script_repo_revision: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:33.351710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:33.352399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 04:22:33.364848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-21 04:22:33.365179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:33 INFO - MultiFileLogger online at 20160921 04:22:33 in /builds/slave/test 04:22:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:22:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:33 INFO - {'append_to_log': False, 04:22:33 INFO - 'base_work_dir': '/builds/slave/test', 04:22:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:33 INFO - 'branch': 'Firefox-Non-PGO', 04:22:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:33 INFO - 'config_files': ('talos/linux_config.py',), 04:22:33 INFO - 'default_actions': ('clobber', 04:22:33 INFO - 'read-buildbot-config', 04:22:33 INFO - 'download-and-extract', 04:22:33 INFO - 'populate-webroot', 04:22:33 INFO - 'create-virtualenv', 04:22:33 INFO - 'install', 04:22:33 INFO - 'run-tests'), 04:22:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:33 INFO - 'download_minidump_stackwalk': True, 04:22:33 INFO - 'download_symbols': 'ondemand', 04:22:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:33 INFO - 'installer_path': 'installer.exe', 04:22:33 INFO - 'log_level': 'info', 04:22:33 INFO - 'log_name': 'talos', 04:22:33 INFO - 'log_to_console': True, 04:22:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:33 INFO - 'opt_config_files': (), 04:22:33 INFO - 'pip_index': False, 04:22:33 INFO - 'sps_profile': False, 04:22:33 INFO - 'sps_profile_interval': 0, 04:22:33 INFO - 'suite': 'dromaeojs', 04:22:33 INFO - 'system_bits': '32', 04:22:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:33 INFO - 'title': 'talos-linux64-ix-010', 04:22:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:33 INFO - 'use_talos_json': True, 04:22:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:33 INFO - 'work_dir': 'build'} 04:22:33 INFO - [mozharness: 2016-09-21 11:22:33.980196Z] Running clobber step. 04:22:33 INFO - Running pre-action listener: _resource_record_pre_action 04:22:33 INFO - Running main action method: clobber 04:22:33 INFO - rmtree: /builds/slave/test/build 04:22:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:34 INFO - Running post-action listener: _resource_record_post_action 04:22:34 INFO - [mozharness: 2016-09-21 11:22:34.957405Z] Finished clobber step (success) 04:22:34 INFO - [mozharness: 2016-09-21 11:22:34.957507Z] Running read-buildbot-config step. 04:22:34 INFO - Running pre-action listener: _resource_record_pre_action 04:22:34 INFO - Running main action method: read_buildbot_config 04:22:34 INFO - Using buildbot properties: 04:22:34 INFO - { 04:22:34 INFO - "project": "", 04:22:34 INFO - "product": "firefox", 04:22:34 INFO - "script_repo_revision": "production", 04:22:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:22:34 INFO - "repository": "", 04:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:22:34 INFO - "buildid": "20160921030508", 04:22:34 INFO - "pgo_build": "False", 04:22:34 INFO - "basedir": "/builds/slave/test", 04:22:34 INFO - "buildnumber": 215, 04:22:34 INFO - "slavename": "talos-linux64-ix-010", 04:22:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:22:34 INFO - "platform": "ubuntu64_hw", 04:22:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:22:34 INFO - "branch": "mozilla-central", 04:22:34 INFO - "repo_path": "mozilla-central", 04:22:34 INFO - "revision": "560b2c805bf7bebeb3ceebc495a81b2aa4c0c755", 04:22:34 INFO - "stage_platform": "linux64", 04:22:34 INFO - "builduid": "3f56d416c7c148db82a7a42f2e9f73f6", 04:22:34 INFO - "slavebuilddir": "test" 04:22:34 INFO - } 04:22:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:22:34 INFO - Running post-action listener: _resource_record_post_action 04:22:34 INFO - [mozharness: 2016-09-21 11:22:34.959977Z] Finished read-buildbot-config step (success) 04:22:34 INFO - [mozharness: 2016-09-21 11:22:34.960067Z] Running download-and-extract step. 04:22:34 INFO - Running pre-action listener: _resource_record_pre_action 04:22:34 INFO - Running main action method: download_and_extract 04:22:34 INFO - mkdir: /builds/slave/test/build/tests 04:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:34 INFO - trying https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:22:35 INFO - Downloaded 1361 bytes. 04:22:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:35 INFO - Using the following test package requirements: 04:22:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'jsshell-linux-x86_64.zip'], 04:22:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:22:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:35 INFO - Fetch https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:22:36 INFO - Expected file size: 20370435 04:22:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:22:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:22:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:40 INFO - Fetch https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:22:40 INFO - Expected file size: 20370435 04:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:22:46 INFO - Expected file size: 14414059 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:47 INFO - trying https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:22:48 INFO - Downloaded 55596714 bytes. 04:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:48 INFO - mkdir: /builds/slave/test/properties 04:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:48 INFO - Contents: 04:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:49 INFO - Running post-action listener: _resource_record_post_action 04:22:49 INFO - Running post-action listener: set_extra_try_arguments 04:22:49 INFO - [mozharness: 2016-09-21 11:22:49.637229Z] Finished download-and-extract step (success) 04:22:49 INFO - [mozharness: 2016-09-21 11:22:49.637460Z] Running populate-webroot step. 04:22:49 INFO - Running pre-action listener: _resource_record_pre_action 04:22:49 INFO - Running main action method: populate_webroot 04:22:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:49 INFO - '--tppagecycles', 04:22:49 INFO - '7'], 04:22:49 INFO - 'tests': ['tsvgm']}}, 04:22:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['damp', 'tps']}, 04:22:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'tests': ['damp', 'tps']}, 04:22:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['dromaeo_dom']}, 04:22:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['basic_compositor_video']}, 04:22:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:22:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['a11yr', 04:22:49 INFO - 'ts_paint', 04:22:49 INFO - 'tpaint', 04:22:49 INFO - 'sessionrestore', 04:22:49 INFO - 'sessionrestore_no_auto_restore', 04:22:49 INFO - 'tabpaint']}, 04:22:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['tsvgx', 04:22:49 INFO - 'tsvgr_opacity', 04:22:49 INFO - 'tart', 04:22:49 INFO - 'tscrollx', 04:22:49 INFO - 'cart']}, 04:22:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:49 INFO - 'tsvgr_opacity', 04:22:49 INFO - 'tart', 04:22:49 INFO - 'tscrollx', 04:22:49 INFO - 'cart']}, 04:22:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'talos_options': ['--disable-e10s'], 04:22:49 INFO - 'tests': ['tp5o']}, 04:22:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'tests': ['tp5o']}, 04:22:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'talos_options': ['--disable-e10s', 04:22:49 INFO - '--xperf_path', 04:22:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:49 INFO - 'tests': ['tp5n']}, 04:22:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:49 INFO - 'talos_options': ['--xperf_path', 04:22:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:49 INFO - 'tests': ['tp5n']}}, 04:22:49 INFO - 'talos.zip': {'path': '', 04:22:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:49 INFO - Running post-action listener: _resource_record_post_action 04:22:49 INFO - [mozharness: 2016-09-21 11:22:49.659332Z] Finished populate-webroot step (success) 04:22:49 INFO - [mozharness: 2016-09-21 11:22:49.659421Z] Running create-virtualenv step. 04:22:49 INFO - Running pre-action listener: _resource_record_pre_action 04:22:49 INFO - Running main action method: create_virtualenv 04:22:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:49 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 04:22:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:49 INFO - Using real prefix '/usr' 04:22:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:52 INFO - Installing pip.................done. 04:22:52 INFO - Return code: 0 04:22:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:22:52 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 04:22:52 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 04:22:52 INFO - Using env: {'DISPLAY': ':0', 04:22:52 INFO - 'HOME': '/home/cltbld', 04:22:52 INFO - 'LANG': 'en_US.UTF-8', 04:22:52 INFO - 'LANGUAGE': 'en_US:en', 04:22:52 INFO - 'LOGNAME': 'cltbld', 04:22:52 INFO - 'MAIL': '/var/mail/cltbld', 04:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:52 INFO - 'MOZ_NO_REMOTE': '1', 04:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:52 INFO - 'NO_EM_RESTART': '1', 04:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:52 INFO - 'PWD': '/builds/slave/test', 04:22:52 INFO - 'SHELL': '/bin/bash', 04:22:52 INFO - 'SHLVL': '1', 04:22:52 INFO - 'TERM': 'linux', 04:22:52 INFO - 'TMOUT': '86400', 04:22:52 INFO - 'USER': 'cltbld', 04:22:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:52 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:52 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 04:22:52 INFO - Cleaning up... 04:22:52 INFO - Return code: 0 04:22:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:22:52 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 04:22:52 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 04:22:52 INFO - Using env: {'DISPLAY': ':0', 04:22:52 INFO - 'HOME': '/home/cltbld', 04:22:52 INFO - 'LANG': 'en_US.UTF-8', 04:22:52 INFO - 'LANGUAGE': 'en_US:en', 04:22:52 INFO - 'LOGNAME': 'cltbld', 04:22:52 INFO - 'MAIL': '/var/mail/cltbld', 04:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:52 INFO - 'MOZ_NO_REMOTE': '1', 04:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:52 INFO - 'NO_EM_RESTART': '1', 04:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:52 INFO - 'PWD': '/builds/slave/test', 04:22:52 INFO - 'SHELL': '/bin/bash', 04:22:52 INFO - 'SHLVL': '1', 04:22:52 INFO - 'TERM': 'linux', 04:22:52 INFO - 'TMOUT': '86400', 04:22:52 INFO - 'USER': 'cltbld', 04:22:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:52 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:52 INFO - Downloading/unpacking psutil>=3.1.1 04:22:52 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 04:22:52 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 04:22:52 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 04:22:52 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 04:22:52 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 04:22:52 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 04:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:54 INFO - Installing collected packages: psutil 04:22:54 INFO - Running setup.py install for psutil 04:22:54 INFO - building 'psutil._psutil_linux' extension 04:22:54 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 04:22:54 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 04:22:54 INFO - building 'psutil._psutil_posix' extension 04:22:54 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 04:22:55 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 04:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:55 INFO - Successfully installed psutil 04:22:55 INFO - Cleaning up... 04:22:55 INFO - Return code: 0 04:22:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22:55 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')]} 04:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:55 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')]} 04:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:55 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:22:55 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 04:22:55 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 04:22:55 INFO - Using env: {'DISPLAY': ':0', 04:22:55 INFO - 'HOME': '/home/cltbld', 04:22:55 INFO - 'LANG': 'en_US.UTF-8', 04:22:55 INFO - 'LANGUAGE': 'en_US:en', 04:22:55 INFO - 'LOGNAME': 'cltbld', 04:22:55 INFO - 'MAIL': '/var/mail/cltbld', 04:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:55 INFO - 'MOZ_NO_REMOTE': '1', 04:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:55 INFO - 'NO_EM_RESTART': '1', 04:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:55 INFO - 'PWD': '/builds/slave/test', 04:22:55 INFO - 'SHELL': '/bin/bash', 04:22:55 INFO - 'SHLVL': '1', 04:22:55 INFO - 'TERM': 'linux', 04:22:55 INFO - 'TMOUT': '86400', 04:22:55 INFO - 'USER': 'cltbld', 04:22:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:55 INFO - '_': '/tools/buildbot/bin/python'} 04:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22:55 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 04:22:55 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 04:22:55 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 04:22:55 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 04:22:55 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 04:22:55 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 04:22:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:57 INFO - Installing collected packages: mozsystemmonitor 04:22:57 INFO - Running setup.py install for mozsystemmonitor 04:22:57 INFO - Successfully installed mozsystemmonitor 04:22:57 INFO - Cleaning up... 04:22:57 INFO - Return code: 0 04:22:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22:57 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')]} 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 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')]} 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:22:57 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 04:22:57 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 04:22:57 INFO - Using env: {'DISPLAY': ':0', 04:22:57 INFO - 'HOME': '/home/cltbld', 04:22:57 INFO - 'LANG': 'en_US.UTF-8', 04:22:57 INFO - 'LANGUAGE': 'en_US:en', 04:22:57 INFO - 'LOGNAME': 'cltbld', 04:22:57 INFO - 'MAIL': '/var/mail/cltbld', 04:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:57 INFO - 'MOZ_NO_REMOTE': '1', 04:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:57 INFO - 'NO_EM_RESTART': '1', 04:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:57 INFO - 'PWD': '/builds/slave/test', 04:22:57 INFO - 'SHELL': '/bin/bash', 04:22:57 INFO - 'SHLVL': '1', 04:22:57 INFO - 'TERM': 'linux', 04:22:57 INFO - 'TMOUT': '86400', 04:22:57 INFO - 'USER': 'cltbld', 04:22:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:57 INFO - '_': '/tools/buildbot/bin/python'} 04:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:22:57 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 04:22:57 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 04:22:57 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 04:22:57 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 04:22:57 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 04:22:57 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 04:22:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22:59 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 04:22:59 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 04:22:59 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 04:22:59 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 04:22:59 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 04:22:59 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 04:22:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:59 INFO - warning: no files found matching '*.txt' 04:22:59 INFO - no previously-included directories found matching 'build' 04:22:59 INFO - no previously-included directories found matching 'dist' 04:22:59 INFO - no previously-included directories found matching '.git*' 04:22:59 INFO - Installing collected packages: jsonschema, functools32 04:22:59 INFO - Running setup.py install for functools32 04:23:00 INFO - warning: no files found matching '*.txt' 04:23:00 INFO - no previously-included directories found matching 'build' 04:23:00 INFO - no previously-included directories found matching 'dist' 04:23:00 INFO - no previously-included directories found matching '.git*' 04:23:00 INFO - Successfully installed jsonschema functools32 04:23:00 INFO - Cleaning up... 04:23:00 INFO - Return code: 0 04:23:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:23:00 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')]} 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:00 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')]} 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:00 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:00 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 04:23:00 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 04:23:00 INFO - Using env: {'DISPLAY': ':0', 04:23:00 INFO - 'HOME': '/home/cltbld', 04:23:00 INFO - 'LANG': 'en_US.UTF-8', 04:23:00 INFO - 'LANGUAGE': 'en_US:en', 04:23:00 INFO - 'LOGNAME': 'cltbld', 04:23:00 INFO - 'MAIL': '/var/mail/cltbld', 04:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:00 INFO - 'MOZ_NO_REMOTE': '1', 04:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:00 INFO - 'NO_EM_RESTART': '1', 04:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:00 INFO - 'PWD': '/builds/slave/test', 04:23:00 INFO - 'SHELL': '/bin/bash', 04:23:00 INFO - 'SHLVL': '1', 04:23:00 INFO - 'TERM': 'linux', 04:23:00 INFO - 'TMOUT': '86400', 04:23:00 INFO - 'USER': 'cltbld', 04:23:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:00 INFO - '_': '/tools/buildbot/bin/python'} 04:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:23:00 INFO - Cleaning up... 04:23:00 INFO - Return code: 0 04:23:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:00 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')]} 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:00 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')]} 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:00 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:00 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 04:23:00 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 04:23:00 INFO - Using env: {'DISPLAY': ':0', 04:23:00 INFO - 'HOME': '/home/cltbld', 04:23:00 INFO - 'LANG': 'en_US.UTF-8', 04:23:00 INFO - 'LANGUAGE': 'en_US:en', 04:23:00 INFO - 'LOGNAME': 'cltbld', 04:23:00 INFO - 'MAIL': '/var/mail/cltbld', 04:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:00 INFO - 'MOZ_NO_REMOTE': '1', 04:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:00 INFO - 'NO_EM_RESTART': '1', 04:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:00 INFO - 'PWD': '/builds/slave/test', 04:23:00 INFO - 'SHELL': '/bin/bash', 04:23:00 INFO - 'SHLVL': '1', 04:23:00 INFO - 'TERM': 'linux', 04:23:00 INFO - 'TMOUT': '86400', 04:23:00 INFO - 'USER': 'cltbld', 04:23:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:00 INFO - '_': '/tools/buildbot/bin/python'} 04:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 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 04:23:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:02 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 04:23:03 INFO - Downloading docopt-0.6.1.tar.gz 04:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:03 INFO - Running setup.py install for blobuploader 04:23:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:03 INFO - Running setup.py install for requests 04:23:03 INFO - Running setup.py install for docopt 04:23:03 INFO - Successfully installed blobuploader requests docopt 04:23:03 INFO - Cleaning up... 04:23:03 INFO - Return code: 0 04:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:03 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')]} 04:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:03 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')]} 04:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:03 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:03 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 04:23:03 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 04:23:03 INFO - Using env: {'DISPLAY': ':0', 04:23:03 INFO - 'HOME': '/home/cltbld', 04:23:03 INFO - 'LANG': 'en_US.UTF-8', 04:23:03 INFO - 'LANGUAGE': 'en_US:en', 04:23:03 INFO - 'LOGNAME': 'cltbld', 04:23:03 INFO - 'MAIL': '/var/mail/cltbld', 04:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:03 INFO - 'MOZ_NO_REMOTE': '1', 04:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:03 INFO - 'NO_EM_RESTART': '1', 04:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:03 INFO - 'PWD': '/builds/slave/test', 04:23:03 INFO - 'SHELL': '/bin/bash', 04:23:03 INFO - 'SHLVL': '1', 04:23:03 INFO - 'TERM': 'linux', 04:23:03 INFO - 'TMOUT': '86400', 04:23:03 INFO - 'USER': 'cltbld', 04:23:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:03 INFO - '_': '/tools/buildbot/bin/python'} 04:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 INFO - Running setup.py (path:/tmp/pip-n7kMMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 INFO - Running setup.py (path:/tmp/pip-UtCw9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:04 INFO - Running setup.py (path:/tmp/pip-nD9TnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:04 INFO - Running setup.py (path:/tmp/pip-noNSIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:04 INFO - Running setup.py (path:/tmp/pip-p0lotg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:04 INFO - Running setup.py (path:/tmp/pip-yJzFn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:04 INFO - Running setup.py (path:/tmp/pip-nMkGES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:04 INFO - Running setup.py (path:/tmp/pip-Y0ZHim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:04 INFO - Running setup.py (path:/tmp/pip-yYr5QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:04 INFO - Running setup.py (path:/tmp/pip-Vjx2iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:04 INFO - Running setup.py (path:/tmp/pip-IQ2hYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:04 INFO - Running setup.py (path:/tmp/pip-blS9KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:04 INFO - Running setup.py (path:/tmp/pip-x5grCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:04 INFO - Running setup.py (path:/tmp/pip-aBgsUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 INFO - Running setup.py (path:/tmp/pip-Ms9Sag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:05 INFO - Running setup.py (path:/tmp/pip-anHES7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:05 INFO - Running setup.py (path:/tmp/pip-VLfdan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:05 INFO - Running setup.py install for manifestparser 04:23:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:05 INFO - Running setup.py install for mozcrash 04:23:05 INFO - Running setup.py install for mozdebug 04:23:05 INFO - Running setup.py install for mozdevice 04:23:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:05 INFO - Running setup.py install for mozfile 04:23:05 INFO - Running setup.py install for mozhttpd 04:23:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:05 INFO - Running setup.py install for mozinfo 04:23:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:05 INFO - Running setup.py install for mozInstall 04:23:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Running setup.py install for mozleak 04:23:06 INFO - Running setup.py install for mozlog 04:23:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Running setup.py install for moznetwork 04:23:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Running setup.py install for mozprocess 04:23:06 INFO - Running setup.py install for mozprofile 04:23:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Running setup.py install for mozrunner 04:23:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Running setup.py install for mozscreenshot 04:23:06 INFO - Running setup.py install for moztest 04:23:06 INFO - Running setup.py install for mozversion 04:23:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:07 INFO - Cleaning up... 04:23:07 INFO - Return code: 0 04:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:07 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:07 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 04:23:07 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 04:23:07 INFO - Using env: {'DISPLAY': ':0', 04:23:07 INFO - 'HOME': '/home/cltbld', 04:23:07 INFO - 'LANG': 'en_US.UTF-8', 04:23:07 INFO - 'LANGUAGE': 'en_US:en', 04:23:07 INFO - 'LOGNAME': 'cltbld', 04:23:07 INFO - 'MAIL': '/var/mail/cltbld', 04:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:07 INFO - 'MOZ_NO_REMOTE': '1', 04:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:07 INFO - 'NO_EM_RESTART': '1', 04:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:07 INFO - 'PWD': '/builds/slave/test', 04:23:07 INFO - 'SHELL': '/bin/bash', 04:23:07 INFO - 'SHLVL': '1', 04:23:07 INFO - 'TERM': 'linux', 04:23:07 INFO - 'TMOUT': '86400', 04:23:07 INFO - 'USER': 'cltbld', 04:23:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:07 INFO - '_': '/tools/buildbot/bin/python'} 04:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:07 INFO - Running setup.py (path:/tmp/pip-T5Xxde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:07 INFO - Running setup.py (path:/tmp/pip-sQKbSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:07 INFO - Running setup.py (path:/tmp/pip-5dWjER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:07 INFO - Running setup.py (path:/tmp/pip-JMEnjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:07 INFO - Running setup.py (path:/tmp/pip-b7eOft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:07 INFO - Running setup.py (path:/tmp/pip-lBxOXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:07 INFO - Running setup.py (path:/tmp/pip-KZYIFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:07 INFO - Running setup.py (path:/tmp/pip-Thp7bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:07 INFO - Running setup.py (path:/tmp/pip-Bu8aDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:07 INFO - Running setup.py (path:/tmp/pip-eInAVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:07 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)) 04:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:07 INFO - Running setup.py (path:/tmp/pip-VqoT4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:08 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)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:08 INFO - Running setup.py (path:/tmp/pip-TLBoZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:08 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)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:08 INFO - Running setup.py (path:/tmp/pip-ZwATUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:08 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)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:08 INFO - Running setup.py (path:/tmp/pip-TPwpMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:08 INFO - Running setup.py (path:/tmp/pip-smGodc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:08 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)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:08 INFO - Running setup.py (path:/tmp/pip-iuE28n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:08 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)) 04:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:08 INFO - Running setup.py (path:/tmp/pip-DZO8BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:08 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)) 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:08 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)) 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:10 INFO - Downloading blessings-1.6.tar.gz 04:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:10 INFO - Installing collected packages: blessings 04:23:10 INFO - Running setup.py install for blessings 04:23:10 INFO - Successfully installed blessings 04:23:10 INFO - Cleaning up... 04:23:10 INFO - Return code: 0 04:23:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:10 INFO - Reading from file tmpfile_stdout 04:23:10 INFO - Current package versions: 04:23:10 INFO - argparse == 1.2.1 04:23:10 INFO - blessings == 1.6 04:23:10 INFO - blobuploader == 1.2.4 04:23:10 INFO - docopt == 0.6.1 04:23:10 INFO - functools32 == 3.2.3-2 04:23:10 INFO - jsonschema == 2.5.1 04:23:10 INFO - manifestparser == 1.1 04:23:10 INFO - mozInstall == 1.12 04:23:10 INFO - mozcrash == 0.17 04:23:10 INFO - mozdebug == 0.1 04:23:10 INFO - mozdevice == 0.48 04:23:10 INFO - mozfile == 1.2 04:23:10 INFO - mozhttpd == 0.7 04:23:10 INFO - mozinfo == 0.9 04:23:10 INFO - mozleak == 0.1 04:23:10 INFO - mozlog == 3.4 04:23:10 INFO - moznetwork == 0.27 04:23:10 INFO - mozprocess == 0.23 04:23:10 INFO - mozprofile == 0.28 04:23:10 INFO - mozrunner == 6.12 04:23:10 INFO - mozscreenshot == 0.1 04:23:10 INFO - mozsystemmonitor == 0.3 04:23:10 INFO - moztest == 0.7 04:23:10 INFO - mozversion == 1.4 04:23:10 INFO - psutil == 3.1.1 04:23:10 INFO - requests == 1.2.3 04:23:10 INFO - wsgiref == 0.1.2 04:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:10 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')]} 04:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:10 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')]} 04:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:10 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:10 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 04:23:10 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 04:23:10 INFO - Using env: {'DISPLAY': ':0', 04:23:10 INFO - 'HOME': '/home/cltbld', 04:23:10 INFO - 'LANG': 'en_US.UTF-8', 04:23:10 INFO - 'LANGUAGE': 'en_US:en', 04:23:10 INFO - 'LOGNAME': 'cltbld', 04:23:10 INFO - 'MAIL': '/var/mail/cltbld', 04:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:10 INFO - 'MOZ_NO_REMOTE': '1', 04:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:10 INFO - 'NO_EM_RESTART': '1', 04:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:10 INFO - 'PWD': '/builds/slave/test', 04:23:10 INFO - 'SHELL': '/bin/bash', 04:23:10 INFO - 'SHLVL': '1', 04:23:10 INFO - 'TERM': 'linux', 04:23:10 INFO - 'TMOUT': '86400', 04:23:10 INFO - 'USER': 'cltbld', 04:23:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:10 INFO - '_': '/tools/buildbot/bin/python'} 04:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 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)) 04:23:11 INFO - Cleaning up... 04:23:11 INFO - Return code: 0 04:23:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:11 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')]} 04:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:11 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')]} 04:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:11 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 0x7f4e50740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2141ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, '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-1474456952.151743-302707296', '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 04:23:11 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 04:23:11 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 04:23:11 INFO - Using env: {'DISPLAY': ':0', 04:23:11 INFO - 'HOME': '/home/cltbld', 04:23:11 INFO - 'LANG': 'en_US.UTF-8', 04:23:11 INFO - 'LANGUAGE': 'en_US:en', 04:23:11 INFO - 'LOGNAME': 'cltbld', 04:23:11 INFO - 'MAIL': '/var/mail/cltbld', 04:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:11 INFO - 'MOZ_NO_REMOTE': '1', 04:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:11 INFO - 'NO_EM_RESTART': '1', 04:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:11 INFO - 'PWD': '/builds/slave/test', 04:23:11 INFO - 'SHELL': '/bin/bash', 04:23:11 INFO - 'SHLVL': '1', 04:23:11 INFO - 'TERM': 'linux', 04:23:11 INFO - 'TMOUT': '86400', 04:23:11 INFO - 'USER': 'cltbld', 04:23:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:11 INFO - '_': '/tools/buildbot/bin/python'} 04:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:11 INFO - Cleaning up... 04:23:11 INFO - Return code: 0 04:23:11 INFO - Running post-action listener: _resource_record_post_action 04:23:11 INFO - Running post-action listener: _start_resource_monitoring 04:23:11 INFO - Starting resource monitoring. 04:23:11 INFO - [mozharness: 2016-09-21 11:23:11.349000Z] Finished create-virtualenv step (success) 04:23:11 INFO - [mozharness: 2016-09-21 11:23:11.349504Z] Running install step. 04:23:11 INFO - Running pre-action listener: _resource_record_pre_action 04:23:11 INFO - Running main action method: install 04:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:11 INFO - Reading from file tmpfile_stdout 04:23:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:11 INFO - Reading from file tmpfile_stdout 04:23:11 INFO - Output received: 04:23:11 INFO - Usage: mozinstall [options] installer 04:23:11 INFO - Options: 04:23:11 INFO - -h, --help show this help message and exit 04:23:11 INFO - -d DEST, --destination=DEST 04:23:11 INFO - Directory to install application into. [default: 04:23:11 INFO - "/builds/slave/test"] 04:23:11 INFO - --app=APP Application being installed. [default: firefox] 04:23:11 INFO - mkdir: /builds/slave/test/build/application 04:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:27 INFO - Reading from file tmpfile_stdout 04:23:27 INFO - Output received: 04:23:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:27 INFO - Running post-action listener: _resource_record_post_action 04:23:27 INFO - [mozharness: 2016-09-21 11:23:27.832097Z] Finished install step (success) 04:23:27 INFO - [mozharness: 2016-09-21 11:23:27.832343Z] Running run-tests step. 04:23:27 INFO - Running pre-action listener: _resource_record_pre_action 04:23:27 INFO - Running main action method: run_tests 04:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:27 INFO - Python 2.7.3 04:23:27 INFO - Return code: 0 04:23:27 INFO - grabbing minidump binary from tooltool 04:23: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')]} 04:23:27 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 0x213ef60>, '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 0x213fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21401d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:27 INFO - Return code: 0 04:23:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.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 04:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.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 04:23:27 INFO - Using env: {'DISPLAY': ':0', 04:23:27 INFO - 'HOME': '/home/cltbld', 04:23:27 INFO - 'LANG': 'en_US.UTF-8', 04:23:27 INFO - 'LANGUAGE': 'en_US:en', 04:23:27 INFO - 'LOGNAME': 'cltbld', 04:23:27 INFO - 'MAIL': '/var/mail/cltbld', 04:23:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:27 INFO - 'MOZ_NO_REMOTE': '1', 04:23:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:27 INFO - 'NO_EM_RESTART': '1', 04:23:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:27 INFO - 'PWD': '/builds/slave/test', 04:23:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:27 INFO - 'SHELL': '/bin/bash', 04:23:27 INFO - 'SHLVL': '1', 04:23:27 INFO - 'TERM': 'linux', 04:23:27 INFO - 'TMOUT': '86400', 04:23:27 INFO - 'USER': 'cltbld', 04:23:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474456952.151743-302707296', 04:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:27 INFO - '_': '/tools/buildbot/bin/python'} 04:23:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.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 04:23:28 INFO - mozversion application_buildid: 20160921030508 04:23:28 INFO - mozversion application_changeset: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 04:23:28 INFO - mozversion application_display_name: Nightly 04:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:28 INFO - mozversion application_name: Firefox 04:23:28 INFO - mozversion application_remotingname: firefox 04:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion application_vendor: Mozilla 04:23:28 INFO - mozversion application_version: 52.0a1 04:23:28 INFO - mozversion platform_buildid: 20160921030508 04:23:28 INFO - mozversion platform_changeset: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 04:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion platform_version: 52.0a1 04:23:28 INFO - using testdate: 1474457008 04:23:28 INFO - actual date: 1474457008 04:23:28 INFO - starting webserver on 'localhost:54499' 04:23:28 INFO - SUITE-START | Running 2 tests 04:23:28 INFO - TEST-START | dromaeo_css 04:23:28 INFO - operating with platform_type : linux_ 04:23:28 INFO - Initialising browser for dromaeo_css test... 04:23:28 INFO - TEST-INFO | started process 28601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppK2xMh/profile http://localhost:54499/getInfo.html) 04:23:33 INFO - PROCESS | 28601 | __metrics Screen width/height:1600/1200 04:23:33 INFO - PROCESS | 28601 | colorDepth:24 04:23:33 INFO - PROCESS | 28601 | Browser inner width/height: 1024/697 04:23:33 INFO - PROCESS | 28601 | __metrics 04:23:33 INFO - PROCESS | 28601 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:23:33 INFO - PROCESS | 28601 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:23:34 INFO - PROCESS | 28601 | console.error: PushService: 04:23:34 INFO - PROCESS | 28601 | stateChangeProcessEnqueue: Error transitioning state 04:23:34 INFO - PROCESS | 28601 | UnknownError 04:23:35 INFO - TEST-INFO | 28601: exit 0 04:23:35 INFO - Browser initialized. 04:23:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:35 INFO - TEST-INFO | started process 28681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppK2xMh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:47 INFO - PROCESS | 28681 | RSS: Main: 175452160 04:23:47 INFO - PROCESS | 28681 | 04:24:38 INFO - PROCESS | 28681 | 1474457078563 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] 04:26:51 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54499/tests/dromaeo/cssquery-ext.html) 04:26:52 INFO - PROCESS | 28681 | RSS: Main: 318910464 04:26:52 INFO - PROCESS | 28681 | 04:29:55 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-ext.html (next: http://localhost:54499/tests/dromaeo/cssquery-jquery.html) 04:29:56 INFO - PROCESS | 28681 | RSS: Main: 282660864 04:29:56 INFO - PROCESS | 28681 | 04:32:58 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54499/tests/dromaeo/cssquery-mootools.html) 04:32:59 INFO - PROCESS | 28681 | RSS: Main: 219545600 04:32:59 INFO - PROCESS | 28681 | 04:36:01 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54499/tests/dromaeo/cssquery-prototype.html) 04:36:02 INFO - PROCESS | 28681 | RSS: Main: 254799872 04:36:02 INFO - PROCESS | 28681 | 04:39:05 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54499/tests/dromaeo/cssquery-yui.html) 04:39:05 INFO - PROCESS | 28681 | RSS: Main: 220614656 04:39:05 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | Cycle 1(1): loaded http://localhost:54499/tests/dromaeo/cssquery-yui.html (next: http://localhost:54499/tests/dromaeo/cssquery-dojo.html) 04:42:08 INFO - PROCESS | 28681 | RSS: Main: 283656192 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | __start_tp_report 04:42:08 INFO - PROCESS | 28681 | _x_x_mozilla_page_load 04:42:08 INFO - PROCESS | 28681 | _x_x_mozilla_page_load_details 04:42:08 INFO - PROCESS | 28681 | |i|pagename|runs| 04:42:08 INFO - PROCESS | 28681 | |0;dojo.html;2503.9248822535324;2563.6923569171704;2597.7532134447233;2600.206936884251;2613.7386261373863;4503.842365517207;4570.337301091348;4593.127305811898;4615.399998000264;4632.490426053131;4589.059242855215;4605.424321959755;4610.077984403116;4612.262038073909;4624.445066592014;4219.3881887126345;4229.851955181569;4281.978590107045;4285.228658841407;4327.11294184693;4212.178625168093;4267.701260911737;4294.119705460389;4328.545502722201;4362.781860906942;4197.265478541259;4265.616094551489;4305.332673435622;4316.7194132381455;4363.498197707273;4308.46144231971;4311.9651283692;4334.804933777988;4338.58783415575;4381.583749543788;4103.4870641169855;4177.185448837478;4179.561146079679;4182.435371224876;4209.6000879916355;4614.976925115353;4627.1439783640135;4628.652851036186;4715.858524244244;4738.218193997986;4928.1129396708575;4951.876203094951;4964.702117872939;4964.950350496485;5029.899402011939;4860.198067318888;4901.5588597026435;5000.049990501793;5006.524380183877;5057.0897238497055;4655.88360290992;4658.091672123904;4659.2312268476;4659.743714095689;4660.627149828006;5044.672096313728;5059.2916991621205;5063.189889617717;5063.544281014726;5065.417476990119;4815.566599006106;4862.756862156878;4871.2206047032305;4871.269309603588;4875.1224779540025;4941.308216849644;4950.43070046942;4951.579115775127;4951.678140920829;4975.950240497548;4957.3307603473795;4992.550670439678;4993.625478089158;4999.400071991385;5000.199968005102;4907.6564640475535;4910.926336104962;4915.0415668944925;4920.335754673145;4979.90040199194;4243.27864263076;4251.128518653669;4253.936190957138;4259.574042595716;4306.0957198987935;3649.105969037603;3669.43123815809;3688.686461650736;3711.5731690855896;3718.9442158367647;4373.584509471595;4381.3208952612395;4405.163019026375;4411.404460397869;4430.712003719748;5025.095482813055;5026.673266237683;5029.346184995927;5031.6729412588065;5093.286939828427;4223.788810559459;4279.935800962988;4331.198728235287;4364.781760911942;4365.847195348148;4522.728636281834;4558.817647294071;4563.726176429424;4602.654800889946;4611.492735799059;4733.313669517969;4750.216214324598;4757.7621118943225;4762.238041913277;4804.8318308859725;4817.590504807131;4858.4898585648;4980.825671101494;4985.875353116201;5035.395752509576;4685.344051832678;4690.484046754923;4721.179945712977;4732.716037037789;4800.231962885921;4899.559039686445;4901.436334821398;4909.042736666316;4910.189818680021;4966.701997880139;4862.7325497098;4945.406551213878;4950.232713929347;4953.2570114483115;5021.598272138293;4777.4505931818285;4781.52184781533;4829.517048295143;4842;4903;4823.2282834746275;4830.29960655696;4838.056578967067;4842.273658951185;4894.632902532396;4696.342512048248;4704.600108990774;4711.764411779466;4726.26742854858;4772.737499437425;4746.050789842115;4799.400074990626;4804.447488538863;4851.708897466164;4875.414950205998;4757.333973243818;4759.9524004759505;4760.0241950399395;4816.903661926672;4824.638152138674 04:42:08 INFO - PROCESS | 28681 | |1;ext.html;516.6512603992306;517.9145441002235;522.9895402091959;525.3931708876248;529.1824131716497;24471.632925506132;25071.874640626793;26771.732282677167;32685;33383.16542086449;33870.49194262088;34304.82847585765;34308.48537271943;34341.31317373651;34366;7385.113786345646;7515.736949206779;7523.473356865022;7526.962365188167;7527.39780817536;7434.591097489636;7481.102267727853;7513.248675132498;7516.233685084001;7518.285762852548;7486.064241969754;7562.886556701654;7567.810804729898;7569.735059272926;7576.583287919162;7337.523061001045;7370.968064470979;7371.631418429057;7384.593847338394;7385.335319821242;7438.776836694854;7502.062242219723;7503.399728021745;7504.887426688604;7506.8123296917465;31814.522782158285;31819.681803182135;32051.198720032186;32068.198295042577;32074.839625801957;2574.781143602796;2599.3891435512637;2603.9088631897794;2693.5151672698908;2727.59086137081;24227;25306.1142859999;25312.62031069517;25703.61444578333;26199.607005894926;2969.0795853285335;3040.5895204147378;3058.143719758471;3061.7244447999565;3082.7842051056437;256470;256869;257658;258017.70991145112;258442;43452.35119434517;43684.78157609192;43754.34368484475;43818.12363752771;43871;28788;29605;29687.703122968494;44675.77662111734;44840.77579612081;12884.355782210852;13045.34773261333;13046.02154838391;13046.869531304756;13049.086563940622;9965.950170249102;10076.19390448777;10081.042300981395;10093.09162175393;10093.495325233709;14161;14194.645133871529;14232.359543820552;14253.714925701428;14369.281535923163;5424.186372044146;5473.917891231635;5474.726263686879;5551.250581171571;5603.327600687943;682.2795464672932;753.8567672142275;817.9427440079256;823.4524041512447;833.4999000599713;23218.419539511648;24302.635460468107;24355;24617.384565386008;24838.254852354457;813.6623301330001;823.3289868756943;854.2013217641525;889.9288056955428;892.8749975003504;12110.212836165621;12505.93747031259;12520.433311171188;12536.623901282976;12561.246325220516;372911;373191;375191;376333.1183344066;376810;38676.226475470336;39110.41334379987;39116.21767564633;39173.608263917566;39186.60813391887;893.848045832197;910.8497097978759;911.2209061252667;960.1214888377197;996.8418374219733;23345.766542335037;25149.24552263435;26071.478570428866;26207;26368;34740.131496712784;35111.82444087763;35181.648183517835;35234.647653523134;35286;304430;307361;308545;308811;359534;19719.901400492905;32941;33467.83266083654;33716;35209;32039.67960320367;33654.495182571794;34583;34896.30207395787;34899.65100348964;30934.22664433407;31021.68978310188;31039.68960310368;31087.378252435275;32666.673333266364;28426.573601395583;28557;28750.856245718638;29040.7095929038;29310;30658.080257592308;30869;30955.845220774652;31121.221969450038;32038.51942220822;27232.591511127746;29003.564946525395;29887.55168672515;30169;30319.545206821473;22789.300900918483;22910.54178916379;23047;23273.185438509572;23498.882505587364 04:42:08 INFO - PROCESS | 28681 | |2;jquery.html;328.7123766704134;338.75271052131944;340.14453649072584;340.19374083422287;357.11969993964874;11576;12503.687407814808;14384.568462946116;14925.701485970274;14996.400143994228;14094.577162685111;14209.644758881008;14213.289335533207;14440.277986100706;14588.562343129723;4783.497732738065;4993.101241776479;5002.174641184219;5002.499750025005;5015.69905805651;4709.128811169928;4823.589994850442;4846.539578740014;4849.248366503198;4908.190148625473;4810.927836082444;4820.68665536739;4820.71075735457;4824.0834241494;4825.059113472874;4773.570378665902;4816.060868130716;4838.540338667821;4990.076835785355;5067.39191297043;4981.128302547076;4983.775730092155;4989.750512474398;4990.525900039491;4991.875203119915;10335.431551264677;14120.50578229757;18113.728294075598;18174.63650726978;18262;1698.6857431375236;1725.6807490614276;1934.2263094762068;1940.874292910123;2209.7127373441513;8272.917270827274;8400.285975692012;9671.806563868753;11605.535778568847;11730.765384692344;1685.5870311773695;1698.5583748225426;1711.2384988680042;1716.2276975361137;1719.869965900845;65545.3445465544;69718.65140674314;69956;70801;70912;8235.711750088718;8352.958235208785;8442.704505342284;9400.623975041059;9546.236301095896;12958.092933494754;12971;12977.740445191042;12980.870191298154;12983.935080324538;6663.966680166568;6748.392644662004;6893.069435626227;6920.30796920314;6954.965225173943;6303.149074874833;6406.263279722798;6456.418922297016;6599.967000164968;6618.801435956929;3352.055807631568;3762.8682996095004;3946.8223929923224;4044.757314561136;4142.896427589274;1488.8734457571227;1568.6784209237308;1608.332541995059;1641.2778377513855;1672.6571052934119;634.6858305138986;735.334522257358;740.3484933258806;776.281939206232;805.9959700201579;14794.890383221302;14937.551873443814;15305.923470382799;15796.92101539485;16067.357305707874;717.289883015821;734.6033142103312;740.2116745665957;754.528419737664;765.9846803063907;8223.876641850376;8246.587670616565;8672.132786721277;9040.367174297737;9084.454932704059;382293;383093;388294;390163;390543;82529.14475394487;82783;83032;87792;87913.56043219742;809.0897740042452;817.5094943034251;825.6314237909315;828.7347849473177;829.6100832608664;14417.78373324422;14437.927810360881;14476.782848257495;14517.637059073608;15159.393624254906;38300.6169938297;38490.80754596209;38745.2250954985;39602;40213.195736084526;51673.48326516687;51933;53203.201951969975;54411.72794136004;55766;6518.804435866931;6847.349501797321;7042.225355211025;7103.964480177566;7122.323379278961;9494.287928405536;11228.494717737558;11511.30932144074;11717.355545445082;12047.759044818878;9834.360766550151;9853.310268281151;10241.846372304273;10412.271141020055;10568.894311057098;9446.763830904283;9508.191803696487;9857.950710246403;10093.091621754078;10210.183185345302;9921.851172232278;10005.399676019171;10061.440476726119;10103.848442273225;10271.332363396356;6896.27589103137;6974.232834388112;7072.575645461289;7218.963905180651;7907.209279072047;7601.809954751176;10022.3485473444;10286.845697314397;10552.261341706007;10714.946425267824 04:42:08 INFO - PROCESS | 28681 | |3;mootools.html;1033.2818691009752;1089.792939341525;1094.2285688589545;1142.2518250545893;1243.9502419903204;6445.323241059686;7396.5562066276;7643.770686879388;7648.579328136951;7648.847023059536;7681.57751323677;7746.147923728399;7749.845003099935;7753.92246077539;7760.844783104349;2084.7185629939954;2106;2110.303599812058;2114.767375588684;2117.089651449876;2064.7006184103298;2115.270231770037;2136.807687308142;2143.506993391521;2152.547964927367;2077.1587507059667;2086.488810241485;2088.613606482798;2095.9371218863384;2150;2088.2377932054765;2090.19527481919;2091.5084955035554;2093.8429617778575;2094.350751267112;1974.8868710479792;2076.1280262289874;2078.9272375466785;2079.0332495389566;2079.2306846466754;7426.9257307427315;7569.697212111509;7650.081990161217;7666.65500052499;7671.424643151786;4263.91472170558;4416.447944006999;4430.556944305576;4432.357308190327;4439.045605194899;2685.973140268592;2860.184847318525;2867.856607169633;2872.5260332045186;2902.85485725715;856.7643897928058;867.9218870301703;873.7684513603837;874.5190145419994;888.8177923525661;10388.168946484264;10548.36709797407;10549.472526373727;10564.683059508227;10599.735006624818;3649.1242101895887;3743.1016556026902;3855.1711382052995;3890.8638197662945;3896.0065183378056;7927.0883848357025;7929.167437419103;7931.405144614177;7933.642986065525;7935.682572697027;4368.344748287719;4368.366586844953;4368.803403846835;4372.125574885035;4375.453068366454;3610.656987586175;3727.794971276606;3973.324534829086;4067.3288907330552;4068.5931406859077;3256.951145732816;3312.38720836646;3390.304987477561;3394.0496660934978;3394.405978953673;1002.6240159940022;1009.1321463541349;1020.1889497849228;1021.0759262866968;1025.0467065628889;630.7445484578753;632.550888868899;650.8795872763459;657.7336178847479;685.6674512861258;4811.591014763714;4992.80028798844;5003.224500202475;5034.748262586856;5270.209468579667;345.81326083914405;345.840913179935;348.48946293679376;362.88750487349006;364.1152000638474;3377.4933759936207;3432.5366075579477;3455.9136021599156;3457.94813077804;3478.5825700915548;9203.217726493189;9669.081437263449;9676.854847177297;9680.709578712649;9686.418814871131;9579.042095790364;9588.041195880496;9601.519924003773;9612.807743845084;9626.374285671409;6861.073755043105;6944.687489063004;6975.651217439107;7078.292170782984;7081.07945967021;4911.165101932608;4988.8752781180765;5035.018171456677;5035.118854200574;5047.192449208109;8568.614412351584;8694.34792390586;8819.514926679094;8830.337724670548;8838.248748856418;8878.955605221932;8936.821263574822;8996.235319997611;9006;9027.277817774693;5356.384015838228;5908.822735317947;5969.164316995711;5976.850578735566;5989.431004054608;6571.408573228241;6642.933570664231;6886.8622627548175;6895.241523432519;7042.401395881408;6133.141360209485;6304.65324407162;6361.45927596141;6490.221173459215;6527.3472652736245;6365.522585806176;6392.968035159981;6433.292337842927;6458.838529036811;6483.708233129426;5829.242198514166;5924.585279030426;5926.081457374114;5934.881302374015;5943.613665111754;4397.846075387346;4414.757188354672;4455.777211139495;4493.415855938707;4585.174668559691;4368.039031413211;4385.035292235703;4463.062756820974;4479.037007043371;4554.931676024796 04:42:08 INFO - PROCESS | 28681 | |4;prototype.html;266.5242542062419;270.7477914644768;279.8460846534406;281.5945039143633;282.0143598124555;4599.494055653884;4751.714897106176;4768.833090841817;4873.707577545345;4874.634402419824;4616.630669546436;4746.62027037837;4754.381930349058;4756.429228492577;4777.211760059586;3740.738148329618;3740.8503659853573;3746.4193050077283;3751.643593858586;3764.642358975893;3567.9643203567894;3671.998760675425;3750.3061933542244;3759.9624003760023;3767.8869633911027;3601.3697602919515;3657.3782456982376;3674.761140525857;3691.095681558022;3699.8335074921692;3670.2659468106485;3694.7967861767593;3703.666669999713;3703.925921481555;3714.591394946554;3239.8542065606866;3240.1575590346442;3246.951295730566;3250.1224669339144;3256.348730253959;4614.284785858164;4615.792289346988;4657.441107067174;4666.370040044584;4728.66899317048;4173.269677806372;4173.561776013506;4175.352820312856;4175.728577642443;4176.14389050247;4983.975080124576;4984.925226121611;5004.84985450437;5010.348654674905;5041.319421878036;3413.1808365992233;3506.1409954561295;3506.2636846262317;3511.3855075361707;3559.2169722660974;5189.506996835295;5221.877296381296;5238.240455134022;5241.659292146036;5255.1066318725525;3640.9805254528246;3646.8665830489463;3648.2521083177885;3664.450332450154;3664.8350824212976;3703.9259214816093;3703.9814051135613;3719.460678201646;3728.284988905134;3740.401535754266;4140.91718165635;4191.287481128215;4203.747775133502;4206.579342065769;4208.558101399371;4995.725235112031;5000.224965130338;5001.174806156943;5008.1486147355035;5046.823361182414;1197.233770386953;1226.2336039975016;1242.3974372429363;1257.5535684831937;1276.8467783865995;846.1200351634232;851.4423052900361;866.3545658484469;872.816708491224;874.9168828961239;4406.383106365111;4416.29339305716;4455.888602784891;4458.175237581057;4464.776761161929;5106.463821298785;5110.131277682803;5126.974365128225;5149.330587023663;5159.303494028258;4439.245328294198;4445.222086134913;4445.844395446144;4451.443569553806;4472.127935052634;2331.778481044298;2376.7504412036833;2379.536585000247;2387.5344307860146;2429.942974805965;4254.680898932593;4331.635534806526;4345.913081738411;4361.520232774392;4393.450818647669;4632.521600943479;4689.484156742756;4689.859304220879;4709.95290047102;4724.4094488188975;4068.4100805383055;4293.6080496407485;4337.6313013392955;4358.825646974149;4380.342948557678;4514.34541991416;4529.297958816389;4531;4546.090362288495;4563.977180114211;4435.538276256709;4465.910681786411;4466.932996004997;4473.642108631367;4503.392042074278;4164.687648426319;4296.957030429656;4328.80957736625;4389.736615803062;4400.977995110004;3238.6599407061917;3261.8695252189646;3268.2319654880607;3271.380666570063;3286.211309285802;4540.432445944257;4553.840615578439;4568.8400905969465;4572.931406028979;4615.538446155358;4631.397918270738;4832;4949.727764972961;4953.331300274561;4966;4979.775910084128;4992.475790041994;4995.325631039763;5007.173816320266;5030.823921162888;4797.560731780382;4871.171900776805;4886.190440496657;4886.633502487399;4941.579965702956;4995.750212489434;4998.725325042091;5009.448960614257;5011.7494125294315;5013.749312534432;4851.80592776285;4881.414230292387;4887.486813884491;4922.433920099091;4941.851744447672 04:42:08 INFO - PROCESS | 28681 | |5;yui.html;535.223925308303;540.4298465119298;555.4723013137518;557.9888402231953;601.4196300569951;12502.56241031564;13471.865281347184;13496.325183740799;13535.390907409166;13557.7966330505;11179.608713695023;11437.885621143787;12310.446029928653;12525.37373131342;12531.31077790721;532.87477442801;550.0127271547582;551.242042191986;551.5449753952985;551.7572268201978;540.8323419739874;541.1179776963544;541.3125330829844;541.3287523470888;541.4342012596845;566.9886602267952;568.7042737776354;568.7128000359812;569.3281927325754;569.3765326966965;565.2538648983343;565.9037963546207;566.0236092740012;566.1366416215263;568.0031544639173;410.8808445550787;411.52057852601683;411.537020851542;411.59252340183;413.85928784213513;10696.839547406795;10722.946385268102;10740.78518429627;10752.946235268852;10757.569697212102;10609.893901061045;10725.731856703567;10865.891341086566;11054.502547385306;11493.195476316661;9477.715668529956;9691.466969316756;9718.271129665303;9776.266779991529;10161.847572286422;3293.2590167212425;3302.190963214004;3324.0858763839897;3334.333133373311;3437.2094418283937;39056.414153787715;54321.45678543243;54417.72791136019;67561.324386756;68059.3194068058;8989.325800564984;9055.320850936074;9226.30802689801;9954.751131221778;10176.39009827093;15346.616334591501;16213.189340533163;16391.754123688155;16435.6712865742;16439.424620138238;6870.7595234166565;6933.341332573498;7114.6442677866935;7132.1441427029085;7165.3551180394015;3827.885163445101;3834.194819087967;3836.9040773980873;3850.1914597934747;3940.704447166474;2792.274008757697;2897.377063931223;2905.5060639691305;2913.533834586456;2918.8978385756395;476.1096749079175;485.87367284506286;489.2490027807299;489.5838537243386;498.7232086192126;396.96824254059607;429.85599824058664;480.5458841394918;501.9924701129486;514.1721827857147;7306.59813710251;7430.4798664093;7456.552606843498;7693.4614576979075;7804;493.6815753838754;495.0838864581146;499.1514425476704;526.1318823940529;529.7430746088144;3448.3965306071336;3634.582023067328;3642.453631955228;3696.9445458318146;3753.9061523462133;81165.59417202995;94088.0591194093;94218.52890735502;95573;96094;82277.17722822815;83402.58298708589;83776.58111709403;85394.57302713447;85544;74745.25254747491;75107;75534.62232688801;75846.62076689581;76545.61727191329;6986.371226589631;7110.182329032227;7366.263373662591;7487.101547814079;7500.287472690085;42541;44640.77679611581;44667.55332446764;45405.77297113493;45955.77022114868;58764;59274.70362648159;63293.36706632875;65575;65815.14050181667;8345.624446899783;8388.874166887623;8436.493810371398;8519.48883067018;8584.356173287153;9102.226310763659;9118.133777291147;9132.315076369432;9182.494962777111;9238.30712696537;9200.723978280395;9562.378445401027;9602.95198524003;9854.359466634645;9930.702078937644;9521.285903557122;9546;9629.903700962901;9672.177864881563;9942.403455792675;9135.862962055442;9457.952710236405;9626.614935402786;9846.212303015598;9862.605495780088;7361.30067643573;7600.3539699126195;7725.652345644347;7847.332976697045;8003.439759216799;7681.308682218627;7746.612669366396;8060.274575288252;8062.516249025077;8111.1888811118415 04:42:08 INFO - PROCESS | 28681 | __end_tp_report 04:42:08 INFO - PROCESS | 28681 | __start_cc_report 04:42:08 INFO - PROCESS | 28681 | _x_x_mozilla_cycle_collect,1196 04:42:08 INFO - PROCESS | 28681 | __end_cc_report 04:42:08 INFO - PROCESS | 28681 | __startTimestamp1474458128890__endTimestamp 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | ------- Summary: start ------- 04:42:08 INFO - PROCESS | 28681 | Number of tests: 6 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#0] dojo.html Cycles:165 Average:4597.79 Median:4733.31 stddev:477.70 (10.1%) stddev-sans-first:450.04 04:42:08 INFO - PROCESS | 28681 | Values: 2503.9 2563.7 2597.8 2600.2 2613.7 4503.8 4570.3 4593.1 4615.4 4632.5 4589.1 4605.4 4610.1 4612.3 4624.4 4219.4 4229.9 4282.0 4285.2 4327.1 4212.2 4267.7 4294.1 4328.5 4362.8 4197.3 4265.6 4305.3 4316.7 4363.5 4308.5 4312.0 4334.8 4338.6 4381.6 4103.5 4177.2 4179.6 4182.4 4209.6 4615.0 4627.1 4628.7 4715.9 4738.2 4928.1 4951.9 4964.7 4965.0 5029.9 4860.2 4901.6 5000.0 5006.5 5057.1 4655.9 4658.1 4659.2 4659.7 4660.6 5044.7 5059.3 5063.2 5063.5 5065.4 4815.6 4862.8 4871.2 4871.3 4875.1 4941.3 4950.4 4951.6 4951.7 4976.0 4957.3 4992.6 4993.6 4999.4 5000.2 4907.7 4910.9 4915.0 4920.3 4979.9 4243.3 4251.1 4253.9 4259.6 4306.1 3649.1 3669.4 3688.7 3711.6 3718.9 4373.6 4381.3 4405.2 4411.4 4430.7 5025.1 5026.7 5029.3 5031.7 5093.3 4223.8 4279.9 4331.2 4364.8 4365.8 4522.7 4558.8 4563.7 4602.7 4611.5 4733.3 4750.2 4757.8 4762.2 4804.8 4817.6 4858.5 4980.8 4985.9 5035.4 4685.3 4690.5 4721.2 4732.7 4800.2 4899.6 4901.4 4909.0 4910.2 4966.7 4862.7 4945.4 4950.2 4953.3 5021.6 4777.5 4781.5 4829.5 4842.0 4903.0 4823.2 4830.3 4838.1 4842.3 4894.6 4696.3 4704.6 4711.8 4726.3 4772.7 4746.1 4799.4 4804.4 4851.7 4875.4 4757.3 4760.0 4760.0 4816.9 4824.6 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#1] ext.html Cycles:180 Average:43984.31 Median:32675.84 stddev:84689.58 (259.2%) stddev-sans-first:84864.27 04:42:08 INFO - PROCESS | 28681 | Values: 516.7 517.9 523.0 525.4 529.2 24471.6 25071.9 26771.7 32685.0 33383.2 33870.5 34304.8 34308.5 34341.3 34366.0 7385.1 7515.7 7523.5 7527.0 7527.4 7434.6 7481.1 7513.2 7516.2 7518.3 7486.1 7562.9 7567.8 7569.7 7576.6 7337.5 7371.0 7371.6 7384.6 7385.3 7438.8 7502.1 7503.4 7504.9 7506.8 31814.5 31819.7 32051.2 32068.2 32074.8 2574.8 2599.4 2603.9 2693.5 2727.6 24227.0 25306.1 25312.6 25703.6 26199.6 2969.1 3040.6 3058.1 3061.7 3082.8 256470.0 256869.0 257658.0 258017.7 258442.0 43452.4 43684.8 43754.3 43818.1 43871.0 28788.0 29605.0 29687.7 44675.8 44840.8 12884.4 13045.3 13046.0 13046.9 13049.1 9966.0 10076.2 10081.0 10093.1 10093.5 14161.0 14194.6 14232.4 14253.7 14369.3 5424.2 5473.9 5474.7 5551.3 5603.3 682.3 753.9 817.9 823.5 833.5 23218.4 24302.6 24355.0 24617.4 24838.3 813.7 823.3 854.2 889.9 892.9 12110.2 12505.9 12520.4 12536.6 12561.2 372911.0 373191.0 375191.0 376333.1 376810.0 38676.2 39110.4 39116.2 39173.6 39186.6 893.8 910.8 911.2 960.1 996.8 23345.8 25149.2 26071.5 26207.0 26368.0 34740.1 35111.8 35181.6 35234.6 35286.0 304430.0 307361.0 308545.0 308811.0 359534.0 19719.9 32941.0 33467.8 33716.0 35209.0 32039.7 33654.5 34583.0 34896.3 34899.7 30934.2 31021.7 31039.7 31087.4 32666.7 28426.6 28557.0 28750.9 29040.7 29310.0 30658.1 30869.0 30955.8 31121.2 32038.5 27232.6 29003.6 29887.6 30169.0 30319.5 22789.3 22910.5 23047.0 23273.2 23498.9 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#2] jquery.html Cycles:180 Average:23956.35 Median:4822.15 stddev:64255.53 (1332.5%) stddev-sans-first:64411.29 04:42:08 INFO - PROCESS | 28681 | Values: 328.7 338.8 340.1 340.2 357.1 11576.0 12503.7 14384.6 14925.7 14996.4 14094.6 14209.6 14213.3 14440.3 14588.6 4783.5 4993.1 5002.2 5002.5 5015.7 4709.1 4823.6 4846.5 4849.2 4908.2 4810.9 4820.7 4820.7 4824.1 4825.1 4773.6 4816.1 4838.5 4990.1 5067.4 4981.1 4983.8 4989.8 4990.5 4991.9 10335.4 14120.5 18113.7 18174.6 18262.0 1698.7 1725.7 1934.2 1940.9 2209.7 8272.9 8400.3 9671.8 11605.5 11730.8 1685.6 1698.6 1711.2 1716.2 1719.9 65545.3 69718.7 69956.0 70801.0 70912.0 8235.7 8353.0 8442.7 9400.6 9546.2 12958.1 12971.0 12977.7 12980.9 12983.9 6664.0 6748.4 6893.1 6920.3 6955.0 6303.1 6406.3 6456.4 6600.0 6618.8 3352.1 3762.9 3946.8 4044.8 4142.9 1488.9 1568.7 1608.3 1641.3 1672.7 634.7 735.3 740.3 776.3 806.0 14794.9 14937.6 15305.9 15796.9 16067.4 717.3 734.6 740.2 754.5 766.0 8223.9 8246.6 8672.1 9040.4 9084.5 382293.0 383093.0 388294.0 390163.0 390543.0 82529.1 82783.0 83032.0 87792.0 87913.6 809.1 817.5 825.6 828.7 829.6 14417.8 14437.9 14476.8 14517.6 15159.4 38300.6 38490.8 38745.2 39602.0 40213.2 51673.5 51933.0 53203.2 54411.7 55766.0 6518.8 6847.3 7042.2 7104.0 7122.3 9494.3 11228.5 11511.3 11717.4 12047.8 9834.4 9853.3 10241.8 10412.3 10568.9 9446.8 9508.2 9858.0 10093.1 10210.2 9921.9 10005.4 10061.4 10103.8 10271.3 6896.3 6974.2 7072.6 7219.0 7907.2 7601.8 10022.3 10286.8 10552.3 10714.9 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#3] mootools.html Cycles:180 Average:4886.78 Median:4861.38 stddev:2837.00 (58.4%) stddev-sans-first:2830.17 04:42:08 INFO - PROCESS | 28681 | Values: 1033.3 1089.8 1094.2 1142.3 1244.0 6445.3 7396.6 7643.8 7648.6 7648.8 7681.6 7746.1 7749.8 7753.9 7760.8 2084.7 2106.0 2110.3 2114.8 2117.1 2064.7 2115.3 2136.8 2143.5 2152.5 2077.2 2086.5 2088.6 2095.9 2150.0 2088.2 2090.2 2091.5 2093.8 2094.4 1974.9 2076.1 2078.9 2079.0 2079.2 7426.9 7569.7 7650.1 7666.7 7671.4 4263.9 4416.4 4430.6 4432.4 4439.0 2686.0 2860.2 2867.9 2872.5 2902.9 856.8 867.9 873.8 874.5 888.8 10388.2 10548.4 10549.5 10564.7 10599.7 3649.1 3743.1 3855.2 3890.9 3896.0 7927.1 7929.2 7931.4 7933.6 7935.7 4368.3 4368.4 4368.8 4372.1 4375.5 3610.7 3727.8 3973.3 4067.3 4068.6 3257.0 3312.4 3390.3 3394.0 3394.4 1002.6 1009.1 1020.2 1021.1 1025.0 630.7 632.6 650.9 657.7 685.7 4811.6 4992.8 5003.2 5034.7 5270.2 345.8 345.8 348.5 362.9 364.1 3377.5 3432.5 3455.9 3457.9 3478.6 9203.2 9669.1 9676.9 9680.7 9686.4 9579.0 9588.0 9601.5 9612.8 9626.4 6861.1 6944.7 6975.7 7078.3 7081.1 4911.2 4988.9 5035.0 5035.1 5047.2 8568.6 8694.3 8819.5 8830.3 8838.2 8879.0 8936.8 8996.2 9006.0 9027.3 5356.4 5908.8 5969.2 5976.9 5989.4 6571.4 6642.9 6886.9 6895.2 7042.4 6133.1 6304.7 6361.5 6490.2 6527.3 6365.5 6393.0 6433.3 6458.8 6483.7 5829.2 5924.6 5926.1 5934.9 5943.6 4397.8 4414.8 4455.8 4493.4 4585.2 4368.0 4385.0 4463.1 4479.0 4554.9 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#4] prototype.html Cycles:180 Average:4016.77 Median:4448.64 stddev:1166.53 (26.2%) stddev-sans-first:1135.34 04:42:08 INFO - PROCESS | 28681 | Values: 266.5 270.7 279.8 281.6 282.0 4599.5 4751.7 4768.8 4873.7 4874.6 4616.6 4746.6 4754.4 4756.4 4777.2 3740.7 3740.9 3746.4 3751.6 3764.6 3568.0 3672.0 3750.3 3760.0 3767.9 3601.4 3657.4 3674.8 3691.1 3699.8 3670.3 3694.8 3703.7 3703.9 3714.6 3239.9 3240.2 3247.0 3250.1 3256.3 4614.3 4615.8 4657.4 4666.4 4728.7 4173.3 4173.6 4175.4 4175.7 4176.1 4984.0 4984.9 5004.8 5010.3 5041.3 3413.2 3506.1 3506.3 3511.4 3559.2 5189.5 5221.9 5238.2 5241.7 5255.1 3641.0 3646.9 3648.3 3664.5 3664.8 3703.9 3704.0 3719.5 3728.3 3740.4 4140.9 4191.3 4203.7 4206.6 4208.6 4995.7 5000.2 5001.2 5008.1 5046.8 1197.2 1226.2 1242.4 1257.6 1276.8 846.1 851.4 866.4 872.8 874.9 4406.4 4416.3 4455.9 4458.2 4464.8 5106.5 5110.1 5127.0 5149.3 5159.3 4439.2 4445.2 4445.8 4451.4 4472.1 2331.8 2376.8 2379.5 2387.5 2429.9 4254.7 4331.6 4345.9 4361.5 4393.5 4632.5 4689.5 4689.9 4710.0 4724.4 4068.4 4293.6 4337.6 4358.8 4380.3 4514.3 4529.3 4531.0 4546.1 4564.0 4435.5 4465.9 4466.9 4473.6 4503.4 4164.7 4297.0 4328.8 4389.7 4401.0 3238.7 3261.9 3268.2 3271.4 3286.2 4540.4 4553.8 4568.8 4572.9 4615.5 4631.4 4832.0 4949.7 4953.3 4966.0 4979.8 4992.5 4995.3 5007.2 5030.8 4797.6 4871.2 4886.2 4886.6 4941.6 4995.8 4998.7 5009.4 5011.7 5013.7 4851.8 4881.4 4887.5 4922.4 4941.9 04:42:08 INFO - PROCESS | 28681 | 04:42:08 INFO - PROCESS | 28681 | [#5] yui.html Cycles:180 Average:16680.80 Median:565.96 stddev:24964.50 (4411.0%) stddev-sans-first:25005.10 04:42:08 INFO - PROCESS | 28681 | Values: 535.2 540.4 555.5 558.0 601.4 12502.6 13471.9 13496.3 13535.4 13557.8 11179.6 11437.9 12310.4 12525.4 12531.3 532.9 550.0 551.2 551.5 551.8 540.8 541.1 541.3 541.3 541.4 567.0 568.7 568.7 569.3 569.4 565.3 565.9 566.0 566.1 568.0 410.9 411.5 411.5 411.6 413.9 10696.8 10722.9 10740.8 10752.9 10757.6 10609.9 10725.7 10865.9 11054.5 11493.2 9477.7 9691.5 9718.3 9776.3 10161.8 3293.3 3302.2 3324.1 3334.3 3437.2 39056.4 54321.5 54417.7 67561.3 68059.3 8989.3 9055.3 9226.3 9954.8 10176.4 15346.6 16213.2 16391.8 16435.7 16439.4 6870.8 6933.3 7114.6 7132.1 7165.4 3827.9 3834.2 3836.9 3850.2 3940.7 2792.3 2897.4 2905.5 2913.5 2918.9 476.1 485.9 489.2 489.6 498.7 397.0 429.9 480.5 502.0 514.2 7306.6 7430.5 7456.6 7693.5 7804.0 493.7 495.1 499.2 526.1 529.7 3448.4 3634.6 3642.5 3696.9 3753.9 81165.6 94088.1 94218.5 95573.0 96094.0 82277.2 83402.6 83776.6 85394.6 85544.0 74745.3 75107.0 75534.6 75846.6 76545.6 6986.4 7110.2 7366.3 7487.1 7500.3 42541.0 44640.8 44667.6 45405.8 45955.8 58764.0 59274.7 63293.4 65575.0 65815.1 8345.6 8388.9 8436.5 8519.5 8584.4 9102.2 9118.1 9132.3 9182.5 9238.3 9200.7 9562.4 9603.0 9854.4 9930.7 9521.3 9546.0 9629.9 9672.2 9942.4 9135.9 9458.0 9626.6 9846.2 9862.6 7361.3 7600.4 7725.7 7847.3 8003.4 7681.3 7746.6 8060.3 8062.5 8111.2 04:42:08 INFO - PROCESS | 28681 | -------- Summary: end -------- 04:42:08 INFO - PROCESS | 28681 | 04:42:09 INFO - TEST-INFO | 28681: exit 0 04:42:09 INFO - TEST-OK | dromaeo_css | took 1121854ms 04:42:09 INFO - TEST-START | kraken 04:42:09 INFO - operating with platform_type : linux_ 04:42:09 INFO - Initialising browser for kraken test... 04:42:09 INFO - TEST-INFO | started process 28997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjVkIa/profile http://localhost:54499/getInfo.html) 04:42:14 INFO - PROCESS | 28997 | __metrics Screen width/height:1600/1200 04:42:14 INFO - PROCESS | 28997 | colorDepth:24 04:42:14 INFO - PROCESS | 28997 | Browser inner width/height: 1024/697 04:42:14 INFO - PROCESS | 28997 | __metrics 04:42:15 INFO - PROCESS | 28997 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:42:15 INFO - PROCESS | 28997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:16 INFO - PROCESS | 28997 | console.error: PushService: 04:42:16 INFO - PROCESS | 28997 | stateChangeProcessEnqueue: Error transitioning state 04:42:16 INFO - PROCESS | 28997 | UnknownError 04:42:16 INFO - TEST-INFO | 28997: exit 0 04:42:16 INFO - Browser initialized. 04:42:16 INFO - Running cycle 1/1 for kraken test... 04:42:16 INFO - TEST-INFO | started process 29077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjVkIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:29 INFO - PROCESS | 29077 | RSS: Main: 175493120 04:42:29 INFO - PROCESS | 29077 | 04:42:31 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54499/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:32 INFO - PROCESS | 29077 | RSS: Main: 234151936 04:42:32 INFO - PROCESS | 29077 | 04:42:35 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54499/tests/kraken/driver.html?testName=audio-dft) 04:42:36 INFO - PROCESS | 29077 | RSS: Main: 218730496 04:42:36 INFO - PROCESS | 29077 | 04:42:39 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54499/tests/kraken/driver.html?testName=audio-fft) 04:42:40 INFO - PROCESS | 29077 | RSS: Main: 300572672 04:42:40 INFO - PROCESS | 29077 | 04:42:42 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54499/tests/kraken/driver.html?testName=audio-oscillator) 04:42:42 INFO - PROCESS | 29077 | RSS: Main: 209653760 04:42:42 INFO - PROCESS | 29077 | 04:42:45 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:45 INFO - PROCESS | 29077 | RSS: Main: 213860352 04:42:45 INFO - PROCESS | 29077 | 04:42:48 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54499/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:49 INFO - PROCESS | 29077 | RSS: Main: 251043840 04:42:49 INFO - PROCESS | 29077 | 04:42:53 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54499/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:53 INFO - PROCESS | 29077 | RSS: Main: 245071872 04:42:53 INFO - PROCESS | 29077 | 04:42:56 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54499/tests/kraken/driver.html?testName=json-parse-financial) 04:42:57 INFO - PROCESS | 29077 | RSS: Main: 247910400 04:42:57 INFO - PROCESS | 29077 | 04:42:58 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:59 INFO - PROCESS | 29077 | RSS: Main: 211435520 04:42:59 INFO - PROCESS | 29077 | 04:43:01 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:02 INFO - PROCESS | 29077 | RSS: Main: 218542080 04:43:02 INFO - PROCESS | 29077 | 04:43:04 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:05 INFO - PROCESS | 29077 | RSS: Main: 222871552 04:43:05 INFO - PROCESS | 29077 | 04:43:07 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:08 INFO - PROCESS | 29077 | RSS: Main: 223891456 04:43:08 INFO - PROCESS | 29077 | 04:43:11 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:12 INFO - PROCESS | 29077 | RSS: Main: 221745152 04:43:12 INFO - PROCESS | 29077 | 04:43:13 INFO - PROCESS | 29077 | Cycle 1(1): loaded http://localhost:54499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54499/tests/kraken/driver.html?testName=ai-astar) 04:43:14 INFO - PROCESS | 29077 | RSS: Main: 273510400 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | __start_tp_report 04:43:14 INFO - PROCESS | 29077 | _x_x_mozilla_page_load 04:43:14 INFO - PROCESS | 29077 | _x_x_mozilla_page_load_details 04:43:14 INFO - PROCESS | 29077 | |i|pagename|runs| 04:43:14 INFO - PROCESS | 29077 | |0;ai-astar;113;117;116;115;116;116;114;115;114;114 04:43:14 INFO - PROCESS | 29077 | |1;audio-beat-detection;150;129;122;164;127;130;123;129;160;124 04:43:14 INFO - PROCESS | 29077 | |2;audio-dft;162;162;161;162;163;165;163;163;160;161 04:43:14 INFO - PROCESS | 29077 | |3;audio-fft;76;77;77;109;78;77;77;76;102;76 04:43:14 INFO - PROCESS | 29077 | |4;audio-oscillator;84;83;129;84;85;83;112;83;83;115 04:43:14 INFO - PROCESS | 29077 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;117;117;116 04:43:14 INFO - PROCESS | 29077 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;147;146 04:43:14 INFO - PROCESS | 29077 | |7;imaging-desaturate;96;96;96;96;96;96;95;95;96;96 04:43:14 INFO - PROCESS | 29077 | |8;json-parse-financial;64;63;62;63;65;64;65;65;65;64 04:43:14 INFO - PROCESS | 29077 | |9;json-stringify-tinderbox;65;65;65;76;66;66;66;65;65;66 04:43:14 INFO - PROCESS | 29077 | |10;stanford-crypto-aes;83;91;85;91;83;82;82;82;82;82 04:43:14 INFO - PROCESS | 29077 | |11;stanford-crypto-ccm;134;133;135;132;134;133;134;140;182;134 04:43:14 INFO - PROCESS | 29077 | |12;stanford-crypto-pbkdf2;176;177;177;175;174;174;174;174;174;180 04:43:14 INFO - PROCESS | 29077 | |13;stanford-crypto-sha256-iterative;70;69;70;70;68;68;69;68;72;67 04:43:14 INFO - PROCESS | 29077 | __end_tp_report 04:43:14 INFO - PROCESS | 29077 | __start_cc_report 04:43:14 INFO - PROCESS | 29077 | _x_x_mozilla_cycle_collect,1948 04:43:14 INFO - PROCESS | 29077 | __end_cc_report 04:43:14 INFO - PROCESS | 29077 | __startTimestamp1474458194035__endTimestamp 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | ------- Summary: start ------- 04:43:14 INFO - PROCESS | 29077 | Number of tests: 14 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:1.25 (1.1%) stddev-sans-first:1.09 04:43:14 INFO - PROCESS | 29077 | Values: 113.0 117.0 116.0 115.0 116.0 116.0 114.0 115.0 114.0 114.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:129.50 stddev:15.92 (12.3%) stddev-sans-first:16.03 04:43:14 INFO - PROCESS | 29077 | Values: 150.0 129.0 122.0 164.0 127.0 130.0 123.0 129.0 160.0 124.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 04:43:14 INFO - PROCESS | 29077 | Values: 162.0 162.0 161.0 162.0 163.0 165.0 163.0 163.0 160.0 161.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:12.25 (15.9%) stddev-sans-first:12.76 04:43:14 INFO - PROCESS | 29077 | Values: 76.0 77.0 77.0 109.0 78.0 77.0 77.0 76.0 102.0 76.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:17.50 (21.1%) stddev-sans-first:18.17 04:43:14 INFO - PROCESS | 29077 | Values: 84.0 83.0 129.0 84.0 85.0 83.0 112.0 83.0 83.0 115.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:43:14 INFO - PROCESS | 29077 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:43:14 INFO - PROCESS | 29077 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:43:14 INFO - PROCESS | 29077 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.50 stddev:1.05 (1.6%) stddev-sans-first:1.12 04:43:14 INFO - PROCESS | 29077 | Values: 64.0 63.0 62.0 63.0 65.0 64.0 65.0 65.0 65.0 64.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:3.37 (5.1%) stddev-sans-first:3.54 04:43:14 INFO - PROCESS | 29077 | Values: 65.0 65.0 65.0 76.0 66.0 66.0 66.0 65.0 65.0 66.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.65 (4.4%) stddev-sans-first:3.84 04:43:14 INFO - PROCESS | 29077 | Values: 83.0 91.0 85.0 91.0 83.0 82.0 82.0 82.0 82.0 82.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:134.00 stddev:15.23 (11.4%) stddev-sans-first:16.04 04:43:14 INFO - PROCESS | 29077 | Values: 134.0 133.0 135.0 132.0 134.0 133.0 134.0 140.0 182.0 134.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:175.50 stddev:2.01 (1.1%) stddev-sans-first:2.13 04:43:14 INFO - PROCESS | 29077 | Values: 176.0 177.0 177.0 175.0 174.0 174.0 174.0 174.0 174.0 180.0 04:43:14 INFO - PROCESS | 29077 | 04:43:14 INFO - PROCESS | 29077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.45 (2.1%) stddev-sans-first:1.50 04:43:14 INFO - PROCESS | 29077 | Values: 70.0 69.0 70.0 70.0 68.0 68.0 69.0 68.0 72.0 67.0 04:43:14 INFO - PROCESS | 29077 | -------- Summary: end -------- 04:43:14 INFO - PROCESS | 29077 | 04:43:15 INFO - TEST-INFO | 29077: exit 0 04:43:15 INFO - TEST-OK | kraken | took 65438ms 04:43:15 INFO - SUITE-END | took 1187s 04:43:15 INFO - Completed test suite (00:19:47) 04:43:15 INFO - javascript benchmark 04:43:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2503.9248822535324, 2563.6923569171704, 2597.7532134447233, 2600.206936884251, 2613.7386261373863, 4503.842365517207, 4570.337301091348, 4593.127305811898, 4615.399998000264, 4632.490426053131, 4589.059242855215, 4605.424321959755, 4610.077984403116, 4612.262038073909, 4624.445066592014, 4219.3881887126345, 4229.851955181569, 4281.978590107045, 4285.228658841407, 4327.11294184693, 4212.178625168093, 4267.701260911737, 4294.119705460389, 4328.545502722201, 4362.781860906942, 4197.265478541259, 4265.616094551489, 4305.332673435622, 4316.7194132381455, 4363.498197707273, 4308.46144231971, 4311.9651283692, 4334.804933777988, 4338.58783415575, 4381.583749543788, 4103.4870641169855, 4177.185448837478, 4179.561146079679, 4182.435371224876, 4209.6000879916355, 4614.976925115353, 4627.1439783640135, 4628.652851036186, 4715.858524244244, 4738.218193997986, 4928.1129396708575, 4951.876203094951, 4964.702117872939, 4964.950350496485, 5029.899402011939, 4860.198067318888, 4901.5588597026435, 5000.049990501793, 5006.524380183877, 5057.0897238497055, 4655.88360290992, 4658.091672123904, 4659.2312268476, 4659.743714095689, 4660.627149828006, 5044.672096313728, 5059.2916991621205, 5063.189889617717, 5063.544281014726, 5065.417476990119, 4815.566599006106, 4862.756862156878, 4871.2206047032305, 4871.269309603588, 4875.1224779540025, 4941.308216849644, 4950.43070046942, 4951.579115775127, 4951.678140920829, 4975.950240497548, 4957.3307603473795, 4992.550670439678, 4993.625478089158, 4999.400071991385, 5000.199968005102, 4907.6564640475535, 4910.926336104962, 4915.0415668944925, 4920.335754673145, 4979.90040199194, 4243.27864263076, 4251.128518653669, 4253.936190957138, 4259.574042595716, 4306.0957198987935, 3649.105969037603, 3669.43123815809, 3688.686461650736, 3711.5731690855896, 3718.9442158367647, 4373.584509471595, 4381.3208952612395, 4405.163019026375, 4411.404460397869, 4430.712003719748, 5025.095482813055, 5026.673266237683, 5029.346184995927, 5031.6729412588065, 5093.286939828427, 4223.788810559459, 4279.935800962988, 4331.198728235287, 4364.781760911942, 4365.847195348148, 4522.728636281834, 4558.817647294071, 4563.726176429424, 4602.654800889946, 4611.492735799059, 4733.313669517969, 4750.216214324598, 4757.7621118943225, 4762.238041913277, 4804.8318308859725, 4817.590504807131, 4858.4898585648, 4980.825671101494, 4985.875353116201, 5035.395752509576, 4685.344051832678, 4690.484046754923, 4721.179945712977, 4732.716037037789, 4800.231962885921, 4899.559039686445, 4901.436334821398, 4909.042736666316, 4910.189818680021, 4966.701997880139, 4862.7325497098, 4945.406551213878, 4950.232713929347, 4953.2570114483115, 5021.598272138293, 4777.4505931818285, 4781.52184781533, 4829.517048295143, 4842.0, 4903.0, 4823.2282834746275, 4830.29960655696, 4838.056578967067, 4842.273658951185, 4894.632902532396, 4696.342512048248, 4704.600108990774, 4711.764411779466, 4726.26742854858, 4772.737499437425, 4746.050789842115, 4799.400074990626, 4804.447488538863, 4851.708897466164, 4875.414950205998, 4757.333973243818, 4759.9524004759505, 4760.0241950399395, 4816.903661926672, 4824.638152138674], "value": 4567.134710158228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.6512603992306, 517.9145441002235, 522.9895402091959, 525.3931708876248, 529.1824131716497, 24471.632925506132, 25071.874640626793, 26771.732282677167, 32685.0, 33383.16542086449, 33870.49194262088, 34304.82847585765, 34308.48537271943, 34341.31317373651, 34366.0, 7385.113786345646, 7515.736949206779, 7523.473356865022, 7526.962365188167, 7527.39780817536, 7434.591097489636, 7481.102267727853, 7513.248675132498, 7516.233685084001, 7518.285762852548, 7486.064241969754, 7562.886556701654, 7567.810804729898, 7569.735059272926, 7576.583287919162, 7337.523061001045, 7370.968064470979, 7371.631418429057, 7384.593847338394, 7385.335319821242, 7438.776836694854, 7502.062242219723, 7503.399728021745, 7504.887426688604, 7506.8123296917465, 31814.522782158285, 31819.681803182135, 32051.198720032186, 32068.198295042577, 32074.839625801957, 2574.781143602796, 2599.3891435512637, 2603.9088631897794, 2693.5151672698908, 2727.59086137081, 24227.0, 25306.1142859999, 25312.62031069517, 25703.61444578333, 26199.607005894926, 2969.0795853285335, 3040.5895204147378, 3058.143719758471, 3061.7244447999565, 3082.7842051056437, 256470.0, 256869.0, 257658.0, 258017.70991145112, 258442.0, 43452.35119434517, 43684.78157609192, 43754.34368484475, 43818.12363752771, 43871.0, 28788.0, 29605.0, 29687.703122968494, 44675.77662111734, 44840.77579612081, 12884.355782210852, 13045.34773261333, 13046.02154838391, 13046.869531304756, 13049.086563940622, 9965.950170249102, 10076.19390448777, 10081.042300981395, 10093.09162175393, 10093.495325233709, 14161.0, 14194.645133871529, 14232.359543820552, 14253.714925701428, 14369.281535923163, 5424.186372044146, 5473.917891231635, 5474.726263686879, 5551.250581171571, 5603.327600687943, 682.2795464672932, 753.8567672142275, 817.9427440079256, 823.4524041512447, 833.4999000599713, 23218.419539511648, 24302.635460468107, 24355.0, 24617.384565386008, 24838.254852354457, 813.6623301330001, 823.3289868756943, 854.2013217641525, 889.9288056955428, 892.8749975003504, 12110.212836165621, 12505.93747031259, 12520.433311171188, 12536.623901282976, 12561.246325220516, 372911.0, 373191.0, 375191.0, 376333.1183344066, 376810.0, 38676.226475470336, 39110.41334379987, 39116.21767564633, 39173.608263917566, 39186.60813391887, 893.848045832197, 910.8497097978759, 911.2209061252667, 960.1214888377197, 996.8418374219733, 23345.766542335037, 25149.24552263435, 26071.478570428866, 26207.0, 26368.0, 34740.131496712784, 35111.82444087763, 35181.648183517835, 35234.647653523134, 35286.0, 304430.0, 307361.0, 308545.0, 308811.0, 359534.0, 19719.901400492905, 32941.0, 33467.83266083654, 33716.0, 35209.0, 32039.67960320367, 33654.495182571794, 34583.0, 34896.30207395787, 34899.65100348964, 30934.22664433407, 31021.68978310188, 31039.68960310368, 31087.378252435275, 32666.673333266364, 28426.573601395583, 28557.0, 28750.856245718638, 29040.7095929038, 29310.0, 30658.080257592308, 30869.0, 30955.845220774652, 31121.221969450038, 32038.51942220822, 27232.591511127746, 29003.564946525395, 29887.55168672515, 30169.0, 30319.545206821473, 22789.300900918483, 22910.54178916379, 23047.0, 23273.185438509572, 23498.882505587364], "value": 15353.193251067805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.7123766704134, 338.75271052131944, 340.14453649072584, 340.19374083422287, 357.11969993964874, 11576.0, 12503.687407814808, 14384.568462946116, 14925.701485970274, 14996.400143994228, 14094.577162685111, 14209.644758881008, 14213.289335533207, 14440.277986100706, 14588.562343129723, 4783.497732738065, 4993.101241776479, 5002.174641184219, 5002.499750025005, 5015.69905805651, 4709.128811169928, 4823.589994850442, 4846.539578740014, 4849.248366503198, 4908.190148625473, 4810.927836082444, 4820.68665536739, 4820.71075735457, 4824.0834241494, 4825.059113472874, 4773.570378665902, 4816.060868130716, 4838.540338667821, 4990.076835785355, 5067.39191297043, 4981.128302547076, 4983.775730092155, 4989.750512474398, 4990.525900039491, 4991.875203119915, 10335.431551264677, 14120.50578229757, 18113.728294075598, 18174.63650726978, 18262.0, 1698.6857431375236, 1725.6807490614276, 1934.2263094762068, 1940.874292910123, 2209.7127373441513, 8272.917270827274, 8400.285975692012, 9671.806563868753, 11605.535778568847, 11730.765384692344, 1685.5870311773695, 1698.5583748225426, 1711.2384988680042, 1716.2276975361137, 1719.869965900845, 65545.3445465544, 69718.65140674314, 69956.0, 70801.0, 70912.0, 8235.711750088718, 8352.958235208785, 8442.704505342284, 9400.623975041059, 9546.236301095896, 12958.092933494754, 12971.0, 12977.740445191042, 12980.870191298154, 12983.935080324538, 6663.966680166568, 6748.392644662004, 6893.069435626227, 6920.30796920314, 6954.965225173943, 6303.149074874833, 6406.263279722798, 6456.418922297016, 6599.967000164968, 6618.801435956929, 3352.055807631568, 3762.8682996095004, 3946.8223929923224, 4044.757314561136, 4142.896427589274, 1488.8734457571227, 1568.6784209237308, 1608.332541995059, 1641.2778377513855, 1672.6571052934119, 634.6858305138986, 735.334522257358, 740.3484933258806, 776.281939206232, 805.9959700201579, 14794.890383221302, 14937.551873443814, 15305.923470382799, 15796.92101539485, 16067.357305707874, 717.289883015821, 734.6033142103312, 740.2116745665957, 754.528419737664, 765.9846803063907, 8223.876641850376, 8246.587670616565, 8672.132786721277, 9040.367174297737, 9084.454932704059, 382293.0, 383093.0, 388294.0, 390163.0, 390543.0, 82529.14475394487, 82783.0, 83032.0, 87792.0, 87913.56043219742, 809.0897740042452, 817.5094943034251, 825.6314237909315, 828.7347849473177, 829.6100832608664, 14417.78373324422, 14437.927810360881, 14476.782848257495, 14517.637059073608, 15159.393624254906, 38300.6169938297, 38490.80754596209, 38745.2250954985, 39602.0, 40213.195736084526, 51673.48326516687, 51933.0, 53203.201951969975, 54411.72794136004, 55766.0, 6518.804435866931, 6847.349501797321, 7042.225355211025, 7103.964480177566, 7122.323379278961, 9494.287928405536, 11228.494717737558, 11511.30932144074, 11717.355545445082, 12047.759044818878, 9834.360766550151, 9853.310268281151, 10241.846372304273, 10412.271141020055, 10568.894311057098, 9446.763830904283, 9508.191803696487, 9857.950710246403, 10093.091621754078, 10210.183185345302, 9921.851172232278, 10005.399676019171, 10061.440476726119, 10103.848442273225, 10271.332363396356, 6896.27589103137, 6974.232834388112, 7072.575645461289, 7218.963905180651, 7907.209279072047, 7601.809954751176, 10022.3485473444, 10286.845697314397, 10552.261341706007, 10714.946425267824], "value": 7663.706912048401, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1033.2818691009752, 1089.792939341525, 1094.2285688589545, 1142.2518250545893, 1243.9502419903204, 6445.323241059686, 7396.5562066276, 7643.770686879388, 7648.579328136951, 7648.847023059536, 7681.57751323677, 7746.147923728399, 7749.845003099935, 7753.92246077539, 7760.844783104349, 2084.7185629939954, 2106.0, 2110.303599812058, 2114.767375588684, 2117.089651449876, 2064.7006184103298, 2115.270231770037, 2136.807687308142, 2143.506993391521, 2152.547964927367, 2077.1587507059667, 2086.488810241485, 2088.613606482798, 2095.9371218863384, 2150.0, 2088.2377932054765, 2090.19527481919, 2091.5084955035554, 2093.8429617778575, 2094.350751267112, 1974.8868710479792, 2076.1280262289874, 2078.9272375466785, 2079.0332495389566, 2079.2306846466754, 7426.9257307427315, 7569.697212111509, 7650.081990161217, 7666.65500052499, 7671.424643151786, 4263.91472170558, 4416.447944006999, 4430.556944305576, 4432.357308190327, 4439.045605194899, 2685.973140268592, 2860.184847318525, 2867.856607169633, 2872.5260332045186, 2902.85485725715, 856.7643897928058, 867.9218870301703, 873.7684513603837, 874.5190145419994, 888.8177923525661, 10388.168946484264, 10548.36709797407, 10549.472526373727, 10564.683059508227, 10599.735006624818, 3649.1242101895887, 3743.1016556026902, 3855.1711382052995, 3890.8638197662945, 3896.0065183378056, 7927.0883848357025, 7929.167437419103, 7931.405144614177, 7933.642986065525, 7935.682572697027, 4368.344748287719, 4368.366586844953, 4368.803403846835, 4372.125574885035, 4375.453068366454, 3610.656987586175, 3727.794971276606, 3973.324534829086, 4067.3288907330552, 4068.5931406859077, 3256.951145732816, 3312.38720836646, 3390.304987477561, 3394.0496660934978, 3394.405978953673, 1002.6240159940022, 1009.1321463541349, 1020.1889497849228, 1021.0759262866968, 1025.0467065628889, 630.7445484578753, 632.550888868899, 650.8795872763459, 657.7336178847479, 685.6674512861258, 4811.591014763714, 4992.80028798844, 5003.224500202475, 5034.748262586856, 5270.209468579667, 345.81326083914405, 345.840913179935, 348.48946293679376, 362.88750487349006, 364.1152000638474, 3377.4933759936207, 3432.5366075579477, 3455.9136021599156, 3457.94813077804, 3478.5825700915548, 9203.217726493189, 9669.081437263449, 9676.854847177297, 9680.709578712649, 9686.418814871131, 9579.042095790364, 9588.041195880496, 9601.519924003773, 9612.807743845084, 9626.374285671409, 6861.073755043105, 6944.687489063004, 6975.651217439107, 7078.292170782984, 7081.07945967021, 4911.165101932608, 4988.8752781180765, 5035.018171456677, 5035.118854200574, 5047.192449208109, 8568.614412351584, 8694.34792390586, 8819.514926679094, 8830.337724670548, 8838.248748856418, 8878.955605221932, 8936.821263574822, 8996.235319997611, 9006.0, 9027.277817774693, 5356.384015838228, 5908.822735317947, 5969.164316995711, 5976.850578735566, 5989.431004054608, 6571.408573228241, 6642.933570664231, 6886.8622627548175, 6895.241523432519, 7042.401395881408, 6133.141360209485, 6304.65324407162, 6361.45927596141, 6490.221173459215, 6527.3472652736245, 6365.522585806176, 6392.968035159981, 6433.292337842927, 6458.838529036811, 6483.708233129426, 5829.242198514166, 5924.585279030426, 5926.081457374114, 5934.881302374015, 5943.613665111754, 4397.846075387346, 4414.757188354672, 4455.777211139495, 4493.415855938707, 4585.174668559691, 4368.039031413211, 4385.035292235703, 4463.062756820974, 4479.037007043371, 4554.931676024796], "value": 3801.616824447086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.5242542062419, 270.7477914644768, 279.8460846534406, 281.5945039143633, 282.0143598124555, 4599.494055653884, 4751.714897106176, 4768.833090841817, 4873.707577545345, 4874.634402419824, 4616.630669546436, 4746.62027037837, 4754.381930349058, 4756.429228492577, 4777.211760059586, 3740.738148329618, 3740.8503659853573, 3746.4193050077283, 3751.643593858586, 3764.642358975893, 3567.9643203567894, 3671.998760675425, 3750.3061933542244, 3759.9624003760023, 3767.8869633911027, 3601.3697602919515, 3657.3782456982376, 3674.761140525857, 3691.095681558022, 3699.8335074921692, 3670.2659468106485, 3694.7967861767593, 3703.666669999713, 3703.925921481555, 3714.591394946554, 3239.8542065606866, 3240.1575590346442, 3246.951295730566, 3250.1224669339144, 3256.348730253959, 4614.284785858164, 4615.792289346988, 4657.441107067174, 4666.370040044584, 4728.66899317048, 4173.269677806372, 4173.561776013506, 4175.352820312856, 4175.728577642443, 4176.14389050247, 4983.975080124576, 4984.925226121611, 5004.84985450437, 5010.348654674905, 5041.319421878036, 3413.1808365992233, 3506.1409954561295, 3506.2636846262317, 3511.3855075361707, 3559.2169722660974, 5189.506996835295, 5221.877296381296, 5238.240455134022, 5241.659292146036, 5255.1066318725525, 3640.9805254528246, 3646.8665830489463, 3648.2521083177885, 3664.450332450154, 3664.8350824212976, 3703.9259214816093, 3703.9814051135613, 3719.460678201646, 3728.284988905134, 3740.401535754266, 4140.91718165635, 4191.287481128215, 4203.747775133502, 4206.579342065769, 4208.558101399371, 4995.725235112031, 5000.224965130338, 5001.174806156943, 5008.1486147355035, 5046.823361182414, 1197.233770386953, 1226.2336039975016, 1242.3974372429363, 1257.5535684831937, 1276.8467783865995, 846.1200351634232, 851.4423052900361, 866.3545658484469, 872.816708491224, 874.9168828961239, 4406.383106365111, 4416.29339305716, 4455.888602784891, 4458.175237581057, 4464.776761161929, 5106.463821298785, 5110.131277682803, 5126.974365128225, 5149.330587023663, 5159.303494028258, 4439.245328294198, 4445.222086134913, 4445.844395446144, 4451.443569553806, 4472.127935052634, 2331.778481044298, 2376.7504412036833, 2379.536585000247, 2387.5344307860146, 2429.942974805965, 4254.680898932593, 4331.635534806526, 4345.913081738411, 4361.520232774392, 4393.450818647669, 4632.521600943479, 4689.484156742756, 4689.859304220879, 4709.95290047102, 4724.4094488188975, 4068.4100805383055, 4293.6080496407485, 4337.6313013392955, 4358.825646974149, 4380.342948557678, 4514.34541991416, 4529.297958816389, 4531.0, 4546.090362288495, 4563.977180114211, 4435.538276256709, 4465.910681786411, 4466.932996004997, 4473.642108631367, 4503.392042074278, 4164.687648426319, 4296.957030429656, 4328.80957736625, 4389.736615803062, 4400.977995110004, 3238.6599407061917, 3261.8695252189646, 3268.2319654880607, 3271.380666570063, 3286.211309285802, 4540.432445944257, 4553.840615578439, 4568.8400905969465, 4572.931406028979, 4615.538446155358, 4631.397918270738, 4832.0, 4949.727764972961, 4953.331300274561, 4966.0, 4979.775910084128, 4992.475790041994, 4995.325631039763, 5007.173816320266, 5030.823921162888, 4797.560731780382, 4871.171900776805, 4886.190440496657, 4886.633502487399, 4941.579965702956, 4995.750212489434, 4998.725325042091, 5009.448960614257, 5011.7494125294315, 5013.749312534432, 4851.80592776285, 4881.414230292387, 4887.486813884491, 4922.433920099091, 4941.851744447672], "value": 3644.8185821522943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.223925308303, 540.4298465119298, 555.4723013137518, 557.9888402231953, 601.4196300569951, 12502.56241031564, 13471.865281347184, 13496.325183740799, 13535.390907409166, 13557.7966330505, 11179.608713695023, 11437.885621143787, 12310.446029928653, 12525.37373131342, 12531.31077790721, 532.87477442801, 550.0127271547582, 551.242042191986, 551.5449753952985, 551.7572268201978, 540.8323419739874, 541.1179776963544, 541.3125330829844, 541.3287523470888, 541.4342012596845, 566.9886602267952, 568.7042737776354, 568.7128000359812, 569.3281927325754, 569.3765326966965, 565.2538648983343, 565.9037963546207, 566.0236092740012, 566.1366416215263, 568.0031544639173, 410.8808445550787, 411.52057852601683, 411.537020851542, 411.59252340183, 413.85928784213513, 10696.839547406795, 10722.946385268102, 10740.78518429627, 10752.946235268852, 10757.569697212102, 10609.893901061045, 10725.731856703567, 10865.891341086566, 11054.502547385306, 11493.195476316661, 9477.715668529956, 9691.466969316756, 9718.271129665303, 9776.266779991529, 10161.847572286422, 3293.2590167212425, 3302.190963214004, 3324.0858763839897, 3334.333133373311, 3437.2094418283937, 39056.414153787715, 54321.45678543243, 54417.72791136019, 67561.324386756, 68059.3194068058, 8989.325800564984, 9055.320850936074, 9226.30802689801, 9954.751131221778, 10176.39009827093, 15346.616334591501, 16213.189340533163, 16391.754123688155, 16435.6712865742, 16439.424620138238, 6870.7595234166565, 6933.341332573498, 7114.6442677866935, 7132.1441427029085, 7165.3551180394015, 3827.885163445101, 3834.194819087967, 3836.9040773980873, 3850.1914597934747, 3940.704447166474, 2792.274008757697, 2897.377063931223, 2905.5060639691305, 2913.533834586456, 2918.8978385756395, 476.1096749079175, 485.87367284506286, 489.2490027807299, 489.5838537243386, 498.7232086192126, 396.96824254059607, 429.85599824058664, 480.5458841394918, 501.9924701129486, 514.1721827857147, 7306.59813710251, 7430.4798664093, 7456.552606843498, 7693.4614576979075, 7804.0, 493.6815753838754, 495.0838864581146, 499.1514425476704, 526.1318823940529, 529.7430746088144, 3448.3965306071336, 3634.582023067328, 3642.453631955228, 3696.9445458318146, 3753.9061523462133, 81165.59417202995, 94088.0591194093, 94218.52890735502, 95573.0, 96094.0, 82277.17722822815, 83402.58298708589, 83776.58111709403, 85394.57302713447, 85544.0, 74745.25254747491, 75107.0, 75534.62232688801, 75846.62076689581, 76545.61727191329, 6986.371226589631, 7110.182329032227, 7366.263373662591, 7487.101547814079, 7500.287472690085, 42541.0, 44640.77679611581, 44667.55332446764, 45405.77297113493, 45955.77022114868, 58764.0, 59274.70362648159, 63293.36706632875, 65575.0, 65815.14050181667, 8345.624446899783, 8388.874166887623, 8436.493810371398, 8519.48883067018, 8584.356173287153, 9102.226310763659, 9118.133777291147, 9132.315076369432, 9182.494962777111, 9238.30712696537, 9200.723978280395, 9562.378445401027, 9602.95198524003, 9854.359466634645, 9930.702078937644, 9521.285903557122, 9546.0, 9629.903700962901, 9672.177864881563, 9942.403455792675, 9135.862962055442, 9457.952710236405, 9626.614935402786, 9846.212303015598, 9862.605495780088, 7361.30067643573, 7600.3539699126195, 7725.652345644347, 7847.332976697045, 8003.439759216799, 7681.308682218627, 7746.612669366396, 8060.274575288252, 8062.516249025077, 8111.1888811118415], "value": 5684.514529253033, "unit": "score"}], "name": "dromaeo_css", "value": 5903.522861207045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 115.0, 116.0, 116.0, 114.0, 115.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 122.0, 164.0, 127.0, 130.0, 123.0, 129.0, 160.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 165.0, 163.0, 163.0, 160.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 109.0, 78.0, 77.0, 77.0, 76.0, 102.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 129.0, 84.0, 85.0, 83.0, 112.0, 83.0, 83.0, 115.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 76.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 85.0, 91.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 135.0, 132.0, 134.0, 133.0, 134.0, 140.0, 182.0, 134.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 177.0, 175.0, 174.0, 174.0, 174.0, 174.0, 174.0, 180.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 70.0, 68.0, 68.0, 69.0, 68.0, 72.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1546.8999999999999, "alertThreshold": 2.0}]} 04:43:15 INFO - Return code: 0 04:43:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:15 INFO - # TBPL SUCCESS # 04:43:15 INFO - Running post-action listener: _resource_record_post_action 04:43:15 INFO - [mozharness: 2016-09-21 11:43:15.839094Z] Finished run-tests step (success) 04:43:15 INFO - Running post-run listener: _resource_record_post_run 04:43:15 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395509760; Read time: 16; Write time: 526224 04:43:15 INFO - TinderboxPrint: CPU usage
13.1% 04:43:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:43:15 INFO - TinderboxPrint: I/O write bytes / time
395,509,760 / 526,224 04:43:15 INFO - TinderboxPrint: CPU idle
8,347.2 (86.9%) 04:43:15 INFO - TinderboxPrint: CPU user
1,206.7 (12.6%) 04:43:15 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107442176; Read time: 0; Write time: 192500 04:43:15 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 288067584; Read time: 0; Write time: 333724 04:43:16 INFO - Running post-run listener: _upload_blobber_files 04:43:16 INFO - Blob upload gear active. 04:43:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:17 INFO - (blobuploader) - INFO - Done attempting. 04:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:24 INFO - (blobuploader) - INFO - Done attempting. 04:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:25 INFO - (blobuploader) - INFO - Done attempting. 04:43:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:25 INFO - Return code: 0 04:43:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07bb2685a295c3f6784a00413d2d55e5782e6c6b00ad167baac08af651a6d2ddd8b391a0195630d8dd74edae01dfe275401f13e6f46b81b5129e118567a6d719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1af589b4b68ad4f71c3ff43cb699166c5bb60768fd3608c864799eae2ad170c2aa8a3b5a6d530b2fc1a0bc81219d2ddb621f0f734cb3797f34ece4a1e4f5ed0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e32f83f42e38a33db5a2dec1f2f87459ac21469b3277170e6eb08db8687e96c2180d93c8d4451f51e89c324f4a345d92e77f158611bd070270795711219bb353"} 04:43:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:25 INFO - Contents: 04:43:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07bb2685a295c3f6784a00413d2d55e5782e6c6b00ad167baac08af651a6d2ddd8b391a0195630d8dd74edae01dfe275401f13e6f46b81b5129e118567a6d719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1af589b4b68ad4f71c3ff43cb699166c5bb60768fd3608c864799eae2ad170c2aa8a3b5a6d530b2fc1a0bc81219d2ddb621f0f734cb3797f34ece4a1e4f5ed0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e32f83f42e38a33db5a2dec1f2f87459ac21469b3277170e6eb08db8687e96c2180d93c8d4451f51e89c324f4a345d92e77f158611bd070270795711219bb353"} 04:43:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:25 INFO - Copying logs to upload dir... 04:43:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.258735 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-21 04:43:24.642450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 04:43:24.645592) ========= 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-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07bb2685a295c3f6784a00413d2d55e5782e6c6b00ad167baac08af651a6d2ddd8b391a0195630d8dd74edae01dfe275401f13e6f46b81b5129e118567a6d719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1af589b4b68ad4f71c3ff43cb699166c5bb60768fd3608c864799eae2ad170c2aa8a3b5a6d530b2fc1a0bc81219d2ddb621f0f734cb3797f34ece4a1e4f5ed0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e32f83f42e38a33db5a2dec1f2f87459ac21469b3277170e6eb08db8687e96c2180d93c8d4451f51e89c324f4a345d92e77f158611bd070270795711219bb353"} build_url:https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/JzJqo0vdQmeivdtmR3TjVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07bb2685a295c3f6784a00413d2d55e5782e6c6b00ad167baac08af651a6d2ddd8b391a0195630d8dd74edae01dfe275401f13e6f46b81b5129e118567a6d719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1af589b4b68ad4f71c3ff43cb699166c5bb60768fd3608c864799eae2ad170c2aa8a3b5a6d530b2fc1a0bc81219d2ddb621f0f734cb3797f34ece4a1e4f5ed0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e32f83f42e38a33db5a2dec1f2f87459ac21469b3277170e6eb08db8687e96c2180d93c8d4451f51e89c324f4a345d92e77f158611bd070270795711219bb353"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 04:43:24.675192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:43:24.675961) ========= 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-1474456952.151743-302707296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 04:43:24.757679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 04:43:24.758174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 04:43:24.758480) ========= ========= Total master_lag: 0.19 =========