builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1482817616.77 results: success (0) buildid: 20161226205936 builduid: defa6e964a894aa096dbd479828fbf6e revision: 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.768167) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.769108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.769746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.796601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.797061) ========= 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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-26 21:46:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-12-26 21:46:58 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.901682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.902018) ========= 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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.952035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:56.952397) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a --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 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a --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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-26 21:46:58,446 truncating revision to first 12 chars 2016-12-26 21:46:58,447 Setting DEBUG logging. 2016-12-26 21:46:58,447 attempt 1/10 2016-12-26 21:46:58,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a1f36ebd21c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-26 21:46:58,752 unpacking tar archive at: mozilla-central-4a1f36ebd21c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:57.564540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:57.566851) ========= script_repo_revision: 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:57.567360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:57.567680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 21:46:57.578332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-26 21:46:57.578712) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:46:59 INFO - MultiFileLogger online at 20161226 21:46:59 in /builds/slave/test 21:46:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 21:46:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:59 INFO - {'append_to_log': False, 21:46:59 INFO - 'base_work_dir': '/builds/slave/test', 21:46:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:46:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:59 INFO - 'branch': 'Firefox-Non-PGO', 21:46:59 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:59 INFO - 'config_files': ('talos/linux_config.py',), 21:46:59 INFO - 'default_actions': ('clobber', 21:46:59 INFO - 'read-buildbot-config', 21:46:59 INFO - 'download-and-extract', 21:46:59 INFO - 'populate-webroot', 21:46:59 INFO - 'create-virtualenv', 21:46:59 INFO - 'install', 21:46:59 INFO - 'run-tests'), 21:46:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:59 INFO - 'download_minidump_stackwalk': True, 21:46:59 INFO - 'download_symbols': 'ondemand', 21:46:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:59 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:59 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:59 INFO - 'installer_path': 'installer.exe', 21:46:59 INFO - 'log_level': 'info', 21:46:59 INFO - 'log_name': 'talos', 21:46:59 INFO - 'log_to_console': True, 21:46:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:46:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:46:59 INFO - 'opt_config_files': (), 21:46:59 INFO - 'pip_index': False, 21:46:59 INFO - 'sps_profile': False, 21:46:59 INFO - 'sps_profile_interval': 0, 21:46:59 INFO - 'suite': 'dromaeojs-e10s', 21:46:59 INFO - 'system_bits': '32', 21:46:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:59 INFO - 'title': 'talos-linux64-ix-010', 21:46:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:59 INFO - 'use_talos_json': True, 21:46:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:59 INFO - 'work_dir': 'build'} 21:46:59 INFO - [mozharness: 2016-12-27 05:46:59.172846Z] Running clobber step. 21:46:59 INFO - Running pre-action listener: _resource_record_pre_action 21:46:59 INFO - Running main action method: clobber 21:46:59 INFO - rmtree: /builds/slave/test/build 21:46:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:59 INFO - Running post-action listener: _resource_record_post_action 21:46:59 INFO - [mozharness: 2016-12-27 05:46:59.633078Z] Finished clobber step (success) 21:46:59 INFO - [mozharness: 2016-12-27 05:46:59.633182Z] Running read-buildbot-config step. 21:46:59 INFO - Running pre-action listener: _resource_record_pre_action 21:46:59 INFO - Running main action method: read_buildbot_config 21:46:59 INFO - Using buildbot properties: 21:46:59 INFO - { 21:46:59 INFO - "project": "", 21:46:59 INFO - "product": "firefox", 21:46:59 INFO - "script_repo_revision": "production", 21:46:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:46:59 INFO - "repository": "", 21:46:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:46:59 INFO - "buildid": "20161226205936", 21:46:59 INFO - "pgo_build": "False", 21:46:59 INFO - "basedir": "/builds/slave/test", 21:46:59 INFO - "buildnumber": 330, 21:46:59 INFO - "slavename": "talos-linux64-ix-010", 21:46:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:46:59 INFO - "platform": "ubuntu64_hw", 21:46:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:46:59 INFO - "branch": "mozilla-central", 21:46:59 INFO - "repo_path": "mozilla-central", 21:46:59 INFO - "revision": "4a1f36ebd21cbe090cd5d0ce6458af3d883a868a", 21:46:59 INFO - "stage_platform": "linux64", 21:46:59 INFO - "builduid": "defa6e964a894aa096dbd479828fbf6e", 21:46:59 INFO - "slavebuilddir": "test" 21:46:59 INFO - } 21:46:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:46:59 INFO - Running post-action listener: _resource_record_post_action 21:46:59 INFO - [mozharness: 2016-12-27 05:46:59.635692Z] Finished read-buildbot-config step (success) 21:46:59 INFO - [mozharness: 2016-12-27 05:46:59.635783Z] Running download-and-extract step. 21:46:59 INFO - Running pre-action listener: _resource_record_pre_action 21:46:59 INFO - Running main action method: download_and_extract 21:46:59 INFO - mkdir: /builds/slave/test/build/tests 21:46:59 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')]} 21:46:59 INFO - trying https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:46:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:47:00 INFO - Downloaded 1361 bytes. 21:47:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:47:00 INFO - Using the following test package requirements: 21:47:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:47:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:47:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'jsshell-linux-x86_64.zip'], 21:47:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:47:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:47:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:47:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:47:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:47:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:47:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:47:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:47:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:47:00 INFO - Expected file size: 20241340 21:47:00 INFO - Obtained file size: 20241340 21:47:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:47:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:47:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:47:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:47:05 INFO - Expected file size: 20241340 21:47:05 INFO - Obtained file size: 20241340 21:47:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:47:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:47:10 INFO - Expected file size: 14409776 21:47:10 INFO - Obtained file size: 14409776 21:47: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')]} 21:47:11 INFO - trying https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:47:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:47:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:47:12 INFO - Downloaded 55898912 bytes. 21:47:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:47:12 INFO - mkdir: /builds/slave/test/properties 21:47:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:12 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:12 INFO - Contents: 21:47:12 INFO - build_url:https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:47:13 INFO - Running post-action listener: _resource_record_post_action 21:47:13 INFO - Running post-action listener: set_extra_try_arguments 21:47:13 INFO - [mozharness: 2016-12-27 05:47:13.400368Z] Finished download-and-extract step (success) 21:47:13 INFO - [mozharness: 2016-12-27 05:47:13.400671Z] Running populate-webroot step. 21:47:13 INFO - Running pre-action listener: _resource_record_pre_action 21:47:13 INFO - Running main action method: populate_webroot 21:47:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:13 INFO - '--tppagecycles', 21:47:13 INFO - '7'], 21:47:13 INFO - 'tests': ['tsvgm']}}, 21:47:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:47:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:47:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['damp', 'tps']}, 21:47:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'tests': ['damp', 'tps']}, 21:47:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['dromaeo_dom']}, 21:47:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['basic_compositor_video']}, 21:47:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:47:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'other-e10s': {'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['a11yr', 21:47:13 INFO - 'ts_paint', 21:47:13 INFO - 'tpaint', 21:47:13 INFO - 'sessionrestore', 21:47:13 INFO - 'sessionrestore_no_auto_restore', 21:47:13 INFO - 'tabpaint']}, 21:47:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['tsvgx', 21:47:13 INFO - 'tsvgr_opacity', 21:47:13 INFO - 'tart', 21:47:13 INFO - 'tscrollx', 21:47:13 INFO - 'cart', 21:47:13 INFO - 'tsvg_static']}, 21:47:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:47:13 INFO - 'tsvgr_opacity', 21:47:13 INFO - 'tart', 21:47:13 INFO - 'tscrollx', 21:47:13 INFO - 'cart', 21:47:13 INFO - 'tsvg_static']}, 21:47:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'talos_options': ['--disable-e10s'], 21:47:13 INFO - 'tests': ['tp5o']}, 21:47:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:47:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'talos_options': ['--disable-e10s', 21:47:13 INFO - '--xperf_path', 21:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:13 INFO - 'tests': ['tp5n']}, 21:47:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:47:13 INFO - 'talos_options': ['--xperf_path', 21:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:13 INFO - 'tests': ['tp5n']}}, 21:47:13 INFO - 'talos.zip': {'path': '', 21:47:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:13 INFO - Running post-action listener: _resource_record_post_action 21:47:13 INFO - [mozharness: 2016-12-27 05:47:13.423271Z] Finished populate-webroot step (success) 21:47:13 INFO - [mozharness: 2016-12-27 05:47:13.423364Z] Running create-virtualenv step. 21:47:13 INFO - Running pre-action listener: _resource_record_pre_action 21:47:13 INFO - Running main action method: create_virtualenv 21:47:13 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:13 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 21:47:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:13 INFO - Using real prefix '/usr' 21:47:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:14 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:15 INFO - Installing pip.................done. 21:47:16 INFO - Return code: 0 21:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:47:16 INFO - Reading from file tmpfile_stdout 21:47:16 INFO - Output received: 21:47:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:47:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:47:16 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')]} 21:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:16 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')]} 21:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:16 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:16 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 21:47:16 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 21:47:16 INFO - Using env: {'DISPLAY': ':0', 21:47:16 INFO - 'HOME': '/home/cltbld', 21:47:16 INFO - 'LANG': 'en_US.UTF-8', 21:47:16 INFO - 'LANGUAGE': 'en_US:en', 21:47:16 INFO - 'LOGNAME': 'cltbld', 21:47:16 INFO - 'MAIL': '/var/mail/cltbld', 21:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:16 INFO - 'MOZ_NO_REMOTE': '1', 21:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:16 INFO - 'NO_EM_RESTART': '1', 21:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:16 INFO - 'PWD': '/builds/slave/test', 21:47:16 INFO - 'SHELL': '/bin/bash', 21:47:16 INFO - 'SHLVL': '1', 21:47:16 INFO - 'TERM': 'linux', 21:47:16 INFO - 'TMOUT': '86400', 21:47:16 INFO - 'USER': 'cltbld', 21:47:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:16 INFO - '_': '/tools/buildbot/bin/python'} 21:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:16 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 21:47:16 INFO - Cleaning up... 21:47:16 INFO - Return code: 0 21:47:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:47:16 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')]} 21:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:16 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')]} 21:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:16 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:16 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 21:47:16 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 21:47:16 INFO - Using env: {'DISPLAY': ':0', 21:47:16 INFO - 'HOME': '/home/cltbld', 21:47:16 INFO - 'LANG': 'en_US.UTF-8', 21:47:16 INFO - 'LANGUAGE': 'en_US:en', 21:47:16 INFO - 'LOGNAME': 'cltbld', 21:47:16 INFO - 'MAIL': '/var/mail/cltbld', 21:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:16 INFO - 'MOZ_NO_REMOTE': '1', 21:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:16 INFO - 'NO_EM_RESTART': '1', 21:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:16 INFO - 'PWD': '/builds/slave/test', 21:47:16 INFO - 'SHELL': '/bin/bash', 21:47:16 INFO - 'SHLVL': '1', 21:47:16 INFO - 'TERM': 'linux', 21:47:16 INFO - 'TMOUT': '86400', 21:47:16 INFO - 'USER': 'cltbld', 21:47:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:16 INFO - '_': '/tools/buildbot/bin/python'} 21:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:16 INFO - Downloading/unpacking psutil>=3.1.1 21:47:16 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 21:47:16 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 21:47:16 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 21:47:16 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 21:47:16 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 21:47:16 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 21:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:18 INFO - Installing collected packages: psutil 21:47:18 INFO - Running setup.py install for psutil 21:47:18 INFO - building 'psutil._psutil_linux' extension 21:47:18 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 21:47:19 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 21:47:19 INFO - building 'psutil._psutil_posix' extension 21:47:19 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 21:47:19 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 21:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:19 INFO - Successfully installed psutil 21:47:19 INFO - Cleaning up... 21:47:19 INFO - Return code: 0 21:47:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:47:19 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')]} 21:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:19 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')]} 21:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:19 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:19 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 21:47:19 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 21:47:19 INFO - Using env: {'DISPLAY': ':0', 21:47:19 INFO - 'HOME': '/home/cltbld', 21:47:19 INFO - 'LANG': 'en_US.UTF-8', 21:47:19 INFO - 'LANGUAGE': 'en_US:en', 21:47:19 INFO - 'LOGNAME': 'cltbld', 21:47:19 INFO - 'MAIL': '/var/mail/cltbld', 21:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:19 INFO - 'MOZ_NO_REMOTE': '1', 21:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:19 INFO - 'NO_EM_RESTART': '1', 21:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:19 INFO - 'PWD': '/builds/slave/test', 21:47:19 INFO - 'SHELL': '/bin/bash', 21:47:19 INFO - 'SHLVL': '1', 21:47:19 INFO - 'TERM': 'linux', 21:47:19 INFO - 'TMOUT': '86400', 21:47:19 INFO - 'USER': 'cltbld', 21:47:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:19 INFO - '_': '/tools/buildbot/bin/python'} 21:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:47:19 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 21:47:19 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 21:47:19 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 21:47:19 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 21:47:19 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 21:47:19 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 21:47:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:47:21 INFO - Installing collected packages: mozsystemmonitor 21:47:21 INFO - Running setup.py install for mozsystemmonitor 21:47:21 INFO - Successfully installed mozsystemmonitor 21:47:21 INFO - Cleaning up... 21:47:21 INFO - Return code: 0 21:47:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:47:21 INFO - Using env: {'DISPLAY': ':0', 21:47:21 INFO - 'HOME': '/home/cltbld', 21:47:21 INFO - 'LANG': 'en_US.UTF-8', 21:47:21 INFO - 'LANGUAGE': 'en_US:en', 21:47:21 INFO - 'LOGNAME': 'cltbld', 21:47:21 INFO - 'MAIL': '/var/mail/cltbld', 21:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:21 INFO - 'MOZ_NO_REMOTE': '1', 21:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:21 INFO - 'NO_EM_RESTART': '1', 21:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:21 INFO - 'PWD': '/builds/slave/test', 21:47:21 INFO - 'SHELL': '/bin/bash', 21:47:21 INFO - 'SHLVL': '1', 21:47:21 INFO - 'TERM': 'linux', 21:47:21 INFO - 'TMOUT': '86400', 21:47:21 INFO - 'USER': 'cltbld', 21:47:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:21 INFO - '_': '/tools/buildbot/bin/python'} 21:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:47:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:47:24 INFO - warning: no files found matching '*.txt' 21:47:24 INFO - no previously-included directories found matching 'build' 21:47:24 INFO - no previously-included directories found matching 'dist' 21:47:24 INFO - no previously-included directories found matching '.git*' 21:47:24 INFO - Installing collected packages: jsonschema, functools32 21:47:24 INFO - Running setup.py install for functools32 21:47:24 INFO - warning: no files found matching '*.txt' 21:47:24 INFO - no previously-included directories found matching 'build' 21:47:24 INFO - no previously-included directories found matching 'dist' 21:47:24 INFO - no previously-included directories found matching '.git*' 21:47:24 INFO - Successfully installed jsonschema functools32 21:47:24 INFO - Cleaning up... 21:47:24 INFO - Return code: 0 21:47:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:24 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 21:47:24 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 21:47:24 INFO - Using env: {'DISPLAY': ':0', 21:47:24 INFO - 'HOME': '/home/cltbld', 21:47:24 INFO - 'LANG': 'en_US.UTF-8', 21:47:24 INFO - 'LANGUAGE': 'en_US:en', 21:47:24 INFO - 'LOGNAME': 'cltbld', 21:47:24 INFO - 'MAIL': '/var/mail/cltbld', 21:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:24 INFO - 'MOZ_NO_REMOTE': '1', 21:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:24 INFO - 'NO_EM_RESTART': '1', 21:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:24 INFO - 'PWD': '/builds/slave/test', 21:47:24 INFO - 'SHELL': '/bin/bash', 21:47:24 INFO - 'SHLVL': '1', 21:47:24 INFO - 'TERM': 'linux', 21:47:24 INFO - 'TMOUT': '86400', 21:47:24 INFO - 'USER': 'cltbld', 21:47:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:24 INFO - '_': '/tools/buildbot/bin/python'} 21:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:47:24 INFO - Cleaning up... 21:47:24 INFO - Return code: 0 21:47:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:24 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 21:47:24 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 21:47:24 INFO - Using env: {'DISPLAY': ':0', 21:47:24 INFO - 'HOME': '/home/cltbld', 21:47:24 INFO - 'LANG': 'en_US.UTF-8', 21:47:24 INFO - 'LANGUAGE': 'en_US:en', 21:47:24 INFO - 'LOGNAME': 'cltbld', 21:47:24 INFO - 'MAIL': '/var/mail/cltbld', 21:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:24 INFO - 'MOZ_NO_REMOTE': '1', 21:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:24 INFO - 'NO_EM_RESTART': '1', 21:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:24 INFO - 'PWD': '/builds/slave/test', 21:47:24 INFO - 'SHELL': '/bin/bash', 21:47:24 INFO - 'SHLVL': '1', 21:47:24 INFO - 'TERM': 'linux', 21:47:24 INFO - 'TMOUT': '86400', 21:47:24 INFO - 'USER': 'cltbld', 21:47:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:24 INFO - '_': '/tools/buildbot/bin/python'} 21:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:24 INFO - Downloading/unpacking blobuploader==1.2.4 21:47:24 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 21:47:24 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 21:47:24 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 21:47:24 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 21:47:24 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 21:47:24 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 21:47:26 INFO - Downloading blobuploader-1.2.4.tar.gz 21:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:47:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:47:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:47:27 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 21:47:27 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 21:47:27 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 21:47:27 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 21:47:27 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 21:47:27 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 21:47:27 INFO - Downloading docopt-0.6.1.tar.gz 21:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:27 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:27 INFO - Running setup.py install for blobuploader 21:47:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:47:27 INFO - Running setup.py install for requests 21:47:28 INFO - Running setup.py install for docopt 21:47:28 INFO - Successfully installed blobuploader requests docopt 21:47:28 INFO - Cleaning up... 21:47:28 INFO - Return code: 0 21:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:28 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 21:47:28 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 21:47:28 INFO - Using env: {'DISPLAY': ':0', 21:47:28 INFO - 'HOME': '/home/cltbld', 21:47:28 INFO - 'LANG': 'en_US.UTF-8', 21:47:28 INFO - 'LANGUAGE': 'en_US:en', 21:47:28 INFO - 'LOGNAME': 'cltbld', 21:47:28 INFO - 'MAIL': '/var/mail/cltbld', 21:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:28 INFO - 'MOZ_NO_REMOTE': '1', 21:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:28 INFO - 'NO_EM_RESTART': '1', 21:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:28 INFO - 'PWD': '/builds/slave/test', 21:47:28 INFO - 'SHELL': '/bin/bash', 21:47:28 INFO - 'SHLVL': '1', 21:47:28 INFO - 'TERM': 'linux', 21:47:28 INFO - 'TMOUT': '86400', 21:47:28 INFO - 'USER': 'cltbld', 21:47:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:28 INFO - '_': '/tools/buildbot/bin/python'} 21:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:28 INFO - Running setup.py (path:/tmp/pip-kGErI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:28 INFO - Running setup.py (path:/tmp/pip-4ISBLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:28 INFO - Running setup.py (path:/tmp/pip-HpeQlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:28 INFO - Running setup.py (path:/tmp/pip-6dqSne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:28 INFO - Running setup.py (path:/tmp/pip-tAdR5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:28 INFO - Running setup.py (path:/tmp/pip-LA7Eak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:28 INFO - Running setup.py (path:/tmp/pip-L1Kgs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:29 INFO - Running setup.py (path:/tmp/pip-t4W5Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:29 INFO - Running setup.py (path:/tmp/pip-OKt079-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:29 INFO - Running setup.py (path:/tmp/pip-7zepVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:29 INFO - Running setup.py (path:/tmp/pip-jDKqZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:29 INFO - Running setup.py (path:/tmp/pip-_qGWLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:29 INFO - Running setup.py (path:/tmp/pip-3sDpHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:29 INFO - Running setup.py (path:/tmp/pip-bw00dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:29 INFO - Running setup.py (path:/tmp/pip-bvY14U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:29 INFO - Running setup.py (path:/tmp/pip-Trzwu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:29 INFO - Running setup.py (path:/tmp/pip-WCCFL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:29 INFO - Running setup.py install for manifestparser 21:47:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:47:29 INFO - Running setup.py install for mozcrash 21:47:29 INFO - Running setup.py install for mozdebug 21:47:30 INFO - Running setup.py install for mozdevice 21:47:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for mozfile 21:47:30 INFO - Running setup.py install for mozhttpd 21:47:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for mozinfo 21:47:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for mozInstall 21:47:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for mozleak 21:47:30 INFO - Running setup.py install for mozlog 21:47:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for moznetwork 21:47:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:47:30 INFO - Running setup.py install for mozprocess 21:47:30 INFO - Running setup.py install for mozprofile 21:47:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Running setup.py install for mozrunner 21:47:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Running setup.py install for mozscreenshot 21:47:31 INFO - Running setup.py install for moztest 21:47:31 INFO - Running setup.py install for mozversion 21:47:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:31 INFO - Cleaning up... 21:47:31 INFO - Return code: 0 21:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:31 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:31 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 21:47:31 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 21:47:31 INFO - Using env: {'DISPLAY': ':0', 21:47:31 INFO - 'HOME': '/home/cltbld', 21:47:31 INFO - 'LANG': 'en_US.UTF-8', 21:47:31 INFO - 'LANGUAGE': 'en_US:en', 21:47:31 INFO - 'LOGNAME': 'cltbld', 21:47:31 INFO - 'MAIL': '/var/mail/cltbld', 21:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:31 INFO - 'MOZ_NO_REMOTE': '1', 21:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:31 INFO - 'NO_EM_RESTART': '1', 21:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:31 INFO - 'PWD': '/builds/slave/test', 21:47:31 INFO - 'SHELL': '/bin/bash', 21:47:31 INFO - 'SHLVL': '1', 21:47:31 INFO - 'TERM': 'linux', 21:47:31 INFO - 'TMOUT': '86400', 21:47:31 INFO - 'USER': 'cltbld', 21:47:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:31 INFO - '_': '/tools/buildbot/bin/python'} 21:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:31 INFO - Running setup.py (path:/tmp/pip-9P6fIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:31 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)) 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:31 INFO - Running setup.py (path:/tmp/pip-mOgHwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:31 INFO - Running setup.py (path:/tmp/pip-g1gWVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:31 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)) 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:31 INFO - Running setup.py (path:/tmp/pip-Nd4QwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:32 INFO - Running setup.py (path:/tmp/pip-a41gTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:32 INFO - Running setup.py (path:/tmp/pip-OZr50m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:32 INFO - Running setup.py (path:/tmp/pip-MNLrfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:32 INFO - Running setup.py (path:/tmp/pip-Bz7SaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:32 INFO - Running setup.py (path:/tmp/pip-vLuuZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:32 INFO - Running setup.py (path:/tmp/pip-xyqzjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:32 INFO - Running setup.py (path:/tmp/pip-0VP7Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:32 INFO - Running setup.py (path:/tmp/pip-m1oeHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:32 INFO - Running setup.py (path:/tmp/pip-2PL7xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:32 INFO - Running setup.py (path:/tmp/pip-YFsWbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:32 INFO - Running setup.py (path:/tmp/pip-Mequ8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:32 INFO - Running setup.py (path:/tmp/pip-SqeevA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:32 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)) 21:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:32 INFO - Running setup.py (path:/tmp/pip-8QbUkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:33 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)) 21:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:33 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)) 21:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:47:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:34 INFO - Downloading blessings-1.6.tar.gz 21:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:35 INFO - Installing collected packages: blessings 21:47:35 INFO - Running setup.py install for blessings 21:47:35 INFO - Successfully installed blessings 21:47:35 INFO - Cleaning up... 21:47:35 INFO - Return code: 0 21:47:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:35 INFO - Reading from file tmpfile_stdout 21:47:35 INFO - Current package versions: 21:47:35 INFO - argparse == 1.2.1 21:47:35 INFO - blessings == 1.6 21:47:35 INFO - blobuploader == 1.2.4 21:47:35 INFO - docopt == 0.6.1 21:47:35 INFO - functools32 == 3.2.3-2 21:47:35 INFO - jsonschema == 2.5.1 21:47:35 INFO - manifestparser == 1.1 21:47:35 INFO - mozInstall == 1.12 21:47:35 INFO - mozcrash == 1.0 21:47:35 INFO - mozdebug == 0.1 21:47:35 INFO - mozdevice == 0.49 21:47:35 INFO - mozfile == 1.2 21:47:35 INFO - mozhttpd == 0.7 21:47:35 INFO - mozinfo == 0.9 21:47:35 INFO - mozleak == 0.1 21:47:35 INFO - mozlog == 3.4 21:47:35 INFO - moznetwork == 0.27 21:47:35 INFO - mozprocess == 0.23 21:47:35 INFO - mozprofile == 0.28 21:47:35 INFO - mozrunner == 6.13 21:47:35 INFO - mozscreenshot == 0.1 21:47:35 INFO - mozsystemmonitor == 0.3 21:47:35 INFO - moztest == 0.7 21:47:35 INFO - mozversion == 1.4 21:47:35 INFO - psutil == 3.1.1 21:47:35 INFO - requests == 1.2.3 21:47:35 INFO - wsgiref == 0.1.2 21:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:35 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')]} 21:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:35 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')]} 21:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:35 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:35 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 21:47:35 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 21:47:35 INFO - Using env: {'DISPLAY': ':0', 21:47:35 INFO - 'HOME': '/home/cltbld', 21:47:35 INFO - 'LANG': 'en_US.UTF-8', 21:47:35 INFO - 'LANGUAGE': 'en_US:en', 21:47:35 INFO - 'LOGNAME': 'cltbld', 21:47:35 INFO - 'MAIL': '/var/mail/cltbld', 21:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:35 INFO - 'MOZ_NO_REMOTE': '1', 21:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:35 INFO - 'NO_EM_RESTART': '1', 21:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:35 INFO - 'PWD': '/builds/slave/test', 21:47:35 INFO - 'SHELL': '/bin/bash', 21:47:35 INFO - 'SHLVL': '1', 21:47:35 INFO - 'TERM': 'linux', 21:47:35 INFO - 'TMOUT': '86400', 21:47:35 INFO - 'USER': 'cltbld', 21:47:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:35 INFO - '_': '/tools/buildbot/bin/python'} 21:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 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)) 21:47:35 INFO - Cleaning up... 21:47:35 INFO - Return code: 0 21:47:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47:35 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')]} 21:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:35 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')]} 21:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:35 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b85480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, '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-1482793424.924131-1040311593', '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 21:47:35 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 21:47:35 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 21:47:35 INFO - Using env: {'DISPLAY': ':0', 21:47:35 INFO - 'HOME': '/home/cltbld', 21:47:35 INFO - 'LANG': 'en_US.UTF-8', 21:47:35 INFO - 'LANGUAGE': 'en_US:en', 21:47:35 INFO - 'LOGNAME': 'cltbld', 21:47:35 INFO - 'MAIL': '/var/mail/cltbld', 21:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:35 INFO - 'MOZ_NO_REMOTE': '1', 21:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:35 INFO - 'NO_EM_RESTART': '1', 21:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:35 INFO - 'PWD': '/builds/slave/test', 21:47:35 INFO - 'SHELL': '/bin/bash', 21:47:35 INFO - 'SHLVL': '1', 21:47:35 INFO - 'TERM': 'linux', 21:47:35 INFO - 'TMOUT': '86400', 21:47:35 INFO - 'USER': 'cltbld', 21:47:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:35 INFO - '_': '/tools/buildbot/bin/python'} 21:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:47:35 INFO - Cleaning up... 21:47:35 INFO - Return code: 0 21:47:35 INFO - Running post-action listener: _resource_record_post_action 21:47:35 INFO - Running post-action listener: _start_resource_monitoring 21:47:35 INFO - Starting resource monitoring. 21:47:35 INFO - [mozharness: 2016-12-27 05:47:35.974630Z] Finished create-virtualenv step (success) 21:47:35 INFO - [mozharness: 2016-12-27 05:47:35.975160Z] Running install step. 21:47:35 INFO - Running pre-action listener: _resource_record_pre_action 21:47:35 INFO - Running main action method: install 21:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:36 INFO - Reading from file tmpfile_stdout 21:47:36 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:36 INFO - Reading from file tmpfile_stdout 21:47:36 INFO - Output received: 21:47:36 INFO - Usage: mozinstall [options] installer 21:47:36 INFO - Options: 21:47:36 INFO - -h, --help show this help message and exit 21:47:36 INFO - -d DEST, --destination=DEST 21:47:36 INFO - Directory to install application into. [default: 21:47:36 INFO - "/builds/slave/test"] 21:47:36 INFO - --app=APP Application being installed. [default: firefox] 21:47:36 INFO - mkdir: /builds/slave/test/build/application 21:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:47:52 INFO - Reading from file tmpfile_stdout 21:47:52 INFO - Output received: 21:47:52 INFO - /builds/slave/test/build/application/firefox/firefox 21:47:52 INFO - Running post-action listener: _resource_record_post_action 21:47:52 INFO - [mozharness: 2016-12-27 05:47:52.359535Z] Finished install step (success) 21:47:52 INFO - [mozharness: 2016-12-27 05:47:52.359783Z] Running run-tests step. 21:47:52 INFO - Running pre-action listener: _resource_record_pre_action 21:47:52 INFO - Running main action method: run_tests 21:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:52 INFO - Python 2.7.3 21:47:52 INFO - Return code: 0 21:47:52 INFO - grabbing minidump binary from tooltool 21:47: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')]} 21:47:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b82820>, '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 0x1b83520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b839b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:47:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:47:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:47:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:52 INFO - Return code: 0 21:47:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:47:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:47:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:52 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:47:52 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:47:52 INFO - Using env: {'DISPLAY': ':0', 21:47:52 INFO - 'HOME': '/home/cltbld', 21:47:52 INFO - 'LANG': 'en_US.UTF-8', 21:47:52 INFO - 'LANGUAGE': 'en_US:en', 21:47:52 INFO - 'LOGNAME': 'cltbld', 21:47:52 INFO - 'MAIL': '/var/mail/cltbld', 21:47:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:52 INFO - 'MOZ_NO_REMOTE': '1', 21:47:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:52 INFO - 'NO_EM_RESTART': '1', 21:47:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:52 INFO - 'PWD': '/builds/slave/test', 21:47:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:52 INFO - 'SHELL': '/bin/bash', 21:47:52 INFO - 'SHLVL': '1', 21:47:52 INFO - 'TERM': 'linux', 21:47:52 INFO - 'TMOUT': '86400', 21:47:52 INFO - 'USER': 'cltbld', 21:47:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1482793424.924131-1040311593', 21:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:52 INFO - '_': '/tools/buildbot/bin/python'} 21:47:52 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:47:52 INFO - mozversion application_buildid: 20161226205936 21:47:52 INFO - mozversion application_changeset: 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a 21:47:52 INFO - mozversion application_display_name: Nightly 21:47:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:52 INFO - mozversion application_name: Firefox 21:47:52 INFO - mozversion application_remotingname: firefox 21:47:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:47:52 INFO - mozversion application_vendor: Mozilla 21:47:52 INFO - mozversion application_version: 53.0a1 21:47:52 INFO - mozversion platform_buildid: 20161226205936 21:47:52 INFO - mozversion platform_changeset: 4a1f36ebd21cbe090cd5d0ce6458af3d883a868a 21:47:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:47:52 INFO - mozversion platform_version: 53.0a1 21:47:52 INFO - using testdate: 1482817672 21:47:52 INFO - actual date: 1482817672 21:47:52 INFO - starting webserver on 'localhost:49509' 21:47:52 INFO - SUITE-START | Running 2 tests 21:47:52 INFO - TEST-START | dromaeo_css 21:47:52 INFO - operating with platform_type : linux_ 21:47:52 INFO - Initialising browser for dromaeo_css test... 21:47:52 INFO - TEST-INFO | started process 8585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hoN98/profile http://localhost:49509/getInfo.html) 21:47:53 INFO - PROCESS | 8585 | 1482817673173 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 21:47:57 INFO - PROCESS | 8585 | __metrics Screen width/height:1600/1200 21:47:57 INFO - PROCESS | 8585 | colorDepth:24 21:47:57 INFO - PROCESS | 8585 | Browser inner width/height: 1024/697 21:47:57 INFO - PROCESS | 8585 | __metrics 21:47:58 ERROR - PROCESS | 8585 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 21:47:59 INFO - TEST-INFO | 8585: exit 0 21:47:59 INFO - Browser initialized. 21:47:59 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:59 INFO - TEST-INFO | started process 8706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hoN98/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:11 INFO - PROCESS | 8706 | RSS: Main: 158109696 21:48:11 INFO - PROCESS | 8706 | 21:51:15 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49509/tests/dromaeo/cssquery-ext.html) 21:51:16 INFO - PROCESS | 8706 | RSS: Main: 164888576 21:51:16 INFO - PROCESS | 8706 | 21:52:59 INFO - PROCESS | 8706 | ************************* 21:52:59 INFO - PROCESS | 8706 | A coding exception was thrown and uncaught in a Task. 21:52:59 INFO - PROCESS | 8706 | 21:52:59 INFO - PROCESS | 8706 | Full message: ReferenceError: fetch is not defined 21:52:59 INFO - PROCESS | 8706 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 21:52:59 INFO - PROCESS | 8706 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 21:52:59 INFO - PROCESS | 8706 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 21:52:59 INFO - PROCESS | 8706 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 21:52:59 INFO - PROCESS | 8706 | TaskImpl@resource://gre/modules/Task.jsm:277:3 21:52:59 INFO - PROCESS | 8706 | asyncFunction@resource://gre/modules/Task.jsm:252:14 21:52:59 INFO - PROCESS | 8706 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 21:52:59 INFO - PROCESS | 8706 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 21:52:59 INFO - PROCESS | 8706 | TaskImpl@resource://gre/modules/Task.jsm:277:3 21:52:59 INFO - PROCESS | 8706 | asyncFunction@resource://gre/modules/Task.jsm:252:14 21:52:59 INFO - PROCESS | 8706 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 21:52:59 INFO - PROCESS | 8706 | 21:52:59 INFO - PROCESS | 8706 | ************************* 21:54:19 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-ext.html (next: http://localhost:49509/tests/dromaeo/cssquery-jquery.html) 21:54:19 INFO - PROCESS | 8706 | RSS: Main: 162869248 21:54:19 INFO - PROCESS | 8706 | 21:57:22 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49509/tests/dromaeo/cssquery-mootools.html) 21:57:22 INFO - PROCESS | 8706 | RSS: Main: 167882752 21:57:22 INFO - PROCESS | 8706 | 22:00:24 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49509/tests/dromaeo/cssquery-prototype.html) 22:00:25 INFO - PROCESS | 8706 | RSS: Main: 163102720 22:00:25 INFO - PROCESS | 8706 | 22:03:28 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49509/tests/dromaeo/cssquery-yui.html) 22:03:29 INFO - PROCESS | 8706 | RSS: Main: 166305792 22:03:29 INFO - PROCESS | 8706 | 22:06:31 INFO - PROCESS | 8706 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-yui.html (next: http://localhost:49509/tests/dromaeo/cssquery-dojo.html) 22:06:32 INFO - PROCESS | 8706 | RSS: Main: 166809600 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | __start_tp_report 22:06:32 INFO - PROCESS | 8706 | _x_x_mozilla_page_load 22:06:32 INFO - PROCESS | 8706 | _x_x_mozilla_page_load_details 22:06:32 INFO - PROCESS | 8706 | |i|pagename|runs| 22:06:32 INFO - PROCESS | 8706 | |0;dojo.html;2590.8963641454343;2592.4167062410947;2596.5456045192086;2619.3320703220675;2626.3434141464636;4749.857504274869;4788.329633851259;4804.783784729687;4813.855584332471;4836.540528649773;4753.191957367248;4777.856664300077;4779.665423420353;4783.043391321732;4785.258284965836;4368.082702632443;4432.689711720165;4461.7322960622305;4487.439070116236;4532.5240849710635;4404.053128577355;4434.667399945001;4451.1542806866755;4481.5070342262325;4506.121306345264;4289.270823959934;4319.935200971988;4322.438083049184;4417.779111044435;4449.26587113126;4327.956720432787;4343.761093139876;4345.978270108661;4355.760433176174;4361.389405483234;4325.394444777734;4332.28517294646;4332.4801023877335;4333.848315308949;4336.522982471925;4648.140094082605;4679.110968915895;4683.976580117078;4686.507916668769;4690.390249267608;4976.576990955737;5033.521815427529;5035.446100928895;5043.52086551777;5051.595872330205;5102.489751024905;5132.615053870974;5140.02339555487;5140.768665410028;5147.356580427447;4789.161896668139;4805.37530121089;4806.303086052503;4813.205821039559;4826.348442960156;5204.401493828258;5235.60732945023;5244.501772331699;5247.790088396498;5309.7345132743985;4953.23224900141;5037.0681423936685;5043.445221025684;5051.520105589963;5055.51972562606;5018.247262910592;5072.087024335581;5087.720175390389;5119.692818430832;5144.279800827887;4999.325091112653;5024.924626130611;5082.974585127125;5090.49095090488;5094.719790411489;5087.618428617869;5094.643374963717;5097.46476619957;5100.056489549445;5138.743062846843;4332.523422423531;4375.299952007664;4407.140607581555;4416.3596278539435;4450.666200035011;3800.3349413852466;3816.217675376541;3842.769433833979;3862.663088831273;3865.690744740414;4444.266695995189;4448.888777780581;4448.933266001012;4453.0648563801315;4457.643388528974;5149.073166830007;5154;5154.5360917516855;5179;5186.974065129651;4356.912861742748;4434.933475997863;4435.35687325336;4444.977775111169;4448.421705178306;4614.169449499055;4620.029793743352;4627.537246275346;4628.305754136839;4636.420447444069;4633.374494443275;4708.858734237979;4755.429348478205;4795.95204047955;4807.038592281628;5142.742862856917;5145.819896303611;5147.073526765218;5150.845474635767;5164.32863727713;4753.358296629911;4758.16732071893;4758.262469317261;4759.595434388116;4811.9518804811505;4954.232094025432;4989.725565093955;5022.74886255693;5054.21659642756;5058.974705126451;5138.434772174983;5152.046871328666;5154.948450515597;5163.509466600667;5184.507471790174;5011.248312753116;5018.347614810052;5018.7741551631;5030.949690503048;5067.214581739836;4894.216925291937;4911.877203069952;4924.089043526816;4930.063287975273;5002.024605202097;4902.264660300983;4906.705597664151;4906.95093049065;4908.509149085063;4924.015196960694;5005.499450055111;5018.473060328759;5025;5025.84922452327;5055.646104772631;4855;4861.513848615252;4895.510448955076;4911.484294149206;4936.629752768628 22:06:32 INFO - PROCESS | 8706 | |1;ext.html;492.9063477939191;506.1976766824583;511.6827566908517;514.8455463360991;527.2407732864677;37951.24097518048;40384.1923161537;40627.79686101569;40640;40727;40786.38820417689;41266.793666031626;41422.37866432006;41438.79280603601;41488.79255603718;7571.507851989617;7727.884081738778;7752.418568607349;9709.61161553537;10061.597536098547;9364.157225849673;9371.859422108673;9421.48181849998;9465.195458386012;9490.66782662607;9474.052594740506;9553.187979021792;9556.283278754086;9559.713208603753;9571.042895710443;9483.762905927339;9512.524373781283;9534.856977145348;9541.236701063934;9547.61809527618;9643.566039528238;9671;9689.70930872075;9700.951495242478;9709;34906.82546587276;35143.4728479073;35238.823805880806;35245.295094098234;35256.471152932725;3397.59228892532;3411.7441191910707;3429.639887811794;3437.2094418283687;3452.361313157074;25164.622530662054;25672.614910776352;26006.08978685737;26466.60300095481;26559.73440265592;3206.1824234820206;3290.9835450822834;3297.9175520612175;3301.636819949804;3338.7829791063746;263160;266833;267536;360170;361508;46602.766986164854;47560.5243947563;47581.524184758404;47630.761846190544;47787.522124778305;51258.23112653313;51477.7426112867;51541.742291288305;51569.48430515647;51688.48311516837;11353.772924541463;11411.828822567668;11527.365994870363;11600.129990250765;11607;8325.167483251626;8355.122712115262;8455.915440845636;8631.568421578895;8677.219050285505;16066.437674681563;16254.51236462908;16313.492599091252;16326.75509867353;16423.343066277215;6185.443310102112;6367.4906007519285;6428.839279018062;6473.158489396348;6544;718.8202949262684;733.8899165125167;734.5042096584784;737.2627372627372;739.268124556685;26843.19470415891;27822;27941.161765147077;28026.719732802412;28541.429171416454;938.2915898496591;961.438391127015;981.5779214937645;983.9409635421755;1042.598599539183;14905.180215088058;15128;15156.621084472976;15302.234888255543;15352.539423817303;360247;363312;364404;364483;365377;50207;50655.24017139746;50824.491755082716;50829.74585127125;50847.7457612717;1120.8486854274568;1176.7293522489874;1180.86420061694;1184.7689700508317;1189.4766302826729;25196.874015629804;26473.60289595619;27246.863765681046;27678.169654910384;27693;41601;42971.14057718765;43122.353164703185;43126;43262.134757305306;297416;298745;299734;300023;300044;22116.00477978527;22808.885955570116;24302.635460467754;24633;25040.49919001646;40248.798756006036;40470;40743.388849166695;40948;42064.78967605143;34772.82613586916;34980.125496861765;35284.47073293954;35343.469847952816;35650.643493564734;34931.12672183216;35037.299254015285;35314.64685353216;35331.82334088313;35396.29207415889;33719.49420758642;33771.66228337685;34266.82866585651;34332.485012724326;34482.310353793284;30090.398192036475;31648.525272120474;31729.365412691157;31796.36407271888;31886.52170217495;23854.642180366962;24137.828369540293;24328.391790204678;24332.51334973255;24337.634935475628 22:06:32 INFO - PROCESS | 8706 | |2;jquery.html;373.17342087276677;382.2584186677845;386.924549712806;390.2818813383374;400.7755656832174;15985.280662370193;16032.198390080508;16227.513174604766;16306.021638701686;16366;15663.216839158053;15920.442784502517;16415.343386264536;16671.249793759278;16685.83314166858;5030.320906677606;5153.330067091273;5190.221466779975;5256.159014557672;5258.92111618326;5082.16144336186;5143.4599367066485;5354.14333706607;5402.864928376803;5454;5407.270018547485;5414.160805075219;5416.83749487516;5419.105847535152;5431.266778984846;5356.91964620531;5366.545767013369;5442.755076021588;5459.727013649302;5479.1781232815;5227.45111763267;5266.631335806495;5276.7889284428575;5303.840884773463;5305.124654432053;12246.632601021984;18072.734908556406;18116.456506304832;20288.695669564968;20373;1945.1830231302886;2128.7658357580654;2146.7745886681987;2156.795104465073;2188.8248940084754;8160;8487.363447741382;8606.225439710455;8691.565421728888;8871.822563548758;1569.3957826236867;1620.894641848276;1628.584710898725;1646.662434200998;1651.4962936304423;63138.68430657863;63806;64289.67855160741;66018;66308;9832.606695732233;9964.601415943425;10034.448105354275;10225.181985441146;10255.435951022766;13811.309434528233;13850.238236897067;13892.791608125886;13912.095713778774;13940.442382304595;6146.477549408351;6404.455621272151;6549.541532092708;6564.770233041821;6572.4084832365315;5697.601167918288;5730.885382292414;5884.9705751470965;5925.703714814242;5927.8221653350465;3991.381335892941;4022.959770402317;4360.258756011485;4430.689851710414;4469.240229161051;1517.1579773225965;1633.4038076102374;1839.9356022539414;1905.676035074013;1915.0233380975803;795.9761207163795;830.9542975136426;838.8867502887155;842.4103127810557;856.3919617071949;15862.44481443144;16055.357785688442;16146.919265403832;16552.33790648385;16582.50252492427;827.3587969323822;839.9496030238205;841.6296829395046;842.5323945210467;859.5788063848669;9114.40756350835;9131.589078491485;9311.483930293802;9325.533723313807;9579.227842849095;334519;339807;340437;343398;347917;67266.66366668136;70635.6468217666;70944.2905570948;71477;72500;932.3753085432776;957.4973139102027;958.2717134977606;974.2546951582045;976.2141476111798;15210.847891521385;15248.695026099638;15333.76999345033;15643.139627320606;16003.199840008187;29163.854180728962;29482.705172948856;35502.28995420129;35924.4611330825;37456.2508749818;49118.75440622774;49959.25061124013;50398;50775.98448031092;51001.744991274805;7356.521826081287;7410.444216683878;7455.888161677471;7643.7324693635455;7925.365970722213;10919.890801092206;11032.613858514913;11134.33194008362;11459.484323205643;11566.710832229262;9027.277817774693;9415.387999780267;9675.419474831533;9799.804003920024;10521.316114452537;9353.85969210476;9962.501874906371;10137.543810528692;10309.793804123725;10500.579976800842;10141.847872281774;10219.437930913573;10298.897011030094;10494.580216791548;10767.892321077003;6651.43462805667;6814.1482314710665;6820.215675197416;7126.037984871976;7543.585102819397;7891.605419728876;9573.569189386355;9700.708978730649;9770.658026969022;9943.154831839374 22:06:32 INFO - PROCESS | 8706 | |3;mootools.html;1319.2480286236846;1325.3704490367077;1341.1550723044486;1342.8388593368798;1347.8449978252497;6373.0759039939185;6555.115059466971;7055.2239253682055;7540.849183016337;7571.356434703057;7048.823779405518;7268.0914885639295;7302.3427891489755;7453.068366454193;7487.625618719069;2146.35609317205;2194.0346247651064;2194.3855720398233;2199.7250343707037;2200.801927826495;2152.3865698275995;2155.2133471282946;2180.4003898927845;2183.257692384589;2207.194374053467;2207.9889600551974;2241.9350808366057;2249.6962910007187;2250.3586477853814;2250.4148921280503;2107.041296210228;2117.184883819725;2119.3006307918504;2119.8834064126468;2120.766715661276;2070.9171633134806;2182.1380554680973;2186.8578542394694;2204.7354317481845;2211.9447013824624;7364.3003914628025;7547.16981132075;7547.698092076311;7553.433492488085;7564.848703025908;4334.219840428722;4438.334249862514;4473.2842745160615;4475.48531918827;4476.836022634106;3018.886779254509;3039.2553824312963;3116.1430606583144;3118.485449900764;3205.086550333144;1161.0943464098018;1168.6902970712683;1178.5757127434117;1186.5135294529289;1210.1408000319784;9508.809823803555;9591.904080959172;9614.567344469515;9643.855342169873;9644.807103857953;3835.386338185877;4012.8194231259663;4016.7188296819527;4102.138550904344;4113.4446849675505;7772.533647981026;7775.066991961001;7794.454388192772;7826.295633393022;7856.135825059239;4402.449693788277;4407.074514351958;4413.271810151289;4414.55854414556;4415.6909016368545;3886.591907849692;4021.8391264349684;4079.73481723687;4092.877213683594;4094.733842300241;3272.476403775432;3311.172206948263;3359.2441700617164;3383.678550537695;3403.3363494118903;835.3108685334623;883.88067610873;1057.1331508163232;1059.5602824827765;1063.803196408667;796.38678217772;817.2277198047788;817.2399668308531;829.088003196479;829.713748756678;4741.288806679026;4909.337239472626;4961.975190124026;4971.651984361132;5059.266406371055;835.2399316621845;836.197250639393;836.6486075848159;869.6477926439802;883.2404132446092;3159.4202898550725;3287.227501537137;3322.0864262328055;3322.1396018229384;3344.4314466540745;8535.530545819915;8741.475511469333;8839.116088391109;8869.246114080246;8949.418287811272;8760.780980475412;8806.955965220133;8817.16236957488;8823.955880220557;8848.46909185451;6725.159355080615;6827.726890924308;6932.6533673316135;6941.236463988957;7001.509894307452;4615;4790.568848803624;4816.566509014206;4841.443234028132;4982;8140;8147.348212142896;8167.79580510492;8186.426950113435;8199.95900020496;8170.182981701782;8190.467619604707;8320.708775193081;8340.374471914509;8379.539125348165;5940.405959404025;5957.136215248851;5965.045592705146;5975.312839023568;6026.7287972040485;6951.7914462566205;6954.965225173842;7049.647517623996;7059.929400705927;7064.823379415556;6153.4769544587425;6213;6221.9377806223165;6326.841828954129;6334.303226645157;6124.693765311806;6173.907391389043;6203.410675985774;6204.72078756448;6223.844403889939;5666.291713535808;5775.1914731938405;5776.480116789509;5779.450952159538;5780.104083867007;4399.802008909543;4463.977680111579;4470.888227794331;4563.155816174019;4581;4409.85343810618;4431.578999994996;4431.778411079368;4472.262076757429;4538.115067561926 22:06:32 INFO - PROCESS | 8706 | |4;prototype.html;356.92682999985004;367.08229426433917;367.874922526341;369.56391458079474;371.48363774353635;4907.337509436225;4923.138450771115;4935.481774413689;5033.245013248014;5035.748212589365;4929.623208102453;4930.654854160211;4938.530839570235;4948.802047918079;4956.727379994108;3516.5428494295707;3741;3859.81920215079;3954.307996100685;3959.46547216125;3952.6837852971835;3954.861579844706;3958.703097267702;3966.305896468121;3973.940390894139;3937.0944682722848;3975.284448799215;3975.3241948868763;3998.4002399639994;4010.0551232652288;3886.708496862718;3944.822482988258;3971.98014009931;3975.403689446577;3981.28336899358;3566.1084728817796;3566.3045706087064;3574.231540218839;3587.1390866191928;3608.621094785036;4754.572088512051;4804.519548045202;4806.7836947337455;4852.369192005052;4861.927071093936;4496.402877697828;4515.0359593576895;4520.615747661453;4540.591346778806;4549.977250113761;4995.652912548601;5169.483051694838;5172.6379153459275;5175.223716442526;5220.895582088337;3889.7666140031406;3890.8638197662945;3891.4746509221177;3897.7856217908;3915.882523524299;5167.586593072583;5382.170062178878;5385.461453854622;5399.136138217867;5400.83797486076;3692;3715.9256814864093;3718.8140592970244;3721.5534135903863;3766.60450652683;3807.428885667172;3814.4659747635355;3827.138893748884;3828.0429892526868;3840.6927445804267;4328.177646247203;4341.609255166987;4375.365571992107;4419.513853476115;4419.734815911055;5083.059633967728;5084.313617661643;5160.225966105114;5189.2875351134035;5218.556422704112;1251.7746805574902;1252.9248245105323;1264.76601828662;1264.7723409786327;1280.9743805123846;834.8789425533264;867.3884911137633;871.1810897756216;875.1817051057282;890.6081324217324;4343.305071188594;4356.607905288539;4363.36731173978;4395.230834603932;4396.878795907023;5154.252633368141;5185.455527169668;5203.323567936144;5211.9478805211465;5219.712915789592;4260.850870219528;4394.780260986938;4408.448943882015;4412.977935110304;4420.9115817684105;2723.7276272372605;2728.972710272872;2751.6285301484445;2754.820936639112;2763.6821765497225;4677.947461821063;4714.882127946828;4717.811287548459;4726.243800991825;4728.88177795551;5066.36670416198;5196.58427325813;5253.343332083489;5274.628596564844;5310.840674779763;4709.976450117728;4720.197566413718;4767.427908650984;4788.233882578771;4800.3759511263315;5124.797001873829;5141.203113517411;5146.8310668358745;5153.330067091254;5158.749987507846;4859.732714700725;5072.239164125411;5073.416557095981;5086.923696144635;5095.726068482879;4726.598239149711;4734.100520901018;4759.2147295697205;4794.304825800309;4844.529290062023;3651.434027725707;3729.533808273966;3748.5126933498473;3757.455169000534;3761;5256.316678831728;5289.074411977966;5312.548433383051;5314.654547454403;5325.121354976385;4884.413870335582;5092.072058566413;5133.996611982032;5147.253648221062;5190.584753219658;5004.224345226496;5063.898722025612;5091.389033316026;5151.407588127413;5152.562032227303;4984.551390374883;5023.7488125592845;5027.069992051483;5027.2207807789855;5050.222377692328;4879.853604391874;5132.5124113209185;5163.27714120031;5168.173092305213;5172.870678233075;5065.442801291929;5094.2103973884105;5122.923156152586;5141.742912854267;5173.568422841258 22:06:32 INFO - PROCESS | 8706 | |5;yui.html;653.3368630839701;667.2660073918687;719.5430901377625;725.9056322678051;762.195883343073;12892.806607900877;13869.445222191125;13950.999999999987;13969.650758731037;14093.718125637493;13232.801507977363;13235.139715918483;14166.504172353969;14189.290535473237;14645.121292722417;796.3748457460895;814.6822739131713;817.7914631768921;818.2022528035178;818.4025661267278;786.0567319216934;816.0533780814256;819.3895547816885;820.9343252539812;821.334718877711;843.6836186430089;852.1138016462902;854.7692123126752;858.1289990659485;859.1065292096213;848.3128665780706;849.7578190215789;849.8215374771305;850.2093053460279;851.0893344121793;623.8396582356812;626.4737620398841;627.5105417774143;627.7865525721277;630.2279707358495;13054.086213965027;13362.799558006638;13400.865991340157;13437.865621343759;14062.789058164135;12195;12524.686882828002;12612.81080783789;12613.306268155247;13040.673983150402;10437.843432348522;10572.207084468695;10578.471076446147;10660;10707.571697132105;3125.9218519537194;3187.5218717192606;3199.2641692410643;3222.065600975714;3302.4550949093373;60812.69593652003;60863;61627;62178;62559;9743.561539730728;9787.265955053257;9933.602655893683;10049.095581397709;10154.289199755945;18954;18988.240470381308;19018.52453688669;19025.14386852595;19062.61874762525;5518.365387980353;5690.4025077367105;5720.08478643415;5812.88374232513;5879.029960056543;3382.5433566468705;3426.691597756214;3478.32172726321;3479.1302174456387;3497.0557949353533;2781.8469984151066;2852.728990745917;2859.056511351249;3114.7819652624553;3285.0637568292923;539.2208259065612;557.9330480342385;562.535907876004;566.0349104776346;571.4085921071671;550.2763865516832;562.7630170073924;569.4703925349464;587.9500242479437;588.4997751910927;7044.295570442915;7289.890651640229;7449.739259125905;7538.283863033003;7898.60506974649;541.5938046465151;549.0967358694925;559.2645670942698;562.6736492834146;566.8469513231487;3647;3691.0956815580353;3701.2967536168044;3772.2078363543965;3838.2323535293053;48718.512814872105;48799.26801097986;61714;66383;68068.31931680719;41157;41666.37500437496;42436.575634243876;43106.56893431026;46934.061318773434;46134.538654613694;47375.5262447378;48841.511584883694;49557;51620.48379516232;8061.758147255592;8460.196281353261;8492.702755403778;8513.829723405373;8563.48619082832;32617.510737338485;33000.66999329976;33189.83405082959;34325;34798.82600586981;39824.800875996596;42960.78519607382;43057.784711076245;43136.568634313255;43548;11055.115590752559;11078.279911805706;11100.666979990614;11159.051480624237;11188.384638844616;11845.407729613313;11941.283522988648;11969.940150299193;12065.698357541132;12068.396580171131;11664.533418663497;11703.180777345504;11713.590024349447;12020.398980051137;12519.874801251872;10807.783844323227;10930.344179349264;11088.944555277172;11227.438628068401;11393.259438136494;11596.652100437;11717.824232636347;12133.878661213275;12182.208156469802;12716.491340346283;9119.772005699911;9166.266698664223;9389.906100939177;9439.244860411014;9483.715488535356;8967.865482017905;9043.553031514926;9060.909390906007;9092.909070909207;9488.478133702436 22:06:32 INFO - PROCESS | 8706 | __end_tp_report 22:06:32 INFO - PROCESS | 8706 | __start_cc_report 22:06:32 INFO - PROCESS | 8706 | _x_x_mozilla_cycle_collect,336 22:06:32 INFO - PROCESS | 8706 | __end_cc_report 22:06:32 INFO - PROCESS | 8706 | __startTimestamp1482818792132__endTimestamp 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | ------- Summary: start ------- 22:06:32 INFO - PROCESS | 8706 | Number of tests: 6 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#0] dojo.html Cycles:165 Average:4721.98 Median:4813.86 stddev:498.04 (10.3%) stddev-sans-first:470.67 22:06:32 INFO - PROCESS | 8706 | Values: 2590.9 2592.4 2596.5 2619.3 2626.3 4749.9 4788.3 4804.8 4813.9 4836.5 4753.2 4777.9 4779.7 4783.0 4785.3 4368.1 4432.7 4461.7 4487.4 4532.5 4404.1 4434.7 4451.2 4481.5 4506.1 4289.3 4319.9 4322.4 4417.8 4449.3 4328.0 4343.8 4346.0 4355.8 4361.4 4325.4 4332.3 4332.5 4333.8 4336.5 4648.1 4679.1 4684.0 4686.5 4690.4 4976.6 5033.5 5035.4 5043.5 5051.6 5102.5 5132.6 5140.0 5140.8 5147.4 4789.2 4805.4 4806.3 4813.2 4826.3 5204.4 5235.6 5244.5 5247.8 5309.7 4953.2 5037.1 5043.4 5051.5 5055.5 5018.2 5072.1 5087.7 5119.7 5144.3 4999.3 5024.9 5083.0 5090.5 5094.7 5087.6 5094.6 5097.5 5100.1 5138.7 4332.5 4375.3 4407.1 4416.4 4450.7 3800.3 3816.2 3842.8 3862.7 3865.7 4444.3 4448.9 4448.9 4453.1 4457.6 5149.1 5154.0 5154.5 5179.0 5187.0 4356.9 4434.9 4435.4 4445.0 4448.4 4614.2 4620.0 4627.5 4628.3 4636.4 4633.4 4708.9 4755.4 4796.0 4807.0 5142.7 5145.8 5147.1 5150.8 5164.3 4753.4 4758.2 4758.3 4759.6 4812.0 4954.2 4989.7 5022.7 5054.2 5059.0 5138.4 5152.0 5154.9 5163.5 5184.5 5011.2 5018.3 5018.8 5030.9 5067.2 4894.2 4911.9 4924.1 4930.1 5002.0 4902.3 4906.7 4907.0 4908.5 4924.0 5005.5 5018.5 5025.0 5025.8 5055.6 4855.0 4861.5 4895.5 4911.5 4936.6 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#1] ext.html Cycles:180 Average:47102.93 Median:360208.50 stddev:85384.29 (23.7%) stddev-sans-first:85552.10 22:06:32 INFO - PROCESS | 8706 | Values: 492.9 506.2 511.7 514.8 527.2 37951.2 40384.2 40627.8 40640.0 40727.0 40786.4 41266.8 41422.4 41438.8 41488.8 7571.5 7727.9 7752.4 9709.6 10061.6 9364.2 9371.9 9421.5 9465.2 9490.7 9474.1 9553.2 9556.3 9559.7 9571.0 9483.8 9512.5 9534.9 9541.2 9547.6 9643.6 9671.0 9689.7 9701.0 9709.0 34906.8 35143.5 35238.8 35245.3 35256.5 3397.6 3411.7 3429.6 3437.2 3452.4 25164.6 25672.6 26006.1 26466.6 26559.7 3206.2 3291.0 3297.9 3301.6 3338.8 263160.0 266833.0 267536.0 360170.0 361508.0 46602.8 47560.5 47581.5 47630.8 47787.5 51258.2 51477.7 51541.7 51569.5 51688.5 11353.8 11411.8 11527.4 11600.1 11607.0 8325.2 8355.1 8455.9 8631.6 8677.2 16066.4 16254.5 16313.5 16326.8 16423.3 6185.4 6367.5 6428.8 6473.2 6544.0 718.8 733.9 734.5 737.3 739.3 26843.2 27822.0 27941.2 28026.7 28541.4 938.3 961.4 981.6 983.9 1042.6 14905.2 15128.0 15156.6 15302.2 15352.5 360247.0 363312.0 364404.0 364483.0 365377.0 50207.0 50655.2 50824.5 50829.7 50847.7 1120.8 1176.7 1180.9 1184.8 1189.5 25196.9 26473.6 27246.9 27678.2 27693.0 41601.0 42971.1 43122.4 43126.0 43262.1 297416.0 298745.0 299734.0 300023.0 300044.0 22116.0 22808.9 24302.6 24633.0 25040.5 40248.8 40470.0 40743.4 40948.0 42064.8 34772.8 34980.1 35284.5 35343.5 35650.6 34931.1 35037.3 35314.6 35331.8 35396.3 33719.5 33771.7 34266.8 34332.5 34482.3 30090.4 31648.5 31729.4 31796.4 31886.5 23854.6 24137.8 24328.4 24332.5 24337.6 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#2] jquery.html Cycles:180 Average:22248.89 Median:5171.78 stddev:56465.10 (1091.8%) stddev-sans-first:56599.61 22:06:32 INFO - PROCESS | 8706 | Values: 373.2 382.3 386.9 390.3 400.8 15985.3 16032.2 16227.5 16306.0 16366.0 15663.2 15920.4 16415.3 16671.2 16685.8 5030.3 5153.3 5190.2 5256.2 5258.9 5082.2 5143.5 5354.1 5402.9 5454.0 5407.3 5414.2 5416.8 5419.1 5431.3 5356.9 5366.5 5442.8 5459.7 5479.2 5227.5 5266.6 5276.8 5303.8 5305.1 12246.6 18072.7 18116.5 20288.7 20373.0 1945.2 2128.8 2146.8 2156.8 2188.8 8160.0 8487.4 8606.2 8691.6 8871.8 1569.4 1620.9 1628.6 1646.7 1651.5 63138.7 63806.0 64289.7 66018.0 66308.0 9832.6 9964.6 10034.4 10225.2 10255.4 13811.3 13850.2 13892.8 13912.1 13940.4 6146.5 6404.5 6549.5 6564.8 6572.4 5697.6 5730.9 5885.0 5925.7 5927.8 3991.4 4023.0 4360.3 4430.7 4469.2 1517.2 1633.4 1839.9 1905.7 1915.0 796.0 831.0 838.9 842.4 856.4 15862.4 16055.4 16146.9 16552.3 16582.5 827.4 839.9 841.6 842.5 859.6 9114.4 9131.6 9311.5 9325.5 9579.2 334519.0 339807.0 340437.0 343398.0 347917.0 67266.7 70635.6 70944.3 71477.0 72500.0 932.4 957.5 958.3 974.3 976.2 15210.8 15248.7 15333.8 15643.1 16003.2 29163.9 29482.7 35502.3 35924.5 37456.3 49118.8 49959.3 50398.0 50776.0 51001.7 7356.5 7410.4 7455.9 7643.7 7925.4 10919.9 11032.6 11134.3 11459.5 11566.7 9027.3 9415.4 9675.4 9799.8 10521.3 9353.9 9962.5 10137.5 10309.8 10500.6 10141.8 10219.4 10298.9 10494.6 10767.9 6651.4 6814.1 6820.2 7126.0 7543.6 7891.6 9573.6 9700.7 9770.7 9943.2 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#3] mootools.html Cycles:180 Average:4798.54 Median:4976.83 stddev:2570.91 (51.7%) stddev-sans-first:2564.82 22:06:32 INFO - PROCESS | 8706 | Values: 1319.2 1325.4 1341.2 1342.8 1347.8 6373.1 6555.1 7055.2 7540.8 7571.4 7048.8 7268.1 7302.3 7453.1 7487.6 2146.4 2194.0 2194.4 2199.7 2200.8 2152.4 2155.2 2180.4 2183.3 2207.2 2208.0 2241.9 2249.7 2250.4 2250.4 2107.0 2117.2 2119.3 2119.9 2120.8 2070.9 2182.1 2186.9 2204.7 2211.9 7364.3 7547.2 7547.7 7553.4 7564.8 4334.2 4438.3 4473.3 4475.5 4476.8 3018.9 3039.3 3116.1 3118.5 3205.1 1161.1 1168.7 1178.6 1186.5 1210.1 9508.8 9591.9 9614.6 9643.9 9644.8 3835.4 4012.8 4016.7 4102.1 4113.4 7772.5 7775.1 7794.5 7826.3 7856.1 4402.4 4407.1 4413.3 4414.6 4415.7 3886.6 4021.8 4079.7 4092.9 4094.7 3272.5 3311.2 3359.2 3383.7 3403.3 835.3 883.9 1057.1 1059.6 1063.8 796.4 817.2 817.2 829.1 829.7 4741.3 4909.3 4962.0 4971.7 5059.3 835.2 836.2 836.6 869.6 883.2 3159.4 3287.2 3322.1 3322.1 3344.4 8535.5 8741.5 8839.1 8869.2 8949.4 8760.8 8807.0 8817.2 8824.0 8848.5 6725.2 6827.7 6932.7 6941.2 7001.5 4615.0 4790.6 4816.6 4841.4 4982.0 8140.0 8147.3 8167.8 8186.4 8200.0 8170.2 8190.5 8320.7 8340.4 8379.5 5940.4 5957.1 5965.0 5975.3 6026.7 6951.8 6955.0 7049.6 7059.9 7064.8 6153.5 6213.0 6221.9 6326.8 6334.3 6124.7 6173.9 6203.4 6204.7 6223.8 5666.3 5775.2 5776.5 5779.5 5780.1 4399.8 4464.0 4470.9 4563.2 4581.0 4409.9 4431.6 4431.8 4472.3 4538.1 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#4] prototype.html Cycles:180 Average:4257.75 Median:4763.32 stddev:1209.90 (25.4%) stddev-sans-first:1177.34 22:06:32 INFO - PROCESS | 8706 | Values: 356.9 367.1 367.9 369.6 371.5 4907.3 4923.1 4935.5 5033.2 5035.7 4929.6 4930.7 4938.5 4948.8 4956.7 3516.5 3741.0 3859.8 3954.3 3959.5 3952.7 3954.9 3958.7 3966.3 3973.9 3937.1 3975.3 3975.3 3998.4 4010.1 3886.7 3944.8 3972.0 3975.4 3981.3 3566.1 3566.3 3574.2 3587.1 3608.6 4754.6 4804.5 4806.8 4852.4 4861.9 4496.4 4515.0 4520.6 4540.6 4550.0 4995.7 5169.5 5172.6 5175.2 5220.9 3889.8 3890.9 3891.5 3897.8 3915.9 5167.6 5382.2 5385.5 5399.1 5400.8 3692.0 3715.9 3718.8 3721.6 3766.6 3807.4 3814.5 3827.1 3828.0 3840.7 4328.2 4341.6 4375.4 4419.5 4419.7 5083.1 5084.3 5160.2 5189.3 5218.6 1251.8 1252.9 1264.8 1264.8 1281.0 834.9 867.4 871.2 875.2 890.6 4343.3 4356.6 4363.4 4395.2 4396.9 5154.3 5185.5 5203.3 5211.9 5219.7 4260.9 4394.8 4408.4 4413.0 4420.9 2723.7 2729.0 2751.6 2754.8 2763.7 4677.9 4714.9 4717.8 4726.2 4728.9 5066.4 5196.6 5253.3 5274.6 5310.8 4710.0 4720.2 4767.4 4788.2 4800.4 5124.8 5141.2 5146.8 5153.3 5158.7 4859.7 5072.2 5073.4 5086.9 5095.7 4726.6 4734.1 4759.2 4794.3 4844.5 3651.4 3729.5 3748.5 3757.5 3761.0 5256.3 5289.1 5312.5 5314.7 5325.1 4884.4 5092.1 5134.0 5147.3 5190.6 5004.2 5063.9 5091.4 5151.4 5152.6 4984.6 5023.7 5027.1 5027.2 5050.2 4879.9 5132.5 5163.3 5168.2 5172.9 5065.4 5094.2 5122.9 5141.7 5173.6 22:06:32 INFO - PROCESS | 8706 | 22:06:32 INFO - PROCESS | 8706 | [#5] yui.html Cycles:180 Average:13871.67 Median:44841.27 stddev:16640.63 (37.1%) stddev-sans-first:16657.71 22:06:32 INFO - PROCESS | 8706 | Values: 653.3 667.3 719.5 725.9 762.2 12892.8 13869.4 13951.0 13969.7 14093.7 13232.8 13235.1 14166.5 14189.3 14645.1 796.4 814.7 817.8 818.2 818.4 786.1 816.1 819.4 820.9 821.3 843.7 852.1 854.8 858.1 859.1 848.3 849.8 849.8 850.2 851.1 623.8 626.5 627.5 627.8 630.2 13054.1 13362.8 13400.9 13437.9 14062.8 12195.0 12524.7 12612.8 12613.3 13040.7 10437.8 10572.2 10578.5 10660.0 10707.6 3125.9 3187.5 3199.3 3222.1 3302.5 60812.7 60863.0 61627.0 62178.0 62559.0 9743.6 9787.3 9933.6 10049.1 10154.3 18954.0 18988.2 19018.5 19025.1 19062.6 5518.4 5690.4 5720.1 5812.9 5879.0 3382.5 3426.7 3478.3 3479.1 3497.1 2781.8 2852.7 2859.1 3114.8 3285.1 539.2 557.9 562.5 566.0 571.4 550.3 562.8 569.5 588.0 588.5 7044.3 7289.9 7449.7 7538.3 7898.6 541.6 549.1 559.3 562.7 566.8 3647.0 3691.1 3701.3 3772.2 3838.2 48718.5 48799.3 61714.0 66383.0 68068.3 41157.0 41666.4 42436.6 43106.6 46934.1 46134.5 47375.5 48841.5 49557.0 51620.5 8061.8 8460.2 8492.7 8513.8 8563.5 32617.5 33000.7 33189.8 34325.0 34798.8 39824.8 42960.8 43057.8 43136.6 43548.0 11055.1 11078.3 11100.7 11159.1 11188.4 11845.4 11941.3 11969.9 12065.7 12068.4 11664.5 11703.2 11713.6 12020.4 12519.9 10807.8 10930.3 11088.9 11227.4 11393.3 11596.7 11717.8 12133.9 12182.2 12716.5 9119.8 9166.3 9389.9 9439.2 9483.7 8967.9 9043.6 9060.9 9092.9 9488.5 22:06:32 INFO - PROCESS | 8706 | -------- Summary: end -------- 22:06:32 INFO - PROCESS | 8706 | 22:06:33 INFO - TEST-INFO | 8706: exit 0 22:06:33 INFO - TEST-OK | dromaeo_css | took 1120388ms 22:06:33 INFO - TEST-START | kraken 22:06:33 INFO - operating with platform_type : linux_ 22:06:33 INFO - Initialising browser for kraken test... 22:06:33 INFO - TEST-INFO | started process 9056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCikFha/profile http://localhost:49509/getInfo.html) 22:06:33 INFO - PROCESS | 9056 | 1482818793531 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 22:06:38 INFO - PROCESS | 9056 | __metrics Screen width/height:1600/1200 22:06:38 INFO - PROCESS | 9056 | colorDepth:24 22:06:38 INFO - PROCESS | 9056 | Browser inner width/height: 1024/697 22:06:38 INFO - PROCESS | 9056 | __metrics 22:06:38 ERROR - PROCESS | 9056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 22:06:39 INFO - TEST-INFO | 9056: exit 0 22:06:39 INFO - Browser initialized. 22:06:39 INFO - Running cycle 1/1 for kraken test... 22:06:39 INFO - TEST-INFO | started process 9176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCikFha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:51 INFO - PROCESS | 9176 | RSS: Main: 158191616 22:06:51 INFO - PROCESS | 9176 | 22:06:54 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:55 INFO - PROCESS | 9176 | RSS: Main: 163840000 22:06:55 INFO - PROCESS | 9176 | 22:06:58 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-dft) 22:06:58 INFO - PROCESS | 9176 | RSS: Main: 162525184 22:06:58 INFO - PROCESS | 9176 | 22:07:01 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-fft) 22:07:02 INFO - PROCESS | 9176 | RSS: Main: 159268864 22:07:02 INFO - PROCESS | 9176 | 22:07:04 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-oscillator) 22:07:05 INFO - PROCESS | 9176 | RSS: Main: 160546816 22:07:05 INFO - PROCESS | 9176 | 22:07:07 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:08 INFO - PROCESS | 9176 | RSS: Main: 159924224 22:07:08 INFO - PROCESS | 9176 | 22:07:11 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:11 INFO - PROCESS | 9176 | RSS: Main: 164605952 22:07:11 INFO - PROCESS | 9176 | 22:07:15 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:15 INFO - PROCESS | 9176 | RSS: Main: 161923072 22:07:15 INFO - PROCESS | 9176 | 22:07:18 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49509/tests/kraken/driver.html?testName=json-parse-financial) 22:07:19 INFO - PROCESS | 9176 | RSS: Main: 162856960 22:07:19 INFO - PROCESS | 9176 | 22:07:21 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:21 INFO - PROCESS | 9176 | RSS: Main: 161796096 22:07:21 INFO - PROCESS | 9176 | 22:07:23 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:24 INFO - PROCESS | 9176 | RSS: Main: 162074624 22:07:24 INFO - PROCESS | 9176 | 22:07:26 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:27 INFO - PROCESS | 9176 | RSS: Main: 162828288 22:07:27 INFO - PROCESS | 9176 | 22:07:30 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:30 INFO - PROCESS | 9176 | RSS: Main: 163315712 22:07:30 INFO - PROCESS | 9176 | 22:07:34 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:34 INFO - PROCESS | 9176 | RSS: Main: 162467840 22:07:34 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49509/tests/kraken/driver.html?testName=ai-astar) 22:07:36 INFO - PROCESS | 9176 | RSS: Main: 165220352 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | __start_tp_report 22:07:36 INFO - PROCESS | 9176 | _x_x_mozilla_page_load 22:07:36 INFO - PROCESS | 9176 | _x_x_mozilla_page_load_details 22:07:36 INFO - PROCESS | 9176 | |i|pagename|runs| 22:07:36 INFO - PROCESS | 9176 | |0;ai-astar;112;116;114;116;127;116;118;115;116;115 22:07:36 INFO - PROCESS | 9176 | |1;audio-beat-detection;158;127;127;166;133;132;131;127;151;132 22:07:36 INFO - PROCESS | 9176 | |2;audio-dft;167;168;171;166;165;164;164;167;166;163 22:07:36 INFO - PROCESS | 9176 | |3;audio-fft;77;76;78;116;78;77;76;77;92;78 22:07:36 INFO - PROCESS | 9176 | |4;audio-oscillator;86;84;125;85;85;84;111;85;85;102 22:07:36 INFO - PROCESS | 9176 | |5;imaging-gaussian-blur;118;119;119;118;118;122;122;122;119;117 22:07:36 INFO - PROCESS | 9176 | |6;imaging-darkroom;153;151;151;151;151;150;150;151;151;151 22:07:36 INFO - PROCESS | 9176 | |7;imaging-desaturate;97;96;96;97;96;96;95;97;97;95 22:07:36 INFO - PROCESS | 9176 | |8;json-parse-financial;66;65;65;66;67;69;69;70;67;67 22:07:36 INFO - PROCESS | 9176 | |9;json-stringify-tinderbox;66;68;67;68;67;67;67;68;68;68 22:07:36 INFO - PROCESS | 9176 | |10;stanford-crypto-aes;88;87;86;92;88;87;86;90;89;88 22:07:36 INFO - PROCESS | 9176 | |11;stanford-crypto-ccm;137;136;135;142;141;146;153;136;181;149 22:07:36 INFO - PROCESS | 9176 | |12;stanford-crypto-pbkdf2;184;185;189;191;198;181;186;190;185;181 22:07:36 INFO - PROCESS | 9176 | |13;stanford-crypto-sha256-iterative;71;73;71;74;70;71;70;70;69;72 22:07:36 INFO - PROCESS | 9176 | __end_tp_report 22:07:36 INFO - PROCESS | 9176 | __start_cc_report 22:07:36 INFO - PROCESS | 9176 | _x_x_mozilla_cycle_collect,784 22:07:36 INFO - PROCESS | 9176 | __end_cc_report 22:07:36 INFO - PROCESS | 9176 | __startTimestamp1482818856686__endTimestamp 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | ------- Summary: start ------- 22:07:36 INFO - PROCESS | 9176 | Number of tests: 14 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.00 stddev:4.01 (3.5%) stddev-sans-first:3.91 22:07:36 INFO - PROCESS | 9176 | Values: 112.0 116.0 114.0 116.0 127.0 116.0 118.0 115.0 116.0 115.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:132.50 stddev:14.38 (10.9%) stddev-sans-first:13.39 22:07:36 INFO - PROCESS | 9176 | Values: 158.0 127.0 127.0 166.0 133.0 132.0 131.0 127.0 151.0 132.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.50 stddev:2.33 (1.4%) stddev-sans-first:2.45 22:07:36 INFO - PROCESS | 9176 | Values: 167.0 168.0 171.0 166.0 165.0 164.0 164.0 167.0 166.0 163.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.50 stddev:12.69 (16.4%) stddev-sans-first:13.30 22:07:36 INFO - PROCESS | 9176 | Values: 77.0 76.0 78.0 116.0 78.0 77.0 76.0 77.0 92.0 78.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:85.00 stddev:14.51 (17.1%) stddev-sans-first:15.16 22:07:36 INFO - PROCESS | 9176 | Values: 86.0 84.0 125.0 85.0 85.0 84.0 111.0 85.0 85.0 102.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:119.00 stddev:1.90 (1.6%) stddev-sans-first:1.94 22:07:36 INFO - PROCESS | 9176 | Values: 118.0 119.0 119.0 118.0 118.0 122.0 122.0 122.0 119.0 117.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.44 22:07:36 INFO - PROCESS | 9176 | Values: 153.0 151.0 151.0 151.0 151.0 150.0 150.0 151.0 151.0 151.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 22:07:36 INFO - PROCESS | 9176 | Values: 97.0 96.0 96.0 97.0 96.0 96.0 95.0 97.0 97.0 95.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:1.73 (2.6%) stddev-sans-first:1.79 22:07:36 INFO - PROCESS | 9176 | Values: 66.0 65.0 65.0 66.0 67.0 69.0 69.0 70.0 67.0 67.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 22:07:36 INFO - PROCESS | 9176 | Values: 66.0 68.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 68.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:1.85 (2.1%) stddev-sans-first:1.96 22:07:36 INFO - PROCESS | 9176 | Values: 88.0 87.0 86.0 92.0 88.0 87.0 86.0 90.0 89.0 88.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:144.00 stddev:13.84 (9.6%) stddev-sans-first:14.33 22:07:36 INFO - PROCESS | 9176 | Values: 137.0 136.0 135.0 142.0 141.0 146.0 153.0 136.0 181.0 149.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:187.50 stddev:5.16 (2.8%) stddev-sans-first:5.36 22:07:36 INFO - PROCESS | 9176 | Values: 184.0 185.0 189.0 191.0 198.0 181.0 186.0 190.0 185.0 181.0 22:07:36 INFO - PROCESS | 9176 | 22:07:36 INFO - PROCESS | 9176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 22:07:36 INFO - PROCESS | 9176 | Values: 71.0 73.0 71.0 74.0 70.0 71.0 70.0 70.0 69.0 72.0 22:07:36 INFO - PROCESS | 9176 | -------- Summary: end -------- 22:07:36 INFO - PROCESS | 9176 | 22:07:37 INFO - TEST-INFO | 9176: exit 0 22:07:37 INFO - TEST-OK | kraken | took 64920ms 22:07:37 INFO - SUITE-END | took 1185s 22:07:38 INFO - Completed test suite (00:19:45) 22:07:38 INFO - javascript benchmark 22:07:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6254.1966885679885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.8963641454343, 2592.4167062410947, 2596.5456045192086, 2619.3320703220675, 2626.3434141464636, 4749.857504274869, 4788.329633851259, 4804.783784729687, 4813.855584332471, 4836.540528649773, 4753.191957367248, 4777.856664300077, 4779.665423420353, 4783.043391321732, 4785.258284965836, 4368.082702632443, 4432.689711720165, 4461.7322960622305, 4487.439070116236, 4532.5240849710635, 4404.053128577355, 4434.667399945001, 4451.1542806866755, 4481.5070342262325, 4506.121306345264, 4289.270823959934, 4319.935200971988, 4322.438083049184, 4417.779111044435, 4449.26587113126, 4327.956720432787, 4343.761093139876, 4345.978270108661, 4355.760433176174, 4361.389405483234, 4325.394444777734, 4332.28517294646, 4332.4801023877335, 4333.848315308949, 4336.522982471925, 4648.140094082605, 4679.110968915895, 4683.976580117078, 4686.507916668769, 4690.390249267608, 4976.576990955737, 5033.521815427529, 5035.446100928895, 5043.52086551777, 5051.595872330205, 5102.489751024905, 5132.615053870974, 5140.02339555487, 5140.768665410028, 5147.356580427447, 4789.161896668139, 4805.37530121089, 4806.303086052503, 4813.205821039559, 4826.348442960156, 5204.401493828258, 5235.60732945023, 5244.501772331699, 5247.790088396498, 5309.7345132743985, 4953.23224900141, 5037.0681423936685, 5043.445221025684, 5051.520105589963, 5055.51972562606, 5018.247262910592, 5072.087024335581, 5087.720175390389, 5119.692818430832, 5144.279800827887, 4999.325091112653, 5024.924626130611, 5082.974585127125, 5090.49095090488, 5094.719790411489, 5087.618428617869, 5094.643374963717, 5097.46476619957, 5100.056489549445, 5138.743062846843, 4332.523422423531, 4375.299952007664, 4407.140607581555, 4416.3596278539435, 4450.666200035011, 3800.3349413852466, 3816.217675376541, 3842.769433833979, 3862.663088831273, 3865.690744740414, 4444.266695995189, 4448.888777780581, 4448.933266001012, 4453.0648563801315, 4457.643388528974, 5149.073166830007, 5154.0, 5154.5360917516855, 5179.0, 5186.974065129651, 4356.912861742748, 4434.933475997863, 4435.35687325336, 4444.977775111169, 4448.421705178306, 4614.169449499055, 4620.029793743352, 4627.537246275346, 4628.305754136839, 4636.420447444069, 4633.374494443275, 4708.858734237979, 4755.429348478205, 4795.95204047955, 4807.038592281628, 5142.742862856917, 5145.819896303611, 5147.073526765218, 5150.845474635767, 5164.32863727713, 4753.358296629911, 4758.16732071893, 4758.262469317261, 4759.595434388116, 4811.9518804811505, 4954.232094025432, 4989.725565093955, 5022.74886255693, 5054.21659642756, 5058.974705126451, 5138.434772174983, 5152.046871328666, 5154.948450515597, 5163.509466600667, 5184.507471790174, 5011.248312753116, 5018.347614810052, 5018.7741551631, 5030.949690503048, 5067.214581739836, 4894.216925291937, 4911.877203069952, 4924.089043526816, 4930.063287975273, 5002.024605202097, 4902.264660300983, 4906.705597664151, 4906.95093049065, 4908.509149085063, 4924.015196960694, 5005.499450055111, 5018.473060328759, 5025.0, 5025.84922452327, 5055.646104772631, 4855.0, 4861.513848615252, 4895.510448955076, 4911.484294149206, 4936.629752768628], "value": 4689.349075880987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.9063477939191, 506.1976766824583, 511.6827566908517, 514.8455463360991, 527.2407732864677, 37951.24097518048, 40384.1923161537, 40627.79686101569, 40640.0, 40727.0, 40786.38820417689, 41266.793666031626, 41422.37866432006, 41438.79280603601, 41488.79255603718, 7571.507851989617, 7727.884081738778, 7752.418568607349, 9709.61161553537, 10061.597536098547, 9364.157225849673, 9371.859422108673, 9421.48181849998, 9465.195458386012, 9490.66782662607, 9474.052594740506, 9553.187979021792, 9556.283278754086, 9559.713208603753, 9571.042895710443, 9483.762905927339, 9512.524373781283, 9534.856977145348, 9541.236701063934, 9547.61809527618, 9643.566039528238, 9671.0, 9689.70930872075, 9700.951495242478, 9709.0, 34906.82546587276, 35143.4728479073, 35238.823805880806, 35245.295094098234, 35256.471152932725, 3397.59228892532, 3411.7441191910707, 3429.639887811794, 3437.2094418283687, 3452.361313157074, 25164.622530662054, 25672.614910776352, 26006.08978685737, 26466.60300095481, 26559.73440265592, 3206.1824234820206, 3290.9835450822834, 3297.9175520612175, 3301.636819949804, 3338.7829791063746, 263160.0, 266833.0, 267536.0, 360170.0, 361508.0, 46602.766986164854, 47560.5243947563, 47581.524184758404, 47630.761846190544, 47787.522124778305, 51258.23112653313, 51477.7426112867, 51541.742291288305, 51569.48430515647, 51688.48311516837, 11353.772924541463, 11411.828822567668, 11527.365994870363, 11600.129990250765, 11607.0, 8325.167483251626, 8355.122712115262, 8455.915440845636, 8631.568421578895, 8677.219050285505, 16066.437674681563, 16254.51236462908, 16313.492599091252, 16326.75509867353, 16423.343066277215, 6185.443310102112, 6367.4906007519285, 6428.839279018062, 6473.158489396348, 6544.0, 718.8202949262684, 733.8899165125167, 734.5042096584784, 737.2627372627372, 739.268124556685, 26843.19470415891, 27822.0, 27941.161765147077, 28026.719732802412, 28541.429171416454, 938.2915898496591, 961.438391127015, 981.5779214937645, 983.9409635421755, 1042.598599539183, 14905.180215088058, 15128.0, 15156.621084472976, 15302.234888255543, 15352.539423817303, 360247.0, 363312.0, 364404.0, 364483.0, 365377.0, 50207.0, 50655.24017139746, 50824.491755082716, 50829.74585127125, 50847.7457612717, 1120.8486854274568, 1176.7293522489874, 1180.86420061694, 1184.7689700508317, 1189.4766302826729, 25196.874015629804, 26473.60289595619, 27246.863765681046, 27678.169654910384, 27693.0, 41601.0, 42971.14057718765, 43122.353164703185, 43126.0, 43262.134757305306, 297416.0, 298745.0, 299734.0, 300023.0, 300044.0, 22116.00477978527, 22808.885955570116, 24302.635460467754, 24633.0, 25040.49919001646, 40248.798756006036, 40470.0, 40743.388849166695, 40948.0, 42064.78967605143, 34772.82613586916, 34980.125496861765, 35284.47073293954, 35343.469847952816, 35650.643493564734, 34931.12672183216, 35037.299254015285, 35314.64685353216, 35331.82334088313, 35396.29207415889, 33719.49420758642, 33771.66228337685, 34266.82866585651, 34332.485012724326, 34482.310353793284, 30090.398192036475, 31648.525272120474, 31729.365412691157, 31796.36407271888, 31886.52170217495, 23854.642180366962, 24137.828369540293, 24328.391790204678, 24332.51334973255, 24337.634935475628], "value": 17243.14021423226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.17342087276677, 382.2584186677845, 386.924549712806, 390.2818813383374, 400.7755656832174, 15985.280662370193, 16032.198390080508, 16227.513174604766, 16306.021638701686, 16366.0, 15663.216839158053, 15920.442784502517, 16415.343386264536, 16671.249793759278, 16685.83314166858, 5030.320906677606, 5153.330067091273, 5190.221466779975, 5256.159014557672, 5258.92111618326, 5082.16144336186, 5143.4599367066485, 5354.14333706607, 5402.864928376803, 5454.0, 5407.270018547485, 5414.160805075219, 5416.83749487516, 5419.105847535152, 5431.266778984846, 5356.91964620531, 5366.545767013369, 5442.755076021588, 5459.727013649302, 5479.1781232815, 5227.45111763267, 5266.631335806495, 5276.7889284428575, 5303.840884773463, 5305.124654432053, 12246.632601021984, 18072.734908556406, 18116.456506304832, 20288.695669564968, 20373.0, 1945.1830231302886, 2128.7658357580654, 2146.7745886681987, 2156.795104465073, 2188.8248940084754, 8160.0, 8487.363447741382, 8606.225439710455, 8691.565421728888, 8871.822563548758, 1569.3957826236867, 1620.894641848276, 1628.584710898725, 1646.662434200998, 1651.4962936304423, 63138.68430657863, 63806.0, 64289.67855160741, 66018.0, 66308.0, 9832.606695732233, 9964.601415943425, 10034.448105354275, 10225.181985441146, 10255.435951022766, 13811.309434528233, 13850.238236897067, 13892.791608125886, 13912.095713778774, 13940.442382304595, 6146.477549408351, 6404.455621272151, 6549.541532092708, 6564.770233041821, 6572.4084832365315, 5697.601167918288, 5730.885382292414, 5884.9705751470965, 5925.703714814242, 5927.8221653350465, 3991.381335892941, 4022.959770402317, 4360.258756011485, 4430.689851710414, 4469.240229161051, 1517.1579773225965, 1633.4038076102374, 1839.9356022539414, 1905.676035074013, 1915.0233380975803, 795.9761207163795, 830.9542975136426, 838.8867502887155, 842.4103127810557, 856.3919617071949, 15862.44481443144, 16055.357785688442, 16146.919265403832, 16552.33790648385, 16582.50252492427, 827.3587969323822, 839.9496030238205, 841.6296829395046, 842.5323945210467, 859.5788063848669, 9114.40756350835, 9131.589078491485, 9311.483930293802, 9325.533723313807, 9579.227842849095, 334519.0, 339807.0, 340437.0, 343398.0, 347917.0, 67266.66366668136, 70635.6468217666, 70944.2905570948, 71477.0, 72500.0, 932.3753085432776, 957.4973139102027, 958.2717134977606, 974.2546951582045, 976.2141476111798, 15210.847891521385, 15248.695026099638, 15333.76999345033, 15643.139627320606, 16003.199840008187, 29163.854180728962, 29482.705172948856, 35502.28995420129, 35924.4611330825, 37456.2508749818, 49118.75440622774, 49959.25061124013, 50398.0, 50775.98448031092, 51001.744991274805, 7356.521826081287, 7410.444216683878, 7455.888161677471, 7643.7324693635455, 7925.365970722213, 10919.890801092206, 11032.613858514913, 11134.33194008362, 11459.484323205643, 11566.710832229262, 9027.277817774693, 9415.387999780267, 9675.419474831533, 9799.804003920024, 10521.316114452537, 9353.85969210476, 9962.501874906371, 10137.543810528692, 10309.793804123725, 10500.579976800842, 10141.847872281774, 10219.437930913573, 10298.897011030094, 10494.580216791548, 10767.892321077003, 6651.43462805667, 6814.1482314710665, 6820.215675197416, 7126.037984871976, 7543.585102819397, 7891.605419728876, 9573.569189386355, 9700.708978730649, 9770.658026969022, 9943.154831839374], "value": 7901.8137462800005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.2480286236846, 1325.3704490367077, 1341.1550723044486, 1342.8388593368798, 1347.8449978252497, 6373.0759039939185, 6555.115059466971, 7055.2239253682055, 7540.849183016337, 7571.356434703057, 7048.823779405518, 7268.0914885639295, 7302.3427891489755, 7453.068366454193, 7487.625618719069, 2146.35609317205, 2194.0346247651064, 2194.3855720398233, 2199.7250343707037, 2200.801927826495, 2152.3865698275995, 2155.2133471282946, 2180.4003898927845, 2183.257692384589, 2207.194374053467, 2207.9889600551974, 2241.9350808366057, 2249.6962910007187, 2250.3586477853814, 2250.4148921280503, 2107.041296210228, 2117.184883819725, 2119.3006307918504, 2119.8834064126468, 2120.766715661276, 2070.9171633134806, 2182.1380554680973, 2186.8578542394694, 2204.7354317481845, 2211.9447013824624, 7364.3003914628025, 7547.16981132075, 7547.698092076311, 7553.433492488085, 7564.848703025908, 4334.219840428722, 4438.334249862514, 4473.2842745160615, 4475.48531918827, 4476.836022634106, 3018.886779254509, 3039.2553824312963, 3116.1430606583144, 3118.485449900764, 3205.086550333144, 1161.0943464098018, 1168.6902970712683, 1178.5757127434117, 1186.5135294529289, 1210.1408000319784, 9508.809823803555, 9591.904080959172, 9614.567344469515, 9643.855342169873, 9644.807103857953, 3835.386338185877, 4012.8194231259663, 4016.7188296819527, 4102.138550904344, 4113.4446849675505, 7772.533647981026, 7775.066991961001, 7794.454388192772, 7826.295633393022, 7856.135825059239, 4402.449693788277, 4407.074514351958, 4413.271810151289, 4414.55854414556, 4415.6909016368545, 3886.591907849692, 4021.8391264349684, 4079.73481723687, 4092.877213683594, 4094.733842300241, 3272.476403775432, 3311.172206948263, 3359.2441700617164, 3383.678550537695, 3403.3363494118903, 835.3108685334623, 883.88067610873, 1057.1331508163232, 1059.5602824827765, 1063.803196408667, 796.38678217772, 817.2277198047788, 817.2399668308531, 829.088003196479, 829.713748756678, 4741.288806679026, 4909.337239472626, 4961.975190124026, 4971.651984361132, 5059.266406371055, 835.2399316621845, 836.197250639393, 836.6486075848159, 869.6477926439802, 883.2404132446092, 3159.4202898550725, 3287.227501537137, 3322.0864262328055, 3322.1396018229384, 3344.4314466540745, 8535.530545819915, 8741.475511469333, 8839.116088391109, 8869.246114080246, 8949.418287811272, 8760.780980475412, 8806.955965220133, 8817.16236957488, 8823.955880220557, 8848.46909185451, 6725.159355080615, 6827.726890924308, 6932.6533673316135, 6941.236463988957, 7001.509894307452, 4615.0, 4790.568848803624, 4816.566509014206, 4841.443234028132, 4982.0, 8140.0, 8147.348212142896, 8167.79580510492, 8186.426950113435, 8199.95900020496, 8170.182981701782, 8190.467619604707, 8320.708775193081, 8340.374471914509, 8379.539125348165, 5940.405959404025, 5957.136215248851, 5965.045592705146, 5975.312839023568, 6026.7287972040485, 6951.7914462566205, 6954.965225173842, 7049.647517623996, 7059.929400705927, 7064.823379415556, 6153.4769544587425, 6213.0, 6221.9377806223165, 6326.841828954129, 6334.303226645157, 6124.693765311806, 6173.907391389043, 6203.410675985774, 6204.72078756448, 6223.844403889939, 5666.291713535808, 5775.1914731938405, 5776.480116789509, 5779.450952159538, 5780.104083867007, 4399.802008909543, 4463.977680111579, 4470.888227794331, 4563.155816174019, 4581.0, 4409.85343810618, 4431.578999994996, 4431.778411079368, 4472.262076757429, 4538.115067561926], "value": 3936.0247345814378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.92682999985004, 367.08229426433917, 367.874922526341, 369.56391458079474, 371.48363774353635, 4907.337509436225, 4923.138450771115, 4935.481774413689, 5033.245013248014, 5035.748212589365, 4929.623208102453, 4930.654854160211, 4938.530839570235, 4948.802047918079, 4956.727379994108, 3516.5428494295707, 3741.0, 3859.81920215079, 3954.307996100685, 3959.46547216125, 3952.6837852971835, 3954.861579844706, 3958.703097267702, 3966.305896468121, 3973.940390894139, 3937.0944682722848, 3975.284448799215, 3975.3241948868763, 3998.4002399639994, 4010.0551232652288, 3886.708496862718, 3944.822482988258, 3971.98014009931, 3975.403689446577, 3981.28336899358, 3566.1084728817796, 3566.3045706087064, 3574.231540218839, 3587.1390866191928, 3608.621094785036, 4754.572088512051, 4804.519548045202, 4806.7836947337455, 4852.369192005052, 4861.927071093936, 4496.402877697828, 4515.0359593576895, 4520.615747661453, 4540.591346778806, 4549.977250113761, 4995.652912548601, 5169.483051694838, 5172.6379153459275, 5175.223716442526, 5220.895582088337, 3889.7666140031406, 3890.8638197662945, 3891.4746509221177, 3897.7856217908, 3915.882523524299, 5167.586593072583, 5382.170062178878, 5385.461453854622, 5399.136138217867, 5400.83797486076, 3692.0, 3715.9256814864093, 3718.8140592970244, 3721.5534135903863, 3766.60450652683, 3807.428885667172, 3814.4659747635355, 3827.138893748884, 3828.0429892526868, 3840.6927445804267, 4328.177646247203, 4341.609255166987, 4375.365571992107, 4419.513853476115, 4419.734815911055, 5083.059633967728, 5084.313617661643, 5160.225966105114, 5189.2875351134035, 5218.556422704112, 1251.7746805574902, 1252.9248245105323, 1264.76601828662, 1264.7723409786327, 1280.9743805123846, 834.8789425533264, 867.3884911137633, 871.1810897756216, 875.1817051057282, 890.6081324217324, 4343.305071188594, 4356.607905288539, 4363.36731173978, 4395.230834603932, 4396.878795907023, 5154.252633368141, 5185.455527169668, 5203.323567936144, 5211.9478805211465, 5219.712915789592, 4260.850870219528, 4394.780260986938, 4408.448943882015, 4412.977935110304, 4420.9115817684105, 2723.7276272372605, 2728.972710272872, 2751.6285301484445, 2754.820936639112, 2763.6821765497225, 4677.947461821063, 4714.882127946828, 4717.811287548459, 4726.243800991825, 4728.88177795551, 5066.36670416198, 5196.58427325813, 5253.343332083489, 5274.628596564844, 5310.840674779763, 4709.976450117728, 4720.197566413718, 4767.427908650984, 4788.233882578771, 4800.3759511263315, 5124.797001873829, 5141.203113517411, 5146.8310668358745, 5153.330067091254, 5158.749987507846, 4859.732714700725, 5072.239164125411, 5073.416557095981, 5086.923696144635, 5095.726068482879, 4726.598239149711, 4734.100520901018, 4759.2147295697205, 4794.304825800309, 4844.529290062023, 3651.434027725707, 3729.533808273966, 3748.5126933498473, 3757.455169000534, 3761.0, 5256.316678831728, 5289.074411977966, 5312.548433383051, 5314.654547454403, 5325.121354976385, 4884.413870335582, 5092.072058566413, 5133.996611982032, 5147.253648221062, 5190.584753219658, 5004.224345226496, 5063.898722025612, 5091.389033316026, 5151.407588127413, 5152.562032227303, 4984.551390374883, 5023.7488125592845, 5027.069992051483, 5027.2207807789855, 5050.222377692328, 4879.853604391874, 5132.5124113209185, 5163.27714120031, 5168.173092305213, 5172.870678233075, 5065.442801291929, 5094.2103973884105, 5122.923156152586, 5141.742912854267, 5173.568422841258], "value": 3886.239698347528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.3368630839701, 667.2660073918687, 719.5430901377625, 725.9056322678051, 762.195883343073, 12892.806607900877, 13869.445222191125, 13950.999999999987, 13969.650758731037, 14093.718125637493, 13232.801507977363, 13235.139715918483, 14166.504172353969, 14189.290535473237, 14645.121292722417, 796.3748457460895, 814.6822739131713, 817.7914631768921, 818.2022528035178, 818.4025661267278, 786.0567319216934, 816.0533780814256, 819.3895547816885, 820.9343252539812, 821.334718877711, 843.6836186430089, 852.1138016462902, 854.7692123126752, 858.1289990659485, 859.1065292096213, 848.3128665780706, 849.7578190215789, 849.8215374771305, 850.2093053460279, 851.0893344121793, 623.8396582356812, 626.4737620398841, 627.5105417774143, 627.7865525721277, 630.2279707358495, 13054.086213965027, 13362.799558006638, 13400.865991340157, 13437.865621343759, 14062.789058164135, 12195.0, 12524.686882828002, 12612.81080783789, 12613.306268155247, 13040.673983150402, 10437.843432348522, 10572.207084468695, 10578.471076446147, 10660.0, 10707.571697132105, 3125.9218519537194, 3187.5218717192606, 3199.2641692410643, 3222.065600975714, 3302.4550949093373, 60812.69593652003, 60863.0, 61627.0, 62178.0, 62559.0, 9743.561539730728, 9787.265955053257, 9933.602655893683, 10049.095581397709, 10154.289199755945, 18954.0, 18988.240470381308, 19018.52453688669, 19025.14386852595, 19062.61874762525, 5518.365387980353, 5690.4025077367105, 5720.08478643415, 5812.88374232513, 5879.029960056543, 3382.5433566468705, 3426.691597756214, 3478.32172726321, 3479.1302174456387, 3497.0557949353533, 2781.8469984151066, 2852.728990745917, 2859.056511351249, 3114.7819652624553, 3285.0637568292923, 539.2208259065612, 557.9330480342385, 562.535907876004, 566.0349104776346, 571.4085921071671, 550.2763865516832, 562.7630170073924, 569.4703925349464, 587.9500242479437, 588.4997751910927, 7044.295570442915, 7289.890651640229, 7449.739259125905, 7538.283863033003, 7898.60506974649, 541.5938046465151, 549.0967358694925, 559.2645670942698, 562.6736492834146, 566.8469513231487, 3647.0, 3691.0956815580353, 3701.2967536168044, 3772.2078363543965, 3838.2323535293053, 48718.512814872105, 48799.26801097986, 61714.0, 66383.0, 68068.31931680719, 41157.0, 41666.37500437496, 42436.575634243876, 43106.56893431026, 46934.061318773434, 46134.538654613694, 47375.5262447378, 48841.511584883694, 49557.0, 51620.48379516232, 8061.758147255592, 8460.196281353261, 8492.702755403778, 8513.829723405373, 8563.48619082832, 32617.510737338485, 33000.66999329976, 33189.83405082959, 34325.0, 34798.82600586981, 39824.800875996596, 42960.78519607382, 43057.784711076245, 43136.568634313255, 43548.0, 11055.115590752559, 11078.279911805706, 11100.666979990614, 11159.051480624237, 11188.384638844616, 11845.407729613313, 11941.283522988648, 11969.940150299193, 12065.698357541132, 12068.396580171131, 11664.533418663497, 11703.180777345504, 11713.590024349447, 12020.398980051137, 12519.874801251872, 10807.783844323227, 10930.344179349264, 11088.944555277172, 11227.438628068401, 11393.259438136494, 11596.652100437, 11717.824232636347, 12133.878661213275, 12182.208156469802, 12716.491340346283, 9119.772005699911, 9166.266698664223, 9389.906100939177, 9439.244860411014, 9483.715488535356, 8967.865482017905, 9043.553031514926, 9060.909390906007, 9092.909070909207, 9488.478133702436], "value": 6122.615287913734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 114.0, 116.0, 127.0, 116.0, 118.0, 115.0, 116.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 127.0, 166.0, 133.0, 132.0, 131.0, 127.0, 151.0, 132.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 171.0, 166.0, 165.0, 164.0, 164.0, 167.0, 166.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 116.0, 78.0, 77.0, 76.0, 77.0, 92.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 125.0, 85.0, 85.0, 84.0, 111.0, 85.0, 85.0, 102.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 118.0, 118.0, 122.0, 122.0, 122.0, 119.0, 117.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 97.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 67.0, 69.0, 69.0, 70.0, 67.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 92.0, 88.0, 87.0, 86.0, 90.0, 89.0, 88.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 142.0, 141.0, 146.0, 153.0, 136.0, 181.0, 149.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 189.0, 191.0, 198.0, 181.0, 186.0, 190.0, 185.0, 181.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 74.0, 70.0, 71.0, 70.0, 70.0, 69.0, 72.0], "value": 71.1, "unit": "score"}]}]} 22:07:38 INFO - Return code: 0 22:07:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:07:38 ERROR - # TBPL SUCCESS # 22:07:38 INFO - Running post-action listener: _resource_record_post_action 22:07:38 INFO - [mozharness: 2016-12-27 06:07:38.509704Z] Finished run-tests step (success) 22:07:38 INFO - Running post-run listener: _resource_record_post_run 22:07:38 INFO - Total resource usage - Wall time: 1202s; CPU: 14.0%; Read bytes: 4096; Write bytes: 405831680; Read time: 8; Write time: 473156 22:07:38 INFO - TinderboxPrint: CPU usage
13.5% 22:07:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:07:38 INFO - TinderboxPrint: I/O write bytes / time
405,831,680 / 473,156 22:07:38 INFO - TinderboxPrint: CPU idle
8,292.1 (86.5%) 22:07:38 INFO - TinderboxPrint: CPU user
1,235.9 (12.9%) 22:07:38 INFO - TinderboxPrint: Swap in / out
0 / 0 22:07:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110993408; Read time: 0; Write time: 85468 22:07:38 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 0; Write bytes: 294838272; Read time: 0; Write time: 387688 22:07:39 INFO - Running post-run listener: _upload_blobber_files 22:07:39 INFO - Blob upload gear active. 22:07:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:39 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 22:07:39 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'] 22:07:39 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 22:07:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:43 INFO - (blobuploader) - INFO - Done attempting. 22:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:43 INFO - (blobuploader) - INFO - Done attempting. 22:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:44 INFO - (blobuploader) - INFO - Done attempting. 22:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:45 INFO - (blobuploader) - INFO - Done attempting. 22:07:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:45 INFO - Return code: 0 22:07:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/383984ff6a17a6f6cee93ae572c997a358c6f11040ee00f337b234d38588a13edb27ef1a0f4ac8f1ad3b479a45903d37bc6d9c66a3eb32d6e3dfe89a387ed922", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aba45ecac7629ad73a3dc90930592fffa188ac2bcc097ac229e697818ce9a5b0757c92e0de61be28cf7df6db3415ec44ad47c7ee65628f2789685bd860a42cf2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1ca52527c0dee8992e4a26dce1d36c7c12ca7d100377bc0fa76a75ad49d3140ebf6dd28d497ecf959bba9b2d29f2a6c297aedfcafad945b67e5bf2ca580d0b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23adf476b149bf4f72389389f8d5da010331d91c1f8b1f5f426dc2bb2f7182827eaf311ada1d4a8f4d39a8fb9fb32de6f00fe2681482e03cd95e2af70371dec8"} 22:07:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:45 INFO - Contents: 22:07:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/383984ff6a17a6f6cee93ae572c997a358c6f11040ee00f337b234d38588a13edb27ef1a0f4ac8f1ad3b479a45903d37bc6d9c66a3eb32d6e3dfe89a387ed922", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aba45ecac7629ad73a3dc90930592fffa188ac2bcc097ac229e697818ce9a5b0757c92e0de61be28cf7df6db3415ec44ad47c7ee65628f2789685bd860a42cf2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1ca52527c0dee8992e4a26dce1d36c7c12ca7d100377bc0fa76a75ad49d3140ebf6dd28d497ecf959bba9b2d29f2a6c297aedfcafad945b67e5bf2ca580d0b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23adf476b149bf4f72389389f8d5da010331d91c1f8b1f5f426dc2bb2f7182827eaf311ada1d4a8f4d39a8fb9fb32de6f00fe2681482e03cd95e2af70371dec8"} 22:07:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:45 INFO - Copying logs to upload dir... 22:07:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.364435 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-26 22:07:43.962228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 22:07:43.965493) ========= 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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/383984ff6a17a6f6cee93ae572c997a358c6f11040ee00f337b234d38588a13edb27ef1a0f4ac8f1ad3b479a45903d37bc6d9c66a3eb32d6e3dfe89a387ed922", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aba45ecac7629ad73a3dc90930592fffa188ac2bcc097ac229e697818ce9a5b0757c92e0de61be28cf7df6db3415ec44ad47c7ee65628f2789685bd860a42cf2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1ca52527c0dee8992e4a26dce1d36c7c12ca7d100377bc0fa76a75ad49d3140ebf6dd28d497ecf959bba9b2d29f2a6c297aedfcafad945b67e5bf2ca580d0b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23adf476b149bf4f72389389f8d5da010331d91c1f8b1f5f426dc2bb2f7182827eaf311ada1d4a8f4d39a8fb9fb32de6f00fe2681482e03cd95e2af70371dec8"} build_url:https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/OrX8kRK9SNuYGNb9xH_vkg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/383984ff6a17a6f6cee93ae572c997a358c6f11040ee00f337b234d38588a13edb27ef1a0f4ac8f1ad3b479a45903d37bc6d9c66a3eb32d6e3dfe89a387ed922", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aba45ecac7629ad73a3dc90930592fffa188ac2bcc097ac229e697818ce9a5b0757c92e0de61be28cf7df6db3415ec44ad47c7ee65628f2789685bd860a42cf2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1ca52527c0dee8992e4a26dce1d36c7c12ca7d100377bc0fa76a75ad49d3140ebf6dd28d497ecf959bba9b2d29f2a6c297aedfcafad945b67e5bf2ca580d0b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23adf476b149bf4f72389389f8d5da010331d91c1f8b1f5f426dc2bb2f7182827eaf311ada1d4a8f4d39a8fb9fb32de6f00fe2681482e03cd95e2af70371dec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 22:07:43.995700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 22:07:43.996194) ========= 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-1482793424.924131-1040311593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 22:07:44.080113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 22:07:44.080835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 22:07:44.081564) ========= ========= Total master_lag: 0.18 =========