builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1474608993.8 results: success (0) buildid: 20160922193455 builduid: 31aa310a994946c8a3c98cfefd9536c3 revision: fa9844b0dee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:33.798493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:33.799012) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:33.799327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:33.856157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:33.856483) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 22:36:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-09-22 22:36:34 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183110 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:34.079754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:34.080036) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.138757 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:34.232394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:34.233095) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fa9844b0dee3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fa9844b0dee3 --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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 22:36:34,317 Setting DEBUG logging. 2016-09-22 22:36:34,317 attempt 1/10 2016-09-22 22:36:34,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fa9844b0dee3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 22:36:34,786 unpacking tar archive at: mozilla-inbound-fa9844b0dee3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:35.064773) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:35.065279) ========= script_repo_revision: fa9844b0dee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:35.065855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:35.066259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 22:36:35.076580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-22 22:36:35.076856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:36:35 INFO - MultiFileLogger online at 20160922 22:36:35 in /builds/slave/test 22:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:36:35 INFO - {'append_to_log': False, 22:36:35 INFO - 'base_work_dir': '/builds/slave/test', 22:36:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:36:35 INFO - 'branch': 'Mozilla-Inbound', 22:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:36:35 INFO - 'config_files': ('talos/linux_config.py',), 22:36:35 INFO - 'default_actions': ('clobber', 22:36:35 INFO - 'read-buildbot-config', 22:36:35 INFO - 'download-and-extract', 22:36:35 INFO - 'populate-webroot', 22:36:35 INFO - 'create-virtualenv', 22:36:35 INFO - 'install', 22:36:35 INFO - 'run-tests'), 22:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:36:35 INFO - 'download_minidump_stackwalk': True, 22:36:35 INFO - 'download_symbols': 'ondemand', 22:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:36:35 INFO - 'installer_path': 'installer.exe', 22:36:35 INFO - 'log_level': 'info', 22:36:35 INFO - 'log_name': 'talos', 22:36:35 INFO - 'log_to_console': True, 22:36:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:36:35 INFO - 'opt_config_files': (), 22:36:35 INFO - 'pip_index': False, 22:36:35 INFO - 'sps_profile': False, 22:36:35 INFO - 'sps_profile_interval': 0, 22:36:35 INFO - 'suite': 'dromaeojs-e10s', 22:36:35 INFO - 'system_bits': '32', 22:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:36:35 INFO - 'title': 'talos-linux64-ix-068', 22:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:36:35 INFO - 'use_talos_json': True, 22:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:36:35 INFO - 'work_dir': 'build'} 22:36:35 INFO - [mozharness: 2016-09-23 05:36:35.414427Z] Running clobber step. 22:36:35 INFO - Running pre-action listener: _resource_record_pre_action 22:36:35 INFO - Running main action method: clobber 22:36:35 INFO - rmtree: /builds/slave/test/build 22:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:36:39 INFO - Running post-action listener: _resource_record_post_action 22:36:39 INFO - [mozharness: 2016-09-23 05:36:39.637398Z] Finished clobber step (success) 22:36:39 INFO - [mozharness: 2016-09-23 05:36:39.637520Z] Running read-buildbot-config step. 22:36:39 INFO - Running pre-action listener: _resource_record_pre_action 22:36:39 INFO - Running main action method: read_buildbot_config 22:36:39 INFO - Using buildbot properties: 22:36:39 INFO - { 22:36:39 INFO - "project": "", 22:36:39 INFO - "product": "firefox", 22:36:39 INFO - "script_repo_revision": "production", 22:36:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:36:39 INFO - "repository": "", 22:36:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:36:39 INFO - "buildid": "20160922193455", 22:36:39 INFO - "pgo_build": "True", 22:36:39 INFO - "basedir": "/builds/slave/test", 22:36:39 INFO - "buildnumber": 1203, 22:36:39 INFO - "slavename": "talos-linux64-ix-068", 22:36:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:36:39 INFO - "platform": "ubuntu64_hw", 22:36:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:36:39 INFO - "branch": "mozilla-inbound", 22:36:39 INFO - "repo_path": "integration/mozilla-inbound", 22:36:39 INFO - "revision": "fa9844b0dee3", 22:36:39 INFO - "stage_platform": "linux64-pgo", 22:36:39 INFO - "builduid": "31aa310a994946c8a3c98cfefd9536c3", 22:36:39 INFO - "slavebuilddir": "test" 22:36:39 INFO - } 22:36:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:36:39 INFO - Running post-action listener: _resource_record_post_action 22:36:39 INFO - [mozharness: 2016-09-23 05:36:39.640490Z] Finished read-buildbot-config step (success) 22:36:39 INFO - [mozharness: 2016-09-23 05:36:39.640599Z] Running download-and-extract step. 22:36:39 INFO - Running pre-action listener: _resource_record_pre_action 22:36:39 INFO - Running main action method: download_and_extract 22:36:39 INFO - mkdir: /builds/slave/test/build/tests 22:36:39 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')]} 22:36:39 INFO - trying https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:36:39 INFO - Downloading https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:36:40 INFO - Downloaded 1361 bytes. 22:36:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:36:40 INFO - Using the following test package requirements: 22:36:40 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:36:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:36:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:36:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'jsshell-linux-x86_64.zip'], 22:36:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:36:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:36:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:36:40 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:36:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:36:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:36:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:36:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:36:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:36:40 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:36:40 INFO - Expected file size: 21950401 22:36:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:36:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:36:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:36:45 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:36:46 INFO - Expected file size: 21950401 22:36:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:36:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:36:51 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:36:51 INFO - Expected file size: 14414059 22:36: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')]} 22:36:52 INFO - trying https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:36:52 INFO - Downloading https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:36:54 INFO - Downloaded 63331295 bytes. 22:36:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:36:54 INFO - mkdir: /builds/slave/test/properties 22:36:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:36:54 INFO - Writing to file /builds/slave/test/properties/build_url 22:36:54 INFO - Contents: 22:36:54 INFO - build_url:https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:36:54 INFO - Running post-action listener: _resource_record_post_action 22:36:54 INFO - Running post-action listener: set_extra_try_arguments 22:36:54 INFO - [mozharness: 2016-09-23 05:36:54.696538Z] Finished download-and-extract step (success) 22:36:54 INFO - [mozharness: 2016-09-23 05:36:54.696765Z] Running populate-webroot step. 22:36:54 INFO - Running pre-action listener: _resource_record_pre_action 22:36:54 INFO - Running main action method: populate_webroot 22:36:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:36:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:36:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:36:54 INFO - '--tppagecycles', 22:36:54 INFO - '7'], 22:36:54 INFO - 'tests': ['tsvgm']}}, 22:36:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:36:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:36:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:36:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:36:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['damp', 'tps']}, 22:36:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'tests': ['damp', 'tps']}, 22:36:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['dromaeo_dom']}, 22:36:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:36:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['basic_compositor_video']}, 22:36:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:36:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'other-e10s': {'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['a11yr', 22:36:54 INFO - 'ts_paint', 22:36:54 INFO - 'tpaint', 22:36:54 INFO - 'sessionrestore', 22:36:54 INFO - 'sessionrestore_no_auto_restore', 22:36:54 INFO - 'tabpaint']}, 22:36:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['tsvgx', 22:36:54 INFO - 'tsvgr_opacity', 22:36:54 INFO - 'tart', 22:36:54 INFO - 'tscrollx', 22:36:54 INFO - 'cart']}, 22:36:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:36:54 INFO - 'tsvgr_opacity', 22:36:54 INFO - 'tart', 22:36:54 INFO - 'tscrollx', 22:36:54 INFO - 'cart']}, 22:36:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'talos_options': ['--disable-e10s'], 22:36:54 INFO - 'tests': ['tp5o']}, 22:36:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'tests': ['tp5o']}, 22:36:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'talos_options': ['--disable-e10s', 22:36:54 INFO - '--xperf_path', 22:36:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:54 INFO - 'tests': ['tp5n']}, 22:36:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:54 INFO - 'talos_options': ['--xperf_path', 22:36:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:54 INFO - 'tests': ['tp5n']}}, 22:36:54 INFO - 'talos.zip': {'path': '', 22:36:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:36:54 INFO - Running post-action listener: _resource_record_post_action 22:36:54 INFO - [mozharness: 2016-09-23 05:36:54.715687Z] Finished populate-webroot step (success) 22:36:54 INFO - [mozharness: 2016-09-23 05:36:54.715776Z] Running create-virtualenv step. 22:36:54 INFO - Running pre-action listener: _resource_record_pre_action 22:36:54 INFO - Running main action method: create_virtualenv 22:36:54 INFO - Creating virtualenv /builds/slave/test/build/venv 22:36:54 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 22:36:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:36:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:36:54 INFO - Using real prefix '/usr' 22:36:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:36:55 INFO - Installing distribute.............................................................................................................................................................................................done. 22:36:57 INFO - Installing pip.................done. 22:36:57 INFO - Return code: 0 22:36:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:36:57 INFO - Using env: {'DISPLAY': ':0', 22:36:57 INFO - 'HOME': '/home/cltbld', 22:36:57 INFO - 'LANG': 'en_US.UTF-8', 22:36:57 INFO - 'LANGUAGE': 'en_US:en', 22:36:57 INFO - 'LOGNAME': 'cltbld', 22:36:57 INFO - 'MAIL': '/var/mail/cltbld', 22:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:57 INFO - 'MOZ_NO_REMOTE': '1', 22:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:57 INFO - 'NO_EM_RESTART': '1', 22:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:57 INFO - 'PWD': '/builds/slave/test', 22:36:57 INFO - 'SHELL': '/bin/bash', 22:36:57 INFO - 'SHLVL': '1', 22:36:57 INFO - 'TERM': 'linux', 22:36:57 INFO - 'TMOUT': '86400', 22:36:57 INFO - 'USER': 'cltbld', 22:36:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:57 INFO - '_': '/tools/buildbot/bin/python'} 22:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:57 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 22:36:57 INFO - Cleaning up... 22:36:57 INFO - Return code: 0 22:36:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:36:57 INFO - Using env: {'DISPLAY': ':0', 22:36:57 INFO - 'HOME': '/home/cltbld', 22:36:57 INFO - 'LANG': 'en_US.UTF-8', 22:36:57 INFO - 'LANGUAGE': 'en_US:en', 22:36:57 INFO - 'LOGNAME': 'cltbld', 22:36:57 INFO - 'MAIL': '/var/mail/cltbld', 22:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:57 INFO - 'MOZ_NO_REMOTE': '1', 22:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:57 INFO - 'NO_EM_RESTART': '1', 22:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:57 INFO - 'PWD': '/builds/slave/test', 22:36:57 INFO - 'SHELL': '/bin/bash', 22:36:57 INFO - 'SHLVL': '1', 22:36:57 INFO - 'TERM': 'linux', 22:36:57 INFO - 'TMOUT': '86400', 22:36:57 INFO - 'USER': 'cltbld', 22:36:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:57 INFO - '_': '/tools/buildbot/bin/python'} 22:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:57 INFO - Downloading/unpacking psutil>=3.1.1 22:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:36:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:59 INFO - Installing collected packages: psutil 22:36:59 INFO - Running setup.py install for psutil 22:37:00 INFO - building 'psutil._psutil_linux' extension 22:37:00 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 22:37:01 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 22:37:01 INFO - building 'psutil._psutil_posix' extension 22:37:01 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 22:37:01 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 22:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:01 INFO - Successfully installed psutil 22:37:01 INFO - Cleaning up... 22:37:01 INFO - Return code: 0 22:37:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:01 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:01 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 22:37:01 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 22:37:01 INFO - Using env: {'DISPLAY': ':0', 22:37:01 INFO - 'HOME': '/home/cltbld', 22:37:01 INFO - 'LANG': 'en_US.UTF-8', 22:37:01 INFO - 'LANGUAGE': 'en_US:en', 22:37:01 INFO - 'LOGNAME': 'cltbld', 22:37:01 INFO - 'MAIL': '/var/mail/cltbld', 22:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:01 INFO - 'MOZ_NO_REMOTE': '1', 22:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:01 INFO - 'NO_EM_RESTART': '1', 22:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:01 INFO - 'PWD': '/builds/slave/test', 22:37:01 INFO - 'SHELL': '/bin/bash', 22:37:01 INFO - 'SHLVL': '1', 22:37:01 INFO - 'TERM': 'linux', 22:37:01 INFO - 'TMOUT': '86400', 22:37:01 INFO - 'USER': 'cltbld', 22:37:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:01 INFO - '_': '/tools/buildbot/bin/python'} 22:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:37:01 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 22:37:01 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 22:37:01 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 22:37:01 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 22:37:01 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 22:37:01 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 22:37:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:37:03 INFO - Installing collected packages: mozsystemmonitor 22:37:03 INFO - Running setup.py install for mozsystemmonitor 22:37:03 INFO - Successfully installed mozsystemmonitor 22:37:03 INFO - Cleaning up... 22:37:03 INFO - Return code: 0 22:37:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:03 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:03 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 22:37:03 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 22:37:03 INFO - Using env: {'DISPLAY': ':0', 22:37:03 INFO - 'HOME': '/home/cltbld', 22:37:03 INFO - 'LANG': 'en_US.UTF-8', 22:37:03 INFO - 'LANGUAGE': 'en_US:en', 22:37:03 INFO - 'LOGNAME': 'cltbld', 22:37:03 INFO - 'MAIL': '/var/mail/cltbld', 22:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:03 INFO - 'MOZ_NO_REMOTE': '1', 22:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:03 INFO - 'NO_EM_RESTART': '1', 22:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:03 INFO - 'PWD': '/builds/slave/test', 22:37:03 INFO - 'SHELL': '/bin/bash', 22:37:03 INFO - 'SHLVL': '1', 22:37:03 INFO - 'TERM': 'linux', 22:37:03 INFO - 'TMOUT': '86400', 22:37:03 INFO - 'USER': 'cltbld', 22:37:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:03 INFO - '_': '/tools/buildbot/bin/python'} 22:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:04 INFO - Downloading/unpacking jsonschema==2.5.1 22:37:04 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 22:37:04 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 22:37:04 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 22:37:04 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 22:37:04 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 22:37:04 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 22:37:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:37:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 INFO - Downloading functools32-3.2.3-2.tar.gz 22:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:37:06 INFO - warning: no files found matching '*.txt' 22:37:06 INFO - no previously-included directories found matching 'build' 22:37:06 INFO - no previously-included directories found matching 'dist' 22:37:06 INFO - no previously-included directories found matching '.git*' 22:37:06 INFO - Installing collected packages: jsonschema, functools32 22:37:06 INFO - Running setup.py install for functools32 22:37:06 INFO - warning: no files found matching '*.txt' 22:37:06 INFO - no previously-included directories found matching 'build' 22:37:06 INFO - no previously-included directories found matching 'dist' 22:37:06 INFO - no previously-included directories found matching '.git*' 22:37:06 INFO - Successfully installed jsonschema functools32 22:37:06 INFO - Cleaning up... 22:37:06 INFO - Return code: 0 22:37:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:06 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:06 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 22:37:06 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 22:37:06 INFO - Using env: {'DISPLAY': ':0', 22:37:06 INFO - 'HOME': '/home/cltbld', 22:37:06 INFO - 'LANG': 'en_US.UTF-8', 22:37:06 INFO - 'LANGUAGE': 'en_US:en', 22:37:06 INFO - 'LOGNAME': 'cltbld', 22:37:06 INFO - 'MAIL': '/var/mail/cltbld', 22:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:06 INFO - 'MOZ_NO_REMOTE': '1', 22:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:06 INFO - 'NO_EM_RESTART': '1', 22:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:06 INFO - 'PWD': '/builds/slave/test', 22:37:06 INFO - 'SHELL': '/bin/bash', 22:37:06 INFO - 'SHLVL': '1', 22:37:06 INFO - 'TERM': 'linux', 22:37:06 INFO - 'TMOUT': '86400', 22:37:06 INFO - 'USER': 'cltbld', 22:37:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:06 INFO - '_': '/tools/buildbot/bin/python'} 22:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:37:06 INFO - Cleaning up... 22:37:06 INFO - Return code: 0 22:37:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:06 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:06 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 22:37:06 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 22:37:06 INFO - Using env: {'DISPLAY': ':0', 22:37:06 INFO - 'HOME': '/home/cltbld', 22:37:06 INFO - 'LANG': 'en_US.UTF-8', 22:37:06 INFO - 'LANGUAGE': 'en_US:en', 22:37:06 INFO - 'LOGNAME': 'cltbld', 22:37:06 INFO - 'MAIL': '/var/mail/cltbld', 22:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:06 INFO - 'MOZ_NO_REMOTE': '1', 22:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:06 INFO - 'NO_EM_RESTART': '1', 22:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:06 INFO - 'PWD': '/builds/slave/test', 22:37:06 INFO - 'SHELL': '/bin/bash', 22:37:06 INFO - 'SHLVL': '1', 22:37:06 INFO - 'TERM': 'linux', 22:37:06 INFO - 'TMOUT': '86400', 22:37:06 INFO - 'USER': 'cltbld', 22:37:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:06 INFO - '_': '/tools/buildbot/bin/python'} 22:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:06 INFO - Downloading/unpacking blobuploader==1.2.4 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:06 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 22:37:08 INFO - Downloading blobuploader-1.2.4.tar.gz 22:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:37:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:37:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:37:09 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 22:37:09 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 22:37:09 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 22:37:09 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 22:37:09 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 22:37:09 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 22:37:09 INFO - Downloading docopt-0.6.1.tar.gz 22:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 22:37:09 INFO - Running setup.py install for blobuploader 22:37:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:37:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:37:09 INFO - Running setup.py install for requests 22:37:10 INFO - Running setup.py install for docopt 22:37:10 INFO - Successfully installed blobuploader requests docopt 22:37:10 INFO - Cleaning up... 22:37:10 INFO - Return code: 0 22:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:10 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:10 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 22:37:10 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 22:37:10 INFO - Using env: {'DISPLAY': ':0', 22:37:10 INFO - 'HOME': '/home/cltbld', 22:37:10 INFO - 'LANG': 'en_US.UTF-8', 22:37:10 INFO - 'LANGUAGE': 'en_US:en', 22:37:10 INFO - 'LOGNAME': 'cltbld', 22:37:10 INFO - 'MAIL': '/var/mail/cltbld', 22:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:10 INFO - 'MOZ_NO_REMOTE': '1', 22:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:10 INFO - 'NO_EM_RESTART': '1', 22:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:10 INFO - 'PWD': '/builds/slave/test', 22:37:10 INFO - 'SHELL': '/bin/bash', 22:37:10 INFO - 'SHLVL': '1', 22:37:10 INFO - 'TERM': 'linux', 22:37:10 INFO - 'TMOUT': '86400', 22:37:10 INFO - 'USER': 'cltbld', 22:37:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:10 INFO - '_': '/tools/buildbot/bin/python'} 22:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:10 INFO - Running setup.py (path:/tmp/pip-VJtLij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:10 INFO - Running setup.py (path:/tmp/pip-xBGt2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:10 INFO - Running setup.py (path:/tmp/pip-IPPjoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:10 INFO - Running setup.py (path:/tmp/pip-ujAuRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:10 INFO - Running setup.py (path:/tmp/pip-Ltr_Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:10 INFO - Running setup.py (path:/tmp/pip-cqiibH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:10 INFO - Running setup.py (path:/tmp/pip-tJx4Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:10 INFO - Running setup.py (path:/tmp/pip-fnMC40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:11 INFO - Running setup.py (path:/tmp/pip-fBzaG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:11 INFO - Running setup.py (path:/tmp/pip-4HNo6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:11 INFO - Running setup.py (path:/tmp/pip-6Iu999-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:11 INFO - Running setup.py (path:/tmp/pip-kgGvn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:11 INFO - Running setup.py (path:/tmp/pip-skR_br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:11 INFO - Running setup.py (path:/tmp/pip-YziFGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:11 INFO - Running setup.py (path:/tmp/pip-UYUJq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:11 INFO - Running setup.py (path:/tmp/pip-JLZq0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:11 INFO - Running setup.py (path:/tmp/pip-uijR9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:37:11 INFO - Running setup.py install for manifestparser 22:37:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:37:11 INFO - Running setup.py install for mozcrash 22:37:11 INFO - Running setup.py install for mozdebug 22:37:12 INFO - Running setup.py install for mozdevice 22:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for mozfile 22:37:12 INFO - Running setup.py install for mozhttpd 22:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for mozinfo 22:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for mozInstall 22:37:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for mozleak 22:37:12 INFO - Running setup.py install for mozlog 22:37:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for moznetwork 22:37:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:37:12 INFO - Running setup.py install for mozprocess 22:37:12 INFO - Running setup.py install for mozprofile 22:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:37:13 INFO - Running setup.py install for mozrunner 22:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:37:13 INFO - Running setup.py install for mozscreenshot 22:37:13 INFO - Running setup.py install for moztest 22:37:13 INFO - Running setup.py install for mozversion 22:37:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:37:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:37:13 INFO - Cleaning up... 22:37:13 INFO - Return code: 0 22:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:13 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:13 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 22:37:13 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 22:37:13 INFO - Using env: {'DISPLAY': ':0', 22:37:13 INFO - 'HOME': '/home/cltbld', 22:37:13 INFO - 'LANG': 'en_US.UTF-8', 22:37:13 INFO - 'LANGUAGE': 'en_US:en', 22:37:13 INFO - 'LOGNAME': 'cltbld', 22:37:13 INFO - 'MAIL': '/var/mail/cltbld', 22:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:13 INFO - 'MOZ_NO_REMOTE': '1', 22:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:13 INFO - 'NO_EM_RESTART': '1', 22:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:13 INFO - 'PWD': '/builds/slave/test', 22:37:13 INFO - 'SHELL': '/bin/bash', 22:37:13 INFO - 'SHLVL': '1', 22:37:13 INFO - 'TERM': 'linux', 22:37:13 INFO - 'TMOUT': '86400', 22:37:13 INFO - 'USER': 'cltbld', 22:37:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:13 INFO - '_': '/tools/buildbot/bin/python'} 22:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:13 INFO - Running setup.py (path:/tmp/pip-SB_D90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:13 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)) 22:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:13 INFO - Running setup.py (path:/tmp/pip-GBoR4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:13 INFO - Running setup.py (path:/tmp/pip-le2zeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:13 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)) 22:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:13 INFO - Running setup.py (path:/tmp/pip-WAzCtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:14 INFO - Running setup.py (path:/tmp/pip-iOLXxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:14 INFO - Running setup.py (path:/tmp/pip-0MT3U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:14 INFO - Running setup.py (path:/tmp/pip-MPwIDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:14 INFO - Running setup.py (path:/tmp/pip-NvVqab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:14 INFO - Running setup.py (path:/tmp/pip-O0p3N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:14 INFO - Running setup.py (path:/tmp/pip-V1SkL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:14 INFO - Running setup.py (path:/tmp/pip-6sTwL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:14 INFO - Running setup.py (path:/tmp/pip-WyrBi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:14 INFO - Running setup.py (path:/tmp/pip-R9HTqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:14 INFO - Running setup.py (path:/tmp/pip-VC2lDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:14 INFO - Running setup.py (path:/tmp/pip-lyYBXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:14 INFO - Running setup.py (path:/tmp/pip-_WHXUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:14 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)) 22:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:14 INFO - Running setup.py (path:/tmp/pip-zGClDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:14 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)) 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:14 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)) 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:37:14 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 22:37:14 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 22:37:14 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 22:37:14 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 22:37:14 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 22:37:14 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 22:37:16 INFO - Downloading blessings-1.6.tar.gz 22:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:37:16 INFO - Installing collected packages: blessings 22:37:16 INFO - Running setup.py install for blessings 22:37:17 INFO - Successfully installed blessings 22:37:17 INFO - Cleaning up... 22:37:17 INFO - Return code: 0 22:37:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:17 INFO - Reading from file tmpfile_stdout 22:37:17 INFO - Current package versions: 22:37:17 INFO - argparse == 1.2.1 22:37:17 INFO - blessings == 1.6 22:37:17 INFO - blobuploader == 1.2.4 22:37:17 INFO - docopt == 0.6.1 22:37:17 INFO - functools32 == 3.2.3-2 22:37:17 INFO - jsonschema == 2.5.1 22:37:17 INFO - manifestparser == 1.1 22:37:17 INFO - mozInstall == 1.12 22:37:17 INFO - mozcrash == 0.17 22:37:17 INFO - mozdebug == 0.1 22:37:17 INFO - mozdevice == 0.48 22:37:17 INFO - mozfile == 1.2 22:37:17 INFO - mozhttpd == 0.7 22:37:17 INFO - mozinfo == 0.9 22:37:17 INFO - mozleak == 0.1 22:37:17 INFO - mozlog == 3.4 22:37:17 INFO - moznetwork == 0.27 22:37:17 INFO - mozprocess == 0.23 22:37:17 INFO - mozprofile == 0.28 22:37:17 INFO - mozrunner == 6.12 22:37:17 INFO - mozscreenshot == 0.1 22:37:17 INFO - mozsystemmonitor == 0.3 22:37:17 INFO - moztest == 0.7 22:37:17 INFO - mozversion == 1.4 22:37:17 INFO - psutil == 3.1.1 22:37:17 INFO - requests == 1.2.3 22:37:17 INFO - wsgiref == 0.1.2 22:37:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:17 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:17 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 22:37:17 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 22:37:17 INFO - Using env: {'DISPLAY': ':0', 22:37:17 INFO - 'HOME': '/home/cltbld', 22:37:17 INFO - 'LANG': 'en_US.UTF-8', 22:37:17 INFO - 'LANGUAGE': 'en_US:en', 22:37:17 INFO - 'LOGNAME': 'cltbld', 22:37:17 INFO - 'MAIL': '/var/mail/cltbld', 22:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:17 INFO - 'MOZ_NO_REMOTE': '1', 22:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:17 INFO - 'NO_EM_RESTART': '1', 22:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:17 INFO - 'PWD': '/builds/slave/test', 22:37:17 INFO - 'SHELL': '/bin/bash', 22:37:17 INFO - 'SHLVL': '1', 22:37:17 INFO - 'TERM': 'linux', 22:37:17 INFO - 'TMOUT': '86400', 22:37:17 INFO - 'USER': 'cltbld', 22:37:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:17 INFO - '_': '/tools/buildbot/bin/python'} 22:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 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)) 22:37:17 INFO - Cleaning up... 22:37:17 INFO - Return code: 0 22:37:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:17 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 0x7fcfa3dc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1990ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', '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 22:37:17 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 22:37:17 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 22:37:17 INFO - Using env: {'DISPLAY': ':0', 22:37:17 INFO - 'HOME': '/home/cltbld', 22:37:17 INFO - 'LANG': 'en_US.UTF-8', 22:37:17 INFO - 'LANGUAGE': 'en_US:en', 22:37:17 INFO - 'LOGNAME': 'cltbld', 22:37:17 INFO - 'MAIL': '/var/mail/cltbld', 22:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:17 INFO - 'MOZ_NO_REMOTE': '1', 22:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:17 INFO - 'NO_EM_RESTART': '1', 22:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:17 INFO - 'PWD': '/builds/slave/test', 22:37:17 INFO - 'SHELL': '/bin/bash', 22:37:17 INFO - 'SHLVL': '1', 22:37:17 INFO - 'TERM': 'linux', 22:37:17 INFO - 'TMOUT': '86400', 22:37:17 INFO - 'USER': 'cltbld', 22:37:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:17 INFO - '_': '/tools/buildbot/bin/python'} 22:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:37:17 INFO - Cleaning up... 22:37:17 INFO - Return code: 0 22:37:17 INFO - Running post-action listener: _resource_record_post_action 22:37:17 INFO - Running post-action listener: _start_resource_monitoring 22:37:17 INFO - Starting resource monitoring. 22:37:17 INFO - [mozharness: 2016-09-23 05:37:17.846896Z] Finished create-virtualenv step (success) 22:37:17 INFO - [mozharness: 2016-09-23 05:37:17.847868Z] Running install step. 22:37:17 INFO - Running pre-action listener: _resource_record_pre_action 22:37:17 INFO - Running main action method: install 22:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:18 INFO - Reading from file tmpfile_stdout 22:37:18 INFO - Detecting whether we're running mozinstall >=1.0... 22:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:37:18 INFO - Reading from file tmpfile_stdout 22:37:18 INFO - Output received: 22:37:18 INFO - Usage: mozinstall [options] installer 22:37:18 INFO - Options: 22:37:18 INFO - -h, --help show this help message and exit 22:37:18 INFO - -d DEST, --destination=DEST 22:37:18 INFO - Directory to install application into. [default: 22:37:18 INFO - "/builds/slave/test"] 22:37:18 INFO - --app=APP Application being installed. [default: firefox] 22:37:18 INFO - mkdir: /builds/slave/test/build/application 22:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:37:35 INFO - Reading from file tmpfile_stdout 22:37:35 INFO - Output received: 22:37:35 INFO - /builds/slave/test/build/application/firefox/firefox 22:37:35 INFO - Running post-action listener: _resource_record_post_action 22:37:35 INFO - [mozharness: 2016-09-23 05:37:35.450554Z] Finished install step (success) 22:37:35 INFO - [mozharness: 2016-09-23 05:37:35.450800Z] Running run-tests step. 22:37:35 INFO - Running pre-action listener: _resource_record_pre_action 22:37:35 INFO - Running main action method: run_tests 22:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:37:35 INFO - Python 2.7.3 22:37:35 INFO - Return code: 0 22:37:35 INFO - grabbing minidump binary from tooltool 22:37: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')]} 22:37:35 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 0x198df60>, '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 0x198ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:37:35 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 22:37:35 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 22:37:35 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 22:37:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:37:35 INFO - Return code: 0 22:37:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:37:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:37:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:37:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:37:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 22:37:35 INFO - Using env: {'DISPLAY': ':0', 22:37:35 INFO - 'HOME': '/home/cltbld', 22:37:35 INFO - 'LANG': 'en_US.UTF-8', 22:37:35 INFO - 'LANGUAGE': 'en_US:en', 22:37:35 INFO - 'LOGNAME': 'cltbld', 22:37:35 INFO - 'MAIL': '/var/mail/cltbld', 22:37:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:37:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:35 INFO - 'MOZ_NO_REMOTE': '1', 22:37:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:35 INFO - 'NO_EM_RESTART': '1', 22:37:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:35 INFO - 'PWD': '/builds/slave/test', 22:37:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:37:35 INFO - 'SHELL': '/bin/bash', 22:37:35 INFO - 'SHLVL': '1', 22:37:35 INFO - 'TERM': 'linux', 22:37:35 INFO - 'TMOUT': '86400', 22:37:35 INFO - 'USER': 'cltbld', 22:37:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850', 22:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:35 INFO - '_': '/tools/buildbot/bin/python'} 22:37:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:37:35 INFO - mozversion application_buildid: 20160922193455 22:37:35 INFO - mozversion application_changeset: fa9844b0dee37aeb4c94d027f7c68a94721db320 22:37:35 INFO - mozversion application_display_name: Nightly 22:37:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:37:35 INFO - mozversion application_name: Firefox 22:37:35 INFO - mozversion application_remotingname: firefox 22:37:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:37:35 INFO - mozversion application_vendor: Mozilla 22:37:35 INFO - mozversion application_version: 52.0a1 22:37:35 INFO - mozversion platform_buildid: 20160922193455 22:37:35 INFO - mozversion platform_changeset: fa9844b0dee37aeb4c94d027f7c68a94721db320 22:37:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:37:35 INFO - mozversion platform_version: 52.0a1 22:37:35 INFO - using testdate: 1474609055 22:37:35 INFO - actual date: 1474609055 22:37:35 INFO - starting webserver on 'localhost:48486' 22:37:35 INFO - SUITE-START | Running 2 tests 22:37:35 INFO - TEST-START | dromaeo_css 22:37:35 INFO - operating with platform_type : linux_ 22:37:35 INFO - Initialising browser for dromaeo_css test... 22:37:36 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD8ZG_/profile http://localhost:48486/getInfo.html) 22:37:41 INFO - PROCESS | 3377 | __metrics Screen width/height:1600/1200 22:37:41 INFO - PROCESS | 3377 | colorDepth:24 22:37:41 INFO - PROCESS | 3377 | Browser inner width/height: 1024/697 22:37:41 INFO - PROCESS | 3377 | __metrics 22:37:42 ERROR - PROCESS | 3377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:37:43 INFO - TEST-INFO | 3377: exit 0 22:37:43 INFO - Browser initialized. 22:37:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:37:43 INFO - TEST-INFO | started process 3501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD8ZG_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:37:55 INFO - PROCESS | 3501 | RSS: Main: 181354496 22:37:55 INFO - PROCESS | 3501 | 22:38:45 INFO - PROCESS | 3501 | 1474609125296 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:40:55 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48486/tests/dromaeo/cssquery-ext.html) 22:40:57 INFO - PROCESS | 3501 | RSS: Main: 195334144 22:40:57 INFO - PROCESS | 3501 | 22:43:59 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-ext.html (next: http://localhost:48486/tests/dromaeo/cssquery-jquery.html) 22:43:59 INFO - PROCESS | 3501 | RSS: Main: 192835584 22:43:59 INFO - PROCESS | 3501 | 22:47:01 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48486/tests/dromaeo/cssquery-mootools.html) 22:47:02 INFO - PROCESS | 3501 | RSS: Main: 193667072 22:47:02 INFO - PROCESS | 3501 | 22:50:04 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48486/tests/dromaeo/cssquery-prototype.html) 22:50:04 INFO - PROCESS | 3501 | RSS: Main: 190676992 22:50:04 INFO - PROCESS | 3501 | 22:53:07 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48486/tests/dromaeo/cssquery-yui.html) 22:53:08 INFO - PROCESS | 3501 | RSS: Main: 194572288 22:53:08 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-yui.html (next: http://localhost:48486/tests/dromaeo/cssquery-dojo.html) 22:56:10 INFO - PROCESS | 3501 | RSS: Main: 195162112 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | __start_tp_report 22:56:10 INFO - PROCESS | 3501 | _x_x_mozilla_page_load 22:56:10 INFO - PROCESS | 3501 | _x_x_mozilla_page_load_details 22:56:10 INFO - PROCESS | 3501 | |i|pagename|runs| 22:56:10 INFO - PROCESS | 3501 | |0;dojo.html;3063.8008529445597;3068.5090385538315;3097.9535306970383;3101.379724055189;3113.984430077849;5432.049391356507;5507.697076660787;5584.301962254724;5595.300587426572;5626.212330273765;5467.343918729758;5515.420880807517;5529.391766905637;5534.944650553493;5590.468905453986;4826.3001864729595;5027.748612569357;5051.494850514947;5167.896642067157;5215.973920130413;5131.307273518065;5135.35808023997;5150.1759718445055;5155.510226528474;5204.947950520503;4880.41435027799;4929.408470983469;5089.7455127243675;5158.3552055993005;5170.276161337416;4892.192788189945;4905.411350637911;4955.752212389366;4956.975215123937;5021.472745361758;4907.411110666707;4925.3597032385915;5014.548690617826;5019.970905964268;5061.569766569846;5445.264889239941;5451.3458384993655;5510.173473978935;5540.889182216373;5543.6119471637;5916.97041514794;5936.347001829795;5957.642541447527;5966.820995370146;6021;5958.195643588104;5970.044792833126;5985.281766188042;6010.78962236324;6028.367021462727;5409.0534156522845;5438.048341540294;5557.527610153183;5591.217229587861;5591.496765291103;6005.669688167192;6086.444144050445;6088.795763799083;6092.62857369438;6096.194094249989;5829.8251052468495;5833.82498525045;5859.501942334864;5891.882162356729;5898.911516327258;5728.885422291614;5831.737571809279;5890.617109887844;5921.7631294747725;5945.2865656120675;5876.6180198286975;5879.7060146993335;5897.528197744256;5948.970255148696;5951.494122999594;5886.705664716833;5903;5927.525797936241;5935.2877654681715;5942.3166335871065;4469.865904022885;4494.303382975644;4501.0547784964865;4611.608013318838;4657.790399432034;4032.1532478179324;4067.8372865085657;4081.0409553754844;4099;4160.2303573838935;5548.4174161713245;5707.600467967202;5709.7716091356715;5722.484976352148;5758.309002919593;5773.740181691834;6009.459148676553;6023.668698221552;6028;6042.305134909454;5487.149491828773;5525.11598144295;5536.335639723259;5548.195511650869;5598.552115830724;5148.279240906276;5155.097857874857;5156.226566015052;5219.973900130475;5222;6116.388361163937;6143.293521245114;6197.504199664107;6201.627902325785;6232.220972378453;5729.28383952006;5825.0679891217205;5949.8215053548465;5962.016267315845;5971.373005834499;6111.500579230132;6112.442689633966;6175.042868355412;6273.404026617464;6282.780102696383;5716.657000579979;5882.1470886722045;5885.087811389241;5895.056790913433;5954.880902382015;5858.150568167677;5914.112883067574;5955.702214889325;6028.156058151774;6033.78881739137;5584.553235741212;5630.5214056805635;5846.56150788684;5848.53211743068;5857.384974577608;5762;5788.681622510802;5792.362840087502;5819.476247137778;5888.205092312654;5720.48515633595;5755.338136114233;5760.193572899713;5787.710614469344;5789.247397838254;5731.283589551306;5852.3269823969085;5881.5588830837005;5883.764649413975;5890.823275301748;5618.69097199658;5651.15232715096;5719.599628025998;5720.713964301852;5792.0443126885275 22:56:10 INFO - PROCESS | 3501 | |1;ext.html;546.4267592990125;572.7823427097702;580.2891457963992;595.4819307202733;608.2943785209159;40842;42618.57381426189;42763.78618106905;46332.768336158275;46457.53542464574;44361.334579981325;44362;44566.7771661142;44678;45038;8529.957350213255;8803.603837827313;8861.645534178626;8869.334799890034;8892.066333035034;8861.911380886206;8938.329625278131;8949;8955;8975.371723979291;8825.558722063903;8904.465732056065;9009.414388064788;9010.639574417015;9011.18899299063;8857.247133993618;8887.511186884718;8921.107889211093;8972.641094356251;9021;8789.428687135316;8884.200421962054;8894.42186257891;8919.777005574848;8932.732018039469;30940.226494337596;31087;31101.84449077763;31129.8443507781;31130.533042004387;2734.931626709328;2873.454043731684;2926.1514160893316;3024.45591204845;3144.119646498984;30892.382152356826;31014.689853101405;31520.211994700316;32425.351492970007;33070.50394244088;4240.915181696349;4245.745255284693;4249.915001699979;4278.165757677254;4293.420388247578;346853;351075;351268;351371.2431437852;352019;31517.212069698442;32280.192995175308;32401.675983239867;48157.27764083542;48638.756806215744;36740.44889326662;36827.26345473075;36967.81516092456;37043.629563704555;37170.44244336337;14115.364808583638;14199.36102875373;14263.85736142646;14291.071080379743;14365.712685746226;11656.53373865036;11695;11732.12009099321;11736.823947640793;11799.941000294944;8413.326933845277;8422.115677853859;8480.279176270085;8539.402241843012;8550.230479256898;3352.6814952579466;3366.242595416061;3379.4423920052914;3385.6445073267446;3393.2874096440023;960.3469640644429;965.9806803863884;1010.9797804043878;1044.0655613226272;1050.5220124843179;32112;32266;32281.031569052964;32302.19244518906;32459.35081298361;1055.2824079625775;1055.3404122423485;1119.5074167366333;1125.386664267976;1153.7807816514835;15943.282552285174;16864.32542698303;16961.745573816403;16990.57523561921;17052.914735426242;578670;582246;582730.1587301587;582799;584402;56718;56918;57442.42557574454;57479;57529.137062944086;1294.4239813283186;1330.6274243211917;1341.8255626768457;1352.594221733476;1356.6811799227173;30054.64480874366;31816.840915795274;31948.68051319457;32372.838135809172;32521;50161.74919125381;50267;50394.49605504045;50567.74716126396;50797;472549;473008;476191;476375;476770;25744.098956537182;25861.224163275132;25938;25988.740112598633;26026.21921342363;45187.32219016783;45672.26512933769;46093.53906460892;46099.76950115362;46816.7659161702;39364.2127157461;39546.80226598849;39811;39832.40251396174;40912.59087409088;38539.42190867195;39207.6079239204;39307.213855722155;40306;40680.59319406887;39861.40207896942;39996.80001599973;40257.597424025385;40941.59058409378;41099.7945010273;32192.517112243804;34619.4807077889;35239.47140792839;35460.113497162776;35941.28117437689;27723;28214.29464263328;28326;28403.43193136167;28548.57177142386 22:56:10 INFO - PROCESS | 3501 | |2;jquery.html;395.45822223553716;398.50585274259925;403.868742658636;405.2947870704973;425.10939581576605;15280.388784448636;17957.7306340405;19414.611707765835;19483.318083867067;19762.604747905032;18717.53206169843;18848.434546963577;18882.150303236354;18974.241030358804;19230.90384548079;5637.943620563783;5722.484976352117;5746.511546518551;5768.336641286264;5805.071188609823;5707.229524014247;5786.103154011114;5797.478226959573;5811.912821307684;5812.50593699534;5596;5756.856078598027;5784.595078344518;5796.8260952171295;5797.71011449428;5568.220449137084;5717.685527295997;5736.1682556029355;5763;5769.249997500298;5665.036943719578;5755.769769209227;5769.942300576982;5789.507891829199;5798.246227990334;13097.738045239137;13598.11612245201;13765.587032389045;13795.931020344935;13837.930810345884;2174.2281490071114;2213.380253529014;2223.944401389962;2591.199116613954;2682.9597556036674;10075.75795408582;10508.211884108723;10988.670339889815;12308.507659693601;14081;1829.7895741989707;1924.4803902946126;1927.180948097053;1933.5552822850682;1971.684530475117;58046.7097664509;83748;84170.57914710448;84800.57599711962;88614.55692721624;10668.199885008655;10745.570177192982;10756.623518176983;10871.239013268996;10993.890061099446;12472.314022728837;13183.802242966363;14967.652911238041;14991.325390357242;15008.774868376982;7417.258274172539;7546.358559522392;7664.961675191588;7675.078990521173;7677.347425468898;7332.706691732377;7504.924950750532;7614.695412183451;7760.146383897767;7763.456558040883;4122.134351786159;4131.793410329472;4199.202151591188;4224.1129362834145;4241.639460645818;1907.4754442528415;1961.578260673962;1961.8430525557922;1967.9704804427945;2048.2319130326127;914.7575892388522;929.2380248196414;975.6487664440796;982.8869679986893;986.5116767200138;17941.451370249764;18943.52641183954;19030.42908712741;19079.80920190808;19565.010922214744;964.344245912786;972.776261459854;996.4121168510613;1036.404067661098;1105.701460605632;10294.536745846455;10435.68692939213;10900.618478353379;10910.23628346008;10930.125589952784;454632;456261;462067;465038;465947.72418206464;76760.84858727123;87642;87652.56173719218;88523;91399;986.4475893499663;1030.5826140413144;1057.2123767793043;1058.539535302146;1065.6643157405392;16540.83459165393;16920;17026.233819478402;17301.56746081358;17342.30630774755;41150.382744259456;41636.791816041936;42298;42649.36025959551;42935.277119516206;56460.43539564716;56501;58112.384942678524;58496.12255816251;59127.40872591391;8035.397345199017;8260.586970651564;8276.668933242603;8461.534615596202;8554.871676924975;9369.344145909721;11839.467223974769;12120;12595.87404125947;13050.086493945713;10971.451427428437;11027.22809403334;11505.42472876336;11654.417279136178;12176.39118044112;5603.0474819281635;7352.558846469229;9203.079692030744;10546.683599492027;11657.18399712012;8459.64920985383;10094.889562148011;10887.673369798918;11235.438228088726;11935.985441237244;7977.960110199412;8168.959155204186;8218.342532597258;8268.503889766633;8301.958490207511;8611.397202196036;11195.496202671062;11246.437678115897;11387;11503.252288601214 22:56:10 INFO - PROCESS | 3501 | |3;mootools.html;1447.8624530669586;1502.8271748748896;1633.5671047172493;1736.1145815634022;1763.2770564068735;8161.55111468869;8426.115257897924;8734.781630459242;9435.386699864504;9436.480993545352;8769.386142969995;8999.280057595393;9061.275097992162;9276.675316363928;9304.395214311066;2360.799332056773;2400.5918993771015;2406.7713567211085;2407.38611654028;2409.204962362425;2375.5486457573006;2381.8928148233285;2407.2537513370826;2414.9637755433682;2426.2478631624253;2400.051979468109;2402.159244264511;2411.2645643078854;2416.903323867043;2421.467277199022;2243.9214627488122;2267.240474441064;2270.920517781878;2273.931782046533;2293.3578597992423;2312.6068568343253;2315.5947709150832;2327.9650805237934;2339.2163625185585;2342.156823543523;8628.870566941501;9115.22520585751;9234.215091717213;9295.860562091573;9319.627214911396;5443.374011988592;5527.336719593634;5529.917051244194;5578.888422231533;5580.386157522669;3462.6364231755556;3475.565554305712;3560.1989552350774;3590.4973303737497;3658.7804731716183;1148.8104462763717;1155.4107405223397;1158.432368139614;1159.0585768837163;1165.4464129538487;12485.93757031209;12710.173838700455;12751.171173873669;12792.104552681316;12819.35903204836;4728.763561821896;4844.75776211188;4855.441624213261;4927.630427717935;4950.950490495121;10667.733306667395;10728.141748660088;10786;10793.892061079288;10802.621908233174;5512.6692398456225;5520.309961254843;5557.3886872444;5561.63849349791;5589.0219211637805;4462.776861156929;4580.38164847748;4933.333999909966;5095.0828850806465;5148.845534633892;3930.8820735377412;4050.1697152084344;4056.7363121397016;4091.5499295077516;4135.958640413617;1280.3022352817736;1316.2628927800463;1318.1497933832625;1323.3780123342015;1324.5165514587106;762.2225330163313;892.5314210039651;910.922571581423;923.5363333432197;931.6599441203912;5774.855628609234;5780.855478612984;5927.199828023162;6033.336333003366;6074.11702372266;915.720705184925;919.7608621758391;920.1396694091046;947.4978261521404;954.0745476887408;3862.1889403225077;4128.298189307825;4150.833966641361;4225.154969006211;4238.766867822299;11028.28316159447;11582.826257606142;11629.709257268636;11674.766504669858;11712.121590880719;11461.197716159955;11482.94258528702;11517.25137866036;11554.075673946065;11572.594959176557;8068.435209535276;8425.410221284574;8439.113893041142;8547.273481753997;8573.657053717907;6001.939980600138;6077.392260773887;6149.96925015372;6151.753929842756;6175.9073613894925;10453.790924181625;10466.424346661006;10594.894051059391;10700.839487407851;10712.839307410552;10326.225533085199;10615.787684246427;10794.08250298702;10879.23845330851;10945.23383363157;7456.589887556236;7599.620018998918;7660.770176894702;7724.304812566896;7765.650545725569;8728.912710873064;8802.29581633455;8816.206541411304;8817.118288171132;8838;7222.566646001257;7284.198738138906;7312.96343518279;7550.395968322631;7823.960880195563;6990.475714321345;7268.890966635399;7396.260373962561;7482.625868706434;7640.503367281109;7257.459889038794;7386.039814824038;7404.259574042768;7409.296116868889;7416.7033318666645;5215;5255.710935898409;5372.274742909657;5462.91805622908;5528.612997090165;5207.3490813648295;5305.363356397257;5313.814016509404;5316.548093411949;5323.733813309396 22:56:10 INFO - PROCESS | 3501 | |4;prototype.html;311.85654598884526;330.796560115529;334.55170072103374;336.16295424393263;338.92543640399106;5481.12302031675;5498.615096943211;5507.586930980183;5515.558755299577;5539.778408863641;5410.56715462763;5486.423925487817;5489.725513724307;5497.862553436166;5515.145152501359;4301.462317210348;4301.849435269766;4302.591253830881;4335.544767799391;4339.652827773771;3893.4743809585625;4170.624643782059;4225.535191128974;4227.429297044906;4314.503832059322;4211.936820947688;4215.3044747616605;4217.641500472449;4231.069164783758;4235.894102647428;4240.342746874239;4250.97874510627;4260.233158031553;4267.722598031118;4281.400603915455;3586.7847929124337;3775.716821238418;3790.7725536467624;3791.203847192093;3792.222594368148;5304.655197412195;5307.442718514578;5316.627836051478;5333.479958211891;5340.572754179656;4838;4849.636277279218;4852.539008794159;4856.295837103636;4865.051314993578;5500.22996780451;5660.773569057233;5670.177824215507;5673.205751194836;5673.659580425187;4089.141280331134;4104.1886307879195;4119.299719047769;4122.227442199853;4164.7709375984305;5806.65160090396;5926.525877929712;6026.608270462406;6031;6055.909161362583;4125.679782469581;4143.91712165755;4169.10364271683;4175.371605073963;4183.226103170923;4226.154769046203;4232.30167022444;4238.689913996817;4238.978805105955;4254.276772948606;4628.583427491474;4879.170541008037;4881.316615673809;4888.877778055577;4891.29076283944;5745.827625171251;5748.281464816898;5766.394528574439;5770.6249093808765;5799.391063938226;1455.7670772676322;1471.4187895781106;1474.8967572269837;1476.2323591732454;1478.1796103162633;880.8062226310202;928.9953550232206;930.9627614895328;946.8390373636498;949.2074118111316;4882.703221165351;4902.460729319772;4910.238912968495;4937.654364194472;4961.387549046574;5130.562982583243;5131.332926719577;5136.614753893473;5176.964607078599;5194.636375453682;4701.529847015339;4869.196582563908;4890.804367825318;4908.3619129513645;4954.355933728592;2739.0960982875604;2749.6562929633797;2751.380939288684;2753.490604238182;2777.5139350613563;5261.684298942076;5293.788248470018;5316.006497563414;5326.162473946482;5385.865353366197;5267.894642107136;5291.947080529222;5656.91514627281;6000.749718855429;6036.607620504653;6140;6149.354317796657;6161.630302181794;6172.259328880473;6189;5571.0807716726285;5891.204687367151;5915.940840591539;5927.288725352985;5956.583039187215;5762.855928601818;5897.292324921037;5913.379095195115;5921.970390148022;5928.614640048383;5890.617109887844;5955.910661339996;6031.336552979256;6045.727942242522;6103.572749907641;4281.529031806436;4293.785310734514;4334.133173365402;4335.241332766816;4356.564343565618;5802.564807639528;5980.880382392241;5995.130706047686;6007.87984240304;6016.8796624068145;5644.153376993484;5673.914891276551;5679.204911312337;5687.009546658636;5712.828615141552;5707.743151558107;5714.885702285847;5734.627249228787;5735.569832262514;5746.764445644207;5390.056740070394;5522.5581953442825;5581.888362232651;5617.241672374341;5632.690202038763;5630.690312032878;5694.544436445157;5711.8000869969355;5737.9139312911175;5761.279840019997;5496.780128794803;5529.585281103853;5568.832935011957;5574.303212098488;5590.8043218487155 22:56:10 INFO - PROCESS | 3501 | |5;yui.html;637.2544123375653;660.9107770450994;686.4851361478891;706.3607435271078;708.9680964356605;15766.921165394171;17135.48593542196;17139.228734706954;17143.91428042858;17198.57003574911;15136.54590362291;15232.543023709279;15247.39010439584;15266.6946661067;15268.236588170603;774.7443343696567;779.2908453307477;804.2882049386305;805.8630032894392;806.0367860406816;824.5423789796661;824.7195953375851;824.8886400335967;831.264331067007;835.2691395029349;873.05273777951;876.045110829196;876.4215617692324;877.1009715042069;878.2710350409177;867.1848462445281;871.0679572857077;873.2664561768145;874.0254616103031;875.1948207648978;634.3276127305026;638.8498702804837;638.9009703495966;640.7084776426715;640.826976716284;15572.29924653382;15762.76355854663;15815;15910;16078.437254696146;14068.76418423758;14122.576322710334;14309.928450357682;14326.283685815668;14484.637884052878;10521.210909181842;10641.73395665107;10651.467426628638;10652.893471065268;10933.343999359984;4265.957340426587;4327.8485253016;4328.394024836525;4333.263345231318;4349.478062632473;78440.60779696122;78802.99999999943;79719.60140199262;80578.19421805824;82192.58903705503;10110.797784044278;10246.948765256126;10304.587816487407;10417.374957502574;10603.893961060445;19713.704294435596;20166.29417970364;20371.786605085294;20460.69308960367;20873.89563052175;8251.216134467337;8333;8488.02387725407;8694.695685651099;8738.825223495494;4273;4412.602865742098;4505.211587972091;4540.2962540805565;4606.953930460652;3781.1303400217553;3905.6680182184264;3923.9019024524614;3938.1729836734035;3946.4869566956113;637.1303171171318;638.5530128909782;647.7927063339686;662.7282814046314;667.8764428580728;550.4055619930466;593.1399470767318;598.5959477352857;609.3510411411833;634.5494698763929;9127.26981841451;9293.767655808659;9503.28725345602;9531.120704266084;9585.856212156823;608.5344711295862;625.7622103600603;643.784332248702;647.2556559955995;650.180772226988;4251.617354438115;4602.309653551994;4643.837465688753;4655.231886738718;4736.19484687597;118651;131250;135579;136256;136522.443428961;109818;110442;111253;113325.43337283426;115389;95306.29664919764;95937.52031239799;97390.5130474343;99995.50002249941;103464.48267758613;8376.958115209385;8638.26574741154;8651.52416617067;8779.385443018928;8876.733697989072;57793.711031444574;57869.710651446476;58434.49393036431;58609;59420.405795941486;80879.19120808717;88166;89455;89842.55078724565;90014;9362.485063321583;9658.517074146124;9947.552360143956;9970.850437243302;10006.69979900604;11899.881001190224;12057.879421206027;12247.693807654523;12282.447289871798;12375.876241237473;11817.70455738579;11847;11902.523899043941;11916.940415297868;11917.344546049704;11504.36725980079;11633.302001879914;11977.940110299392;12019.519219231133;12120.151589388659;10876.836847447137;11089.5564177432;11193.66419007431;11339.829902551633;12147.574834880737;9177.449353038839;9371.718848434557;9474.24206063527;9476.099770521789;9648.324617276723;8420.64550679092;8764.824703505767;9408.670696525589;9514.714558563253;9560.235181185628 22:56:10 INFO - PROCESS | 3501 | __end_tp_report 22:56:10 INFO - PROCESS | 3501 | __start_cc_report 22:56:10 INFO - PROCESS | 3501 | _x_x_mozilla_cycle_collect,275 22:56:10 INFO - PROCESS | 3501 | __end_cc_report 22:56:10 INFO - PROCESS | 3501 | __startTimestamp1474610170942__endTimestamp 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | ------- Summary: start ------- 22:56:10 INFO - PROCESS | 3501 | Number of tests: 6 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#0] dojo.html Cycles:165 Average:5512.98 Median:5728.89 stddev:642.10 (11.2%) stddev-sans-first:614.65 22:56:10 INFO - PROCESS | 3501 | Values: 3063.8 3068.5 3098.0 3101.4 3114.0 5432.0 5507.7 5584.3 5595.3 5626.2 5467.3 5515.4 5529.4 5534.9 5590.5 4826.3 5027.7 5051.5 5167.9 5216.0 5131.3 5135.4 5150.2 5155.5 5204.9 4880.4 4929.4 5089.7 5158.4 5170.3 4892.2 4905.4 4955.8 4957.0 5021.5 4907.4 4925.4 5014.5 5020.0 5061.6 5445.3 5451.3 5510.2 5540.9 5543.6 5917.0 5936.3 5957.6 5966.8 6021.0 5958.2 5970.0 5985.3 6010.8 6028.4 5409.1 5438.0 5557.5 5591.2 5591.5 6005.7 6086.4 6088.8 6092.6 6096.2 5829.8 5833.8 5859.5 5891.9 5898.9 5728.9 5831.7 5890.6 5921.8 5945.3 5876.6 5879.7 5897.5 5949.0 5951.5 5886.7 5903.0 5927.5 5935.3 5942.3 4469.9 4494.3 4501.1 4611.6 4657.8 4032.2 4067.8 4081.0 4099.0 4160.2 5548.4 5707.6 5709.8 5722.5 5758.3 5773.7 6009.5 6023.7 6028.0 6042.3 5487.1 5525.1 5536.3 5548.2 5598.6 5148.3 5155.1 5156.2 5220.0 5222.0 6116.4 6143.3 6197.5 6201.6 6232.2 5729.3 5825.1 5949.8 5962.0 5971.4 6111.5 6112.4 6175.0 6273.4 6282.8 5716.7 5882.1 5885.1 5895.1 5954.9 5858.2 5914.1 5955.7 6028.2 6033.8 5584.6 5630.5 5846.6 5848.5 5857.4 5762.0 5788.7 5792.4 5819.5 5888.2 5720.5 5755.3 5760.2 5787.7 5789.2 5731.3 5852.3 5881.6 5883.8 5890.8 5618.7 5651.2 5719.6 5720.7 5792.0 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#1] ext.html Cycles:180 Average:60311.86 Median:39678.90 stddev:127704.49 (321.8%) stddev-sans-first:127983.90 22:56:10 INFO - PROCESS | 3501 | Values: 546.4 572.8 580.3 595.5 608.3 40842.0 42618.6 42763.8 46332.8 46457.5 44361.3 44362.0 44566.8 44678.0 45038.0 8530.0 8803.6 8861.6 8869.3 8892.1 8861.9 8938.3 8949.0 8955.0 8975.4 8825.6 8904.5 9009.4 9010.6 9011.2 8857.2 8887.5 8921.1 8972.6 9021.0 8789.4 8884.2 8894.4 8919.8 8932.7 30940.2 31087.0 31101.8 31129.8 31130.5 2734.9 2873.5 2926.2 3024.5 3144.1 30892.4 31014.7 31520.2 32425.4 33070.5 4240.9 4245.7 4249.9 4278.2 4293.4 346853.0 351075.0 351268.0 351371.2 352019.0 31517.2 32280.2 32401.7 48157.3 48638.8 36740.4 36827.3 36967.8 37043.6 37170.4 14115.4 14199.4 14263.9 14291.1 14365.7 11656.5 11695.0 11732.1 11736.8 11799.9 8413.3 8422.1 8480.3 8539.4 8550.2 3352.7 3366.2 3379.4 3385.6 3393.3 960.3 966.0 1011.0 1044.1 1050.5 32112.0 32266.0 32281.0 32302.2 32459.4 1055.3 1055.3 1119.5 1125.4 1153.8 15943.3 16864.3 16961.7 16990.6 17052.9 578670.0 582246.0 582730.2 582799.0 584402.0 56718.0 56918.0 57442.4 57479.0 57529.1 1294.4 1330.6 1341.8 1352.6 1356.7 30054.6 31816.8 31948.7 32372.8 32521.0 50161.7 50267.0 50394.5 50567.7 50797.0 472549.0 473008.0 476191.0 476375.0 476770.0 25744.1 25861.2 25938.0 25988.7 26026.2 45187.3 45672.3 46093.5 46099.8 46816.8 39364.2 39546.8 39811.0 39832.4 40912.6 38539.4 39207.6 39307.2 40306.0 40680.6 39861.4 39996.8 40257.6 40941.6 41099.8 32192.5 34619.5 35239.5 35460.1 35941.3 27723.0 28214.3 28326.0 28403.4 28548.6 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#2] jquery.html Cycles:180 Average:27465.57 Median:4126.96 stddev:76119.27 (1844.4%) stddev-sans-first:76305.67 22:56:10 INFO - PROCESS | 3501 | Values: 395.5 398.5 403.9 405.3 425.1 15280.4 17957.7 19414.6 19483.3 19762.6 18717.5 18848.4 18882.2 18974.2 19230.9 5637.9 5722.5 5746.5 5768.3 5805.1 5707.2 5786.1 5797.5 5811.9 5812.5 5596.0 5756.9 5784.6 5796.8 5797.7 5568.2 5717.7 5736.2 5763.0 5769.2 5665.0 5755.8 5769.9 5789.5 5798.2 13097.7 13598.1 13765.6 13795.9 13837.9 2174.2 2213.4 2223.9 2591.2 2683.0 10075.8 10508.2 10988.7 12308.5 14081.0 1829.8 1924.5 1927.2 1933.6 1971.7 58046.7 83748.0 84170.6 84800.6 88614.6 10668.2 10745.6 10756.6 10871.2 10993.9 12472.3 13183.8 14967.7 14991.3 15008.8 7417.3 7546.4 7665.0 7675.1 7677.3 7332.7 7504.9 7614.7 7760.1 7763.5 4122.1 4131.8 4199.2 4224.1 4241.6 1907.5 1961.6 1961.8 1968.0 2048.2 914.8 929.2 975.6 982.9 986.5 17941.5 18943.5 19030.4 19079.8 19565.0 964.3 972.8 996.4 1036.4 1105.7 10294.5 10435.7 10900.6 10910.2 10930.1 454632.0 456261.0 462067.0 465038.0 465947.7 76760.8 87642.0 87652.6 88523.0 91399.0 986.4 1030.6 1057.2 1058.5 1065.7 16540.8 16920.0 17026.2 17301.6 17342.3 41150.4 41636.8 42298.0 42649.4 42935.3 56460.4 56501.0 58112.4 58496.1 59127.4 8035.4 8260.6 8276.7 8461.5 8554.9 9369.3 11839.5 12120.0 12595.9 13050.1 10971.5 11027.2 11505.4 11654.4 12176.4 5603.0 7352.6 9203.1 10546.7 11657.2 8459.6 10094.9 10887.7 11235.4 11936.0 7978.0 8169.0 8218.3 8268.5 8302.0 8611.4 11195.5 11246.4 11387.0 11503.3 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#3] mootools.html Cycles:180 Average:5966.04 Median:4930.48 stddev:3433.80 (69.6%) stddev-sans-first:3426.65 22:56:10 INFO - PROCESS | 3501 | Values: 1447.9 1502.8 1633.6 1736.1 1763.3 8161.6 8426.1 8734.8 9435.4 9436.5 8769.4 8999.3 9061.3 9276.7 9304.4 2360.8 2400.6 2406.8 2407.4 2409.2 2375.5 2381.9 2407.3 2415.0 2426.2 2400.1 2402.2 2411.3 2416.9 2421.5 2243.9 2267.2 2270.9 2273.9 2293.4 2312.6 2315.6 2328.0 2339.2 2342.2 8628.9 9115.2 9234.2 9295.9 9319.6 5443.4 5527.3 5529.9 5578.9 5580.4 3462.6 3475.6 3560.2 3590.5 3658.8 1148.8 1155.4 1158.4 1159.1 1165.4 12485.9 12710.2 12751.2 12792.1 12819.4 4728.8 4844.8 4855.4 4927.6 4951.0 10667.7 10728.1 10786.0 10793.9 10802.6 5512.7 5520.3 5557.4 5561.6 5589.0 4462.8 4580.4 4933.3 5095.1 5148.8 3930.9 4050.2 4056.7 4091.5 4136.0 1280.3 1316.3 1318.1 1323.4 1324.5 762.2 892.5 910.9 923.5 931.7 5774.9 5780.9 5927.2 6033.3 6074.1 915.7 919.8 920.1 947.5 954.1 3862.2 4128.3 4150.8 4225.2 4238.8 11028.3 11582.8 11629.7 11674.8 11712.1 11461.2 11482.9 11517.3 11554.1 11572.6 8068.4 8425.4 8439.1 8547.3 8573.7 6001.9 6077.4 6150.0 6151.8 6175.9 10453.8 10466.4 10594.9 10700.8 10712.8 10326.2 10615.8 10794.1 10879.2 10945.2 7456.6 7599.6 7660.8 7724.3 7765.7 8728.9 8802.3 8816.2 8817.1 8838.0 7222.6 7284.2 7313.0 7550.4 7824.0 6990.5 7268.9 7396.3 7482.6 7640.5 7257.5 7386.0 7404.3 7409.3 7416.7 5215.0 5255.7 5372.3 5462.9 5528.6 5207.3 5305.4 5313.8 5316.5 5323.7 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#4] prototype.html Cycles:180 Average:4732.95 Median:5311.72 stddev:1398.20 (26.3%) stddev-sans-first:1362.17 22:56:10 INFO - PROCESS | 3501 | Values: 311.9 330.8 334.6 336.2 338.9 5481.1 5498.6 5507.6 5515.6 5539.8 5410.6 5486.4 5489.7 5497.9 5515.1 4301.5 4301.8 4302.6 4335.5 4339.7 3893.5 4170.6 4225.5 4227.4 4314.5 4211.9 4215.3 4217.6 4231.1 4235.9 4240.3 4251.0 4260.2 4267.7 4281.4 3586.8 3775.7 3790.8 3791.2 3792.2 5304.7 5307.4 5316.6 5333.5 5340.6 4838.0 4849.6 4852.5 4856.3 4865.1 5500.2 5660.8 5670.2 5673.2 5673.7 4089.1 4104.2 4119.3 4122.2 4164.8 5806.7 5926.5 6026.6 6031.0 6055.9 4125.7 4143.9 4169.1 4175.4 4183.2 4226.2 4232.3 4238.7 4239.0 4254.3 4628.6 4879.2 4881.3 4888.9 4891.3 5745.8 5748.3 5766.4 5770.6 5799.4 1455.8 1471.4 1474.9 1476.2 1478.2 880.8 929.0 931.0 946.8 949.2 4882.7 4902.5 4910.2 4937.7 4961.4 5130.6 5131.3 5136.6 5177.0 5194.6 4701.5 4869.2 4890.8 4908.4 4954.4 2739.1 2749.7 2751.4 2753.5 2777.5 5261.7 5293.8 5316.0 5326.2 5385.9 5267.9 5291.9 5656.9 6000.7 6036.6 6140.0 6149.4 6161.6 6172.3 6189.0 5571.1 5891.2 5915.9 5927.3 5956.6 5762.9 5897.3 5913.4 5922.0 5928.6 5890.6 5955.9 6031.3 6045.7 6103.6 4281.5 4293.8 4334.1 4335.2 4356.6 5802.6 5980.9 5995.1 6007.9 6016.9 5644.2 5673.9 5679.2 5687.0 5712.8 5707.7 5714.9 5734.6 5735.6 5746.8 5390.1 5522.6 5581.9 5617.2 5632.7 5630.7 5694.5 5711.8 5737.9 5761.3 5496.8 5529.6 5568.8 5574.3 5590.8 22:56:10 INFO - PROCESS | 3501 | 22:56:10 INFO - PROCESS | 3501 | [#5] yui.html Cycles:180 Average:22158.03 Median:58521.75 stddev:34337.07 (58.7%) stddev-sans-first:34395.37 22:56:10 INFO - PROCESS | 3501 | Values: 637.3 660.9 686.5 706.4 709.0 15766.9 17135.5 17139.2 17143.9 17198.6 15136.5 15232.5 15247.4 15266.7 15268.2 774.7 779.3 804.3 805.9 806.0 824.5 824.7 824.9 831.3 835.3 873.1 876.0 876.4 877.1 878.3 867.2 871.1 873.3 874.0 875.2 634.3 638.8 638.9 640.7 640.8 15572.3 15762.8 15815.0 15910.0 16078.4 14068.8 14122.6 14309.9 14326.3 14484.6 10521.2 10641.7 10651.5 10652.9 10933.3 4266.0 4327.8 4328.4 4333.3 4349.5 78440.6 78803.0 79719.6 80578.2 82192.6 10110.8 10246.9 10304.6 10417.4 10603.9 19713.7 20166.3 20371.8 20460.7 20873.9 8251.2 8333.0 8488.0 8694.7 8738.8 4273.0 4412.6 4505.2 4540.3 4607.0 3781.1 3905.7 3923.9 3938.2 3946.5 637.1 638.6 647.8 662.7 667.9 550.4 593.1 598.6 609.4 634.5 9127.3 9293.8 9503.3 9531.1 9585.9 608.5 625.8 643.8 647.3 650.2 4251.6 4602.3 4643.8 4655.2 4736.2 118651.0 131250.0 135579.0 136256.0 136522.4 109818.0 110442.0 111253.0 113325.4 115389.0 95306.3 95937.5 97390.5 99995.5 103464.5 8377.0 8638.3 8651.5 8779.4 8876.7 57793.7 57869.7 58434.5 58609.0 59420.4 80879.2 88166.0 89455.0 89842.6 90014.0 9362.5 9658.5 9947.6 9970.9 10006.7 11899.9 12057.9 12247.7 12282.4 12375.9 11817.7 11847.0 11902.5 11916.9 11917.3 11504.4 11633.3 11977.9 12019.5 12120.2 10876.8 11089.6 11193.7 11339.8 12147.6 9177.4 9371.7 9474.2 9476.1 9648.3 8420.6 8764.8 9408.7 9514.7 9560.2 22:56:10 INFO - PROCESS | 3501 | -------- Summary: end -------- 22:56:10 INFO - PROCESS | 3501 | 22:56:12 INFO - TEST-INFO | 3501: exit 0 22:56:12 INFO - TEST-OK | dromaeo_css | took 1116039ms 22:56:12 INFO - TEST-START | kraken 22:56:12 INFO - operating with platform_type : linux_ 22:56:12 INFO - Initialising browser for kraken test... 22:56:12 INFO - TEST-INFO | started process 3860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsfglJ/profile http://localhost:48486/getInfo.html) 22:56:17 INFO - PROCESS | 3860 | __metrics Screen width/height:1600/1200 22:56:17 INFO - PROCESS | 3860 | colorDepth:24 22:56:17 INFO - PROCESS | 3860 | Browser inner width/height: 1024/697 22:56:17 INFO - PROCESS | 3860 | __metrics 22:56:17 ERROR - PROCESS | 3860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:56:18 INFO - TEST-INFO | 3860: exit 0 22:56:18 INFO - Browser initialized. 22:56:18 INFO - Running cycle 1/1 for kraken test... 22:56:18 INFO - TEST-INFO | started process 3981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsfglJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:30 INFO - PROCESS | 3981 | RSS: Main: 181514240 22:56:30 INFO - PROCESS | 3981 | 22:56:33 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-beat-detection) 22:56:34 INFO - PROCESS | 3981 | RSS: Main: 194875392 22:56:34 INFO - PROCESS | 3981 | 22:56:36 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-dft) 22:56:37 INFO - PROCESS | 3981 | RSS: Main: 193572864 22:56:37 INFO - PROCESS | 3981 | 22:56:40 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-fft) 22:56:41 INFO - PROCESS | 3981 | RSS: Main: 188563456 22:56:41 INFO - PROCESS | 3981 | 22:56:43 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-oscillator) 22:56:43 INFO - PROCESS | 3981 | RSS: Main: 189255680 22:56:43 INFO - PROCESS | 3981 | 22:56:45 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:56:46 INFO - PROCESS | 3981 | RSS: Main: 189358080 22:56:46 INFO - PROCESS | 3981 | 22:56:49 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-darkroom) 22:56:50 INFO - PROCESS | 3981 | RSS: Main: 189194240 22:56:50 INFO - PROCESS | 3981 | 22:56:53 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-desaturate) 22:56:54 INFO - PROCESS | 3981 | RSS: Main: 187531264 22:56:54 INFO - PROCESS | 3981 | 22:56:57 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48486/tests/kraken/driver.html?testName=json-parse-financial) 22:56:57 INFO - PROCESS | 3981 | RSS: Main: 188932096 22:56:57 INFO - PROCESS | 3981 | 22:56:59 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48486/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:57:00 INFO - PROCESS | 3981 | RSS: Main: 189399040 22:57:00 INFO - PROCESS | 3981 | 22:57:01 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:57:02 INFO - PROCESS | 3981 | RSS: Main: 188907520 22:57:02 INFO - PROCESS | 3981 | 22:57:04 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:57:05 INFO - PROCESS | 3981 | RSS: Main: 189128704 22:57:05 INFO - PROCESS | 3981 | 22:57:07 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:57:08 INFO - PROCESS | 3981 | RSS: Main: 189050880 22:57:08 INFO - PROCESS | 3981 | 22:57:11 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:57:11 INFO - PROCESS | 3981 | RSS: Main: 189005824 22:57:11 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48486/tests/kraken/driver.html?testName=ai-astar) 22:57:13 INFO - PROCESS | 3981 | RSS: Main: 190308352 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | __start_tp_report 22:57:13 INFO - PROCESS | 3981 | _x_x_mozilla_page_load 22:57:13 INFO - PROCESS | 3981 | _x_x_mozilla_page_load_details 22:57:13 INFO - PROCESS | 3981 | |i|pagename|runs| 22:57:13 INFO - PROCESS | 3981 | |0;ai-astar;108;113;113;114;112;112;114;113;114;113 22:57:13 INFO - PROCESS | 3981 | |1;audio-beat-detection;156;122;120;164;123;123;120;120;155;120 22:57:13 INFO - PROCESS | 3981 | |2;audio-dft;164;171;167;171;173;163;163;164;162;171 22:57:13 INFO - PROCESS | 3981 | |3;audio-fft;77;79;77;111;77;75;76;77;101;76 22:57:13 INFO - PROCESS | 3981 | |4;audio-oscillator;83;83;112;84;83;82;104;83;82;106 22:57:13 INFO - PROCESS | 3981 | |5;imaging-gaussian-blur;119;117;117;119;117;119;118;118;117;118 22:57:13 INFO - PROCESS | 3981 | |6;imaging-darkroom;148;150;148;148;149;150;148;147;147;147 22:57:13 INFO - PROCESS | 3981 | |7;imaging-desaturate;96;97;96;96;95;96;96;96;96;96 22:57:13 INFO - PROCESS | 3981 | |8;json-parse-financial;55;55;57;54;54;55;59;54;55;57 22:57:13 INFO - PROCESS | 3981 | |9;json-stringify-tinderbox;60;62;60;60;60;59;60;59;60;61 22:57:13 INFO - PROCESS | 3981 | |10;stanford-crypto-aes;90;83;86;80;80;79;79;79;81;84 22:57:13 INFO - PROCESS | 3981 | |11;stanford-crypto-ccm;130;127;133;127;133;142;131;129;160;132 22:57:13 INFO - PROCESS | 3981 | |12;stanford-crypto-pbkdf2;172;170;170;168;172;180;168;172;170;169 22:57:13 INFO - PROCESS | 3981 | |13;stanford-crypto-sha256-iterative;70;69;70;71;67;66;67;65;66;65 22:57:13 INFO - PROCESS | 3981 | __end_tp_report 22:57:13 INFO - PROCESS | 3981 | __start_cc_report 22:57:13 INFO - PROCESS | 3981 | _x_x_mozilla_cycle_collect,704 22:57:13 INFO - PROCESS | 3981 | __end_cc_report 22:57:13 INFO - PROCESS | 3981 | __startTimestamp1474610233956__endTimestamp 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | ------- Summary: start ------- 22:57:13 INFO - PROCESS | 3981 | Number of tests: 14 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:0.78 22:57:13 INFO - PROCESS | 3981 | Values: 108.0 113.0 113.0 114.0 112.0 112.0 114.0 113.0 114.0 113.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:123.00 stddev:18.15 (14.8%) stddev-sans-first:17.11 22:57:13 INFO - PROCESS | 3981 | Values: 156.0 122.0 120.0 164.0 123.0 123.0 120.0 120.0 155.0 120.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#2] audio-dft Cycles:10 Average:166.90 Median:169.00 stddev:4.20 (2.5%) stddev-sans-first:4.32 22:57:13 INFO - PROCESS | 3981 | Values: 164.0 171.0 167.0 171.0 173.0 163.0 163.0 164.0 162.0 171.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.60 (16.4%) stddev-sans-first:13.20 22:57:13 INFO - PROCESS | 3981 | Values: 77.0 79.0 77.0 111.0 77.0 75.0 76.0 77.0 101.0 76.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.00 stddev:12.00 (14.5%) stddev-sans-first:12.44 22:57:13 INFO - PROCESS | 3981 | Values: 83.0 83.0 112.0 84.0 83.0 82.0 104.0 83.0 82.0 106.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 22:57:13 INFO - PROCESS | 3981 | Values: 119.0 117.0 117.0 119.0 117.0 119.0 118.0 118.0 117.0 118.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 22:57:13 INFO - PROCESS | 3981 | Values: 148.0 150.0 148.0 148.0 149.0 150.0 148.0 147.0 147.0 147.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:57:13 INFO - PROCESS | 3981 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.65 (3.0%) stddev-sans-first:1.74 22:57:13 INFO - PROCESS | 3981 | Values: 55.0 55.0 57.0 54.0 54.0 55.0 59.0 54.0 55.0 57.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 22:57:13 INFO - PROCESS | 3981 | Values: 60.0 62.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 61.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:3.67 (4.5%) stddev-sans-first:2.54 22:57:13 INFO - PROCESS | 3981 | Values: 90.0 83.0 86.0 80.0 80.0 79.0 79.0 79.0 81.0 84.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:132.50 stddev:9.96 (7.5%) stddev-sans-first:10.43 22:57:13 INFO - PROCESS | 3981 | Values: 130.0 127.0 133.0 127.0 133.0 142.0 131.0 129.0 160.0 132.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:3.48 (2.0%) stddev-sans-first:3.67 22:57:13 INFO - PROCESS | 3981 | Values: 172.0 170.0 170.0 168.0 172.0 180.0 168.0 172.0 170.0 169.0 22:57:13 INFO - PROCESS | 3981 | 22:57:13 INFO - PROCESS | 3981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:2.22 (3.3%) stddev-sans-first:2.18 22:57:13 INFO - PROCESS | 3981 | Values: 70.0 69.0 70.0 71.0 67.0 66.0 67.0 65.0 66.0 65.0 22:57:13 INFO - PROCESS | 3981 | -------- Summary: end -------- 22:57:13 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | 22:57:14 INFO - PROCESS | 3981 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 22:57:14 INFO - PROCESS | 3981 | 22:57:15 INFO - TEST-INFO | 3981: exit 0 22:57:15 INFO - TEST-OK | kraken | took 63043ms 22:57:15 INFO - SUITE-END | took 1179s 22:57:15 INFO - Completed test suite (00:19:39) 22:57:15 INFO - javascript benchmark 22:57:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7139.886330752096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.8008529445597, 3068.5090385538315, 3097.9535306970383, 3101.379724055189, 3113.984430077849, 5432.049391356507, 5507.697076660787, 5584.301962254724, 5595.300587426572, 5626.212330273765, 5467.343918729758, 5515.420880807517, 5529.391766905637, 5534.944650553493, 5590.468905453986, 4826.3001864729595, 5027.748612569357, 5051.494850514947, 5167.896642067157, 5215.973920130413, 5131.307273518065, 5135.35808023997, 5150.1759718445055, 5155.510226528474, 5204.947950520503, 4880.41435027799, 4929.408470983469, 5089.7455127243675, 5158.3552055993005, 5170.276161337416, 4892.192788189945, 4905.411350637911, 4955.752212389366, 4956.975215123937, 5021.472745361758, 4907.411110666707, 4925.3597032385915, 5014.548690617826, 5019.970905964268, 5061.569766569846, 5445.264889239941, 5451.3458384993655, 5510.173473978935, 5540.889182216373, 5543.6119471637, 5916.97041514794, 5936.347001829795, 5957.642541447527, 5966.820995370146, 6021.0, 5958.195643588104, 5970.044792833126, 5985.281766188042, 6010.78962236324, 6028.367021462727, 5409.0534156522845, 5438.048341540294, 5557.527610153183, 5591.217229587861, 5591.496765291103, 6005.669688167192, 6086.444144050445, 6088.795763799083, 6092.62857369438, 6096.194094249989, 5829.8251052468495, 5833.82498525045, 5859.501942334864, 5891.882162356729, 5898.911516327258, 5728.885422291614, 5831.737571809279, 5890.617109887844, 5921.7631294747725, 5945.2865656120675, 5876.6180198286975, 5879.7060146993335, 5897.528197744256, 5948.970255148696, 5951.494122999594, 5886.705664716833, 5903.0, 5927.525797936241, 5935.2877654681715, 5942.3166335871065, 4469.865904022885, 4494.303382975644, 4501.0547784964865, 4611.608013318838, 4657.790399432034, 4032.1532478179324, 4067.8372865085657, 4081.0409553754844, 4099.0, 4160.2303573838935, 5548.4174161713245, 5707.600467967202, 5709.7716091356715, 5722.484976352148, 5758.309002919593, 5773.740181691834, 6009.459148676553, 6023.668698221552, 6028.0, 6042.305134909454, 5487.149491828773, 5525.11598144295, 5536.335639723259, 5548.195511650869, 5598.552115830724, 5148.279240906276, 5155.097857874857, 5156.226566015052, 5219.973900130475, 5222.0, 6116.388361163937, 6143.293521245114, 6197.504199664107, 6201.627902325785, 6232.220972378453, 5729.28383952006, 5825.0679891217205, 5949.8215053548465, 5962.016267315845, 5971.373005834499, 6111.500579230132, 6112.442689633966, 6175.042868355412, 6273.404026617464, 6282.780102696383, 5716.657000579979, 5882.1470886722045, 5885.087811389241, 5895.056790913433, 5954.880902382015, 5858.150568167677, 5914.112883067574, 5955.702214889325, 6028.156058151774, 6033.78881739137, 5584.553235741212, 5630.5214056805635, 5846.56150788684, 5848.53211743068, 5857.384974577608, 5762.0, 5788.681622510802, 5792.362840087502, 5819.476247137778, 5888.205092312654, 5720.48515633595, 5755.338136114233, 5760.193572899713, 5787.710614469344, 5789.247397838254, 5731.283589551306, 5852.3269823969085, 5881.5588830837005, 5883.764649413975, 5890.823275301748, 5618.69097199658, 5651.15232715096, 5719.599628025998, 5720.713964301852, 5792.0443126885275], "value": 5467.96501874589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.4267592990125, 572.7823427097702, 580.2891457963992, 595.4819307202733, 608.2943785209159, 40842.0, 42618.57381426189, 42763.78618106905, 46332.768336158275, 46457.53542464574, 44361.334579981325, 44362.0, 44566.7771661142, 44678.0, 45038.0, 8529.957350213255, 8803.603837827313, 8861.645534178626, 8869.334799890034, 8892.066333035034, 8861.911380886206, 8938.329625278131, 8949.0, 8955.0, 8975.371723979291, 8825.558722063903, 8904.465732056065, 9009.414388064788, 9010.639574417015, 9011.18899299063, 8857.247133993618, 8887.511186884718, 8921.107889211093, 8972.641094356251, 9021.0, 8789.428687135316, 8884.200421962054, 8894.42186257891, 8919.777005574848, 8932.732018039469, 30940.226494337596, 31087.0, 31101.84449077763, 31129.8443507781, 31130.533042004387, 2734.931626709328, 2873.454043731684, 2926.1514160893316, 3024.45591204845, 3144.119646498984, 30892.382152356826, 31014.689853101405, 31520.211994700316, 32425.351492970007, 33070.50394244088, 4240.915181696349, 4245.745255284693, 4249.915001699979, 4278.165757677254, 4293.420388247578, 346853.0, 351075.0, 351268.0, 351371.2431437852, 352019.0, 31517.212069698442, 32280.192995175308, 32401.675983239867, 48157.27764083542, 48638.756806215744, 36740.44889326662, 36827.26345473075, 36967.81516092456, 37043.629563704555, 37170.44244336337, 14115.364808583638, 14199.36102875373, 14263.85736142646, 14291.071080379743, 14365.712685746226, 11656.53373865036, 11695.0, 11732.12009099321, 11736.823947640793, 11799.941000294944, 8413.326933845277, 8422.115677853859, 8480.279176270085, 8539.402241843012, 8550.230479256898, 3352.6814952579466, 3366.242595416061, 3379.4423920052914, 3385.6445073267446, 3393.2874096440023, 960.3469640644429, 965.9806803863884, 1010.9797804043878, 1044.0655613226272, 1050.5220124843179, 32112.0, 32266.0, 32281.031569052964, 32302.19244518906, 32459.35081298361, 1055.2824079625775, 1055.3404122423485, 1119.5074167366333, 1125.386664267976, 1153.7807816514835, 15943.282552285174, 16864.32542698303, 16961.745573816403, 16990.57523561921, 17052.914735426242, 578670.0, 582246.0, 582730.1587301587, 582799.0, 584402.0, 56718.0, 56918.0, 57442.42557574454, 57479.0, 57529.137062944086, 1294.4239813283186, 1330.6274243211917, 1341.8255626768457, 1352.594221733476, 1356.6811799227173, 30054.64480874366, 31816.840915795274, 31948.68051319457, 32372.838135809172, 32521.0, 50161.74919125381, 50267.0, 50394.49605504045, 50567.74716126396, 50797.0, 472549.0, 473008.0, 476191.0, 476375.0, 476770.0, 25744.098956537182, 25861.224163275132, 25938.0, 25988.740112598633, 26026.21921342363, 45187.32219016783, 45672.26512933769, 46093.53906460892, 46099.76950115362, 46816.7659161702, 39364.2127157461, 39546.80226598849, 39811.0, 39832.40251396174, 40912.59087409088, 38539.42190867195, 39207.6079239204, 39307.213855722155, 40306.0, 40680.59319406887, 39861.40207896942, 39996.80001599973, 40257.597424025385, 40941.59058409378, 41099.7945010273, 32192.517112243804, 34619.4807077889, 35239.47140792839, 35460.113497162776, 35941.28117437689, 27723.0, 28214.29464263328, 28326.0, 28403.43193136167, 28548.57177142386], "value": 18307.442145322642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.45822223553716, 398.50585274259925, 403.868742658636, 405.2947870704973, 425.10939581576605, 15280.388784448636, 17957.7306340405, 19414.611707765835, 19483.318083867067, 19762.604747905032, 18717.53206169843, 18848.434546963577, 18882.150303236354, 18974.241030358804, 19230.90384548079, 5637.943620563783, 5722.484976352117, 5746.511546518551, 5768.336641286264, 5805.071188609823, 5707.229524014247, 5786.103154011114, 5797.478226959573, 5811.912821307684, 5812.50593699534, 5596.0, 5756.856078598027, 5784.595078344518, 5796.8260952171295, 5797.71011449428, 5568.220449137084, 5717.685527295997, 5736.1682556029355, 5763.0, 5769.249997500298, 5665.036943719578, 5755.769769209227, 5769.942300576982, 5789.507891829199, 5798.246227990334, 13097.738045239137, 13598.11612245201, 13765.587032389045, 13795.931020344935, 13837.930810345884, 2174.2281490071114, 2213.380253529014, 2223.944401389962, 2591.199116613954, 2682.9597556036674, 10075.75795408582, 10508.211884108723, 10988.670339889815, 12308.507659693601, 14081.0, 1829.7895741989707, 1924.4803902946126, 1927.180948097053, 1933.5552822850682, 1971.684530475117, 58046.7097664509, 83748.0, 84170.57914710448, 84800.57599711962, 88614.55692721624, 10668.199885008655, 10745.570177192982, 10756.623518176983, 10871.239013268996, 10993.890061099446, 12472.314022728837, 13183.802242966363, 14967.652911238041, 14991.325390357242, 15008.774868376982, 7417.258274172539, 7546.358559522392, 7664.961675191588, 7675.078990521173, 7677.347425468898, 7332.706691732377, 7504.924950750532, 7614.695412183451, 7760.146383897767, 7763.456558040883, 4122.134351786159, 4131.793410329472, 4199.202151591188, 4224.1129362834145, 4241.639460645818, 1907.4754442528415, 1961.578260673962, 1961.8430525557922, 1967.9704804427945, 2048.2319130326127, 914.7575892388522, 929.2380248196414, 975.6487664440796, 982.8869679986893, 986.5116767200138, 17941.451370249764, 18943.52641183954, 19030.42908712741, 19079.80920190808, 19565.010922214744, 964.344245912786, 972.776261459854, 996.4121168510613, 1036.404067661098, 1105.701460605632, 10294.536745846455, 10435.68692939213, 10900.618478353379, 10910.23628346008, 10930.125589952784, 454632.0, 456261.0, 462067.0, 465038.0, 465947.72418206464, 76760.84858727123, 87642.0, 87652.56173719218, 88523.0, 91399.0, 986.4475893499663, 1030.5826140413144, 1057.2123767793043, 1058.539535302146, 1065.6643157405392, 16540.83459165393, 16920.0, 17026.233819478402, 17301.56746081358, 17342.30630774755, 41150.382744259456, 41636.791816041936, 42298.0, 42649.36025959551, 42935.277119516206, 56460.43539564716, 56501.0, 58112.384942678524, 58496.12255816251, 59127.40872591391, 8035.397345199017, 8260.586970651564, 8276.668933242603, 8461.534615596202, 8554.871676924975, 9369.344145909721, 11839.467223974769, 12120.0, 12595.87404125947, 13050.086493945713, 10971.451427428437, 11027.22809403334, 11505.42472876336, 11654.417279136178, 12176.39118044112, 5603.0474819281635, 7352.558846469229, 9203.079692030744, 10546.683599492027, 11657.18399712012, 8459.64920985383, 10094.889562148011, 10887.673369798918, 11235.438228088726, 11935.985441237244, 7977.960110199412, 8168.959155204186, 8218.342532597258, 8268.503889766633, 8301.958490207511, 8611.397202196036, 11195.496202671062, 11246.437678115897, 11387.0, 11503.252288601214], "value": 8835.614420970513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.8624530669586, 1502.8271748748896, 1633.5671047172493, 1736.1145815634022, 1763.2770564068735, 8161.55111468869, 8426.115257897924, 8734.781630459242, 9435.386699864504, 9436.480993545352, 8769.386142969995, 8999.280057595393, 9061.275097992162, 9276.675316363928, 9304.395214311066, 2360.799332056773, 2400.5918993771015, 2406.7713567211085, 2407.38611654028, 2409.204962362425, 2375.5486457573006, 2381.8928148233285, 2407.2537513370826, 2414.9637755433682, 2426.2478631624253, 2400.051979468109, 2402.159244264511, 2411.2645643078854, 2416.903323867043, 2421.467277199022, 2243.9214627488122, 2267.240474441064, 2270.920517781878, 2273.931782046533, 2293.3578597992423, 2312.6068568343253, 2315.5947709150832, 2327.9650805237934, 2339.2163625185585, 2342.156823543523, 8628.870566941501, 9115.22520585751, 9234.215091717213, 9295.860562091573, 9319.627214911396, 5443.374011988592, 5527.336719593634, 5529.917051244194, 5578.888422231533, 5580.386157522669, 3462.6364231755556, 3475.565554305712, 3560.1989552350774, 3590.4973303737497, 3658.7804731716183, 1148.8104462763717, 1155.4107405223397, 1158.432368139614, 1159.0585768837163, 1165.4464129538487, 12485.93757031209, 12710.173838700455, 12751.171173873669, 12792.104552681316, 12819.35903204836, 4728.763561821896, 4844.75776211188, 4855.441624213261, 4927.630427717935, 4950.950490495121, 10667.733306667395, 10728.141748660088, 10786.0, 10793.892061079288, 10802.621908233174, 5512.6692398456225, 5520.309961254843, 5557.3886872444, 5561.63849349791, 5589.0219211637805, 4462.776861156929, 4580.38164847748, 4933.333999909966, 5095.0828850806465, 5148.845534633892, 3930.8820735377412, 4050.1697152084344, 4056.7363121397016, 4091.5499295077516, 4135.958640413617, 1280.3022352817736, 1316.2628927800463, 1318.1497933832625, 1323.3780123342015, 1324.5165514587106, 762.2225330163313, 892.5314210039651, 910.922571581423, 923.5363333432197, 931.6599441203912, 5774.855628609234, 5780.855478612984, 5927.199828023162, 6033.336333003366, 6074.11702372266, 915.720705184925, 919.7608621758391, 920.1396694091046, 947.4978261521404, 954.0745476887408, 3862.1889403225077, 4128.298189307825, 4150.833966641361, 4225.154969006211, 4238.766867822299, 11028.28316159447, 11582.826257606142, 11629.709257268636, 11674.766504669858, 11712.121590880719, 11461.197716159955, 11482.94258528702, 11517.25137866036, 11554.075673946065, 11572.594959176557, 8068.435209535276, 8425.410221284574, 8439.113893041142, 8547.273481753997, 8573.657053717907, 6001.939980600138, 6077.392260773887, 6149.96925015372, 6151.753929842756, 6175.9073613894925, 10453.790924181625, 10466.424346661006, 10594.894051059391, 10700.839487407851, 10712.839307410552, 10326.225533085199, 10615.787684246427, 10794.08250298702, 10879.23845330851, 10945.23383363157, 7456.589887556236, 7599.620018998918, 7660.770176894702, 7724.304812566896, 7765.650545725569, 8728.912710873064, 8802.29581633455, 8816.206541411304, 8817.118288171132, 8838.0, 7222.566646001257, 7284.198738138906, 7312.96343518279, 7550.395968322631, 7823.960880195563, 6990.475714321345, 7268.890966635399, 7396.260373962561, 7482.625868706434, 7640.503367281109, 7257.459889038794, 7386.039814824038, 7404.259574042768, 7409.296116868889, 7416.7033318666645, 5215.0, 5255.710935898409, 5372.274742909657, 5462.91805622908, 5528.612997090165, 5207.3490813648295, 5305.363356397257, 5313.814016509404, 5316.548093411949, 5323.733813309396], "value": 4747.389306334288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.85654598884526, 330.796560115529, 334.55170072103374, 336.16295424393263, 338.92543640399106, 5481.12302031675, 5498.615096943211, 5507.586930980183, 5515.558755299577, 5539.778408863641, 5410.56715462763, 5486.423925487817, 5489.725513724307, 5497.862553436166, 5515.145152501359, 4301.462317210348, 4301.849435269766, 4302.591253830881, 4335.544767799391, 4339.652827773771, 3893.4743809585625, 4170.624643782059, 4225.535191128974, 4227.429297044906, 4314.503832059322, 4211.936820947688, 4215.3044747616605, 4217.641500472449, 4231.069164783758, 4235.894102647428, 4240.342746874239, 4250.97874510627, 4260.233158031553, 4267.722598031118, 4281.400603915455, 3586.7847929124337, 3775.716821238418, 3790.7725536467624, 3791.203847192093, 3792.222594368148, 5304.655197412195, 5307.442718514578, 5316.627836051478, 5333.479958211891, 5340.572754179656, 4838.0, 4849.636277279218, 4852.539008794159, 4856.295837103636, 4865.051314993578, 5500.22996780451, 5660.773569057233, 5670.177824215507, 5673.205751194836, 5673.659580425187, 4089.141280331134, 4104.1886307879195, 4119.299719047769, 4122.227442199853, 4164.7709375984305, 5806.65160090396, 5926.525877929712, 6026.608270462406, 6031.0, 6055.909161362583, 4125.679782469581, 4143.91712165755, 4169.10364271683, 4175.371605073963, 4183.226103170923, 4226.154769046203, 4232.30167022444, 4238.689913996817, 4238.978805105955, 4254.276772948606, 4628.583427491474, 4879.170541008037, 4881.316615673809, 4888.877778055577, 4891.29076283944, 5745.827625171251, 5748.281464816898, 5766.394528574439, 5770.6249093808765, 5799.391063938226, 1455.7670772676322, 1471.4187895781106, 1474.8967572269837, 1476.2323591732454, 1478.1796103162633, 880.8062226310202, 928.9953550232206, 930.9627614895328, 946.8390373636498, 949.2074118111316, 4882.703221165351, 4902.460729319772, 4910.238912968495, 4937.654364194472, 4961.387549046574, 5130.562982583243, 5131.332926719577, 5136.614753893473, 5176.964607078599, 5194.636375453682, 4701.529847015339, 4869.196582563908, 4890.804367825318, 4908.3619129513645, 4954.355933728592, 2739.0960982875604, 2749.6562929633797, 2751.380939288684, 2753.490604238182, 2777.5139350613563, 5261.684298942076, 5293.788248470018, 5316.006497563414, 5326.162473946482, 5385.865353366197, 5267.894642107136, 5291.947080529222, 5656.91514627281, 6000.749718855429, 6036.607620504653, 6140.0, 6149.354317796657, 6161.630302181794, 6172.259328880473, 6189.0, 5571.0807716726285, 5891.204687367151, 5915.940840591539, 5927.288725352985, 5956.583039187215, 5762.855928601818, 5897.292324921037, 5913.379095195115, 5921.970390148022, 5928.614640048383, 5890.617109887844, 5955.910661339996, 6031.336552979256, 6045.727942242522, 6103.572749907641, 4281.529031806436, 4293.785310734514, 4334.133173365402, 4335.241332766816, 4356.564343565618, 5802.564807639528, 5980.880382392241, 5995.130706047686, 6007.87984240304, 6016.8796624068145, 5644.153376993484, 5673.914891276551, 5679.204911312337, 5687.009546658636, 5712.828615141552, 5707.743151558107, 5714.885702285847, 5734.627249228787, 5735.569832262514, 5746.764445644207, 5390.056740070394, 5522.5581953442825, 5581.888362232651, 5617.241672374341, 5632.690202038763, 5630.690312032878, 5694.544436445157, 5711.8000869969355, 5737.9139312911175, 5761.279840019997, 5496.780128794803, 5529.585281103853, 5568.832935011957, 5574.303212098488, 5590.8043218487155], "value": 4283.898534392431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.2544123375653, 660.9107770450994, 686.4851361478891, 706.3607435271078, 708.9680964356605, 15766.921165394171, 17135.48593542196, 17139.228734706954, 17143.91428042858, 17198.57003574911, 15136.54590362291, 15232.543023709279, 15247.39010439584, 15266.6946661067, 15268.236588170603, 774.7443343696567, 779.2908453307477, 804.2882049386305, 805.8630032894392, 806.0367860406816, 824.5423789796661, 824.7195953375851, 824.8886400335967, 831.264331067007, 835.2691395029349, 873.05273777951, 876.045110829196, 876.4215617692324, 877.1009715042069, 878.2710350409177, 867.1848462445281, 871.0679572857077, 873.2664561768145, 874.0254616103031, 875.1948207648978, 634.3276127305026, 638.8498702804837, 638.9009703495966, 640.7084776426715, 640.826976716284, 15572.29924653382, 15762.76355854663, 15815.0, 15910.0, 16078.437254696146, 14068.76418423758, 14122.576322710334, 14309.928450357682, 14326.283685815668, 14484.637884052878, 10521.210909181842, 10641.73395665107, 10651.467426628638, 10652.893471065268, 10933.343999359984, 4265.957340426587, 4327.8485253016, 4328.394024836525, 4333.263345231318, 4349.478062632473, 78440.60779696122, 78802.99999999943, 79719.60140199262, 80578.19421805824, 82192.58903705503, 10110.797784044278, 10246.948765256126, 10304.587816487407, 10417.374957502574, 10603.893961060445, 19713.704294435596, 20166.29417970364, 20371.786605085294, 20460.69308960367, 20873.89563052175, 8251.216134467337, 8333.0, 8488.02387725407, 8694.695685651099, 8738.825223495494, 4273.0, 4412.602865742098, 4505.211587972091, 4540.2962540805565, 4606.953930460652, 3781.1303400217553, 3905.6680182184264, 3923.9019024524614, 3938.1729836734035, 3946.4869566956113, 637.1303171171318, 638.5530128909782, 647.7927063339686, 662.7282814046314, 667.8764428580728, 550.4055619930466, 593.1399470767318, 598.5959477352857, 609.3510411411833, 634.5494698763929, 9127.26981841451, 9293.767655808659, 9503.28725345602, 9531.120704266084, 9585.856212156823, 608.5344711295862, 625.7622103600603, 643.784332248702, 647.2556559955995, 650.180772226988, 4251.617354438115, 4602.309653551994, 4643.837465688753, 4655.231886738718, 4736.19484687597, 118651.0, 131250.0, 135579.0, 136256.0, 136522.443428961, 109818.0, 110442.0, 111253.0, 113325.43337283426, 115389.0, 95306.29664919764, 95937.52031239799, 97390.5130474343, 99995.50002249941, 103464.48267758613, 8376.958115209385, 8638.26574741154, 8651.52416617067, 8779.385443018928, 8876.733697989072, 57793.711031444574, 57869.710651446476, 58434.49393036431, 58609.0, 59420.405795941486, 80879.19120808717, 88166.0, 89455.0, 89842.55078724565, 90014.0, 9362.485063321583, 9658.517074146124, 9947.552360143956, 9970.850437243302, 10006.69979900604, 11899.881001190224, 12057.879421206027, 12247.693807654523, 12282.447289871798, 12375.876241237473, 11817.70455738579, 11847.0, 11902.523899043941, 11916.940415297868, 11917.344546049704, 11504.36725980079, 11633.302001879914, 11977.940110299392, 12019.519219231133, 12120.151589388659, 10876.836847447137, 11089.5564177432, 11193.66419007431, 11339.829902551633, 12147.574834880737, 9177.449353038839, 9371.718848434557, 9474.24206063527, 9476.099770521789, 9648.324617276723, 8420.64550679092, 8764.824703505767, 9408.670696525589, 9514.714558563253, 9560.235181185628], "value": 7364.180871022004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 113.0, 114.0, 112.0, 112.0, 114.0, 113.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 120.0, 164.0, 123.0, 123.0, 120.0, 120.0, 155.0, 120.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 167.0, 171.0, 173.0, 163.0, 163.0, 164.0, 162.0, 171.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 111.0, 77.0, 75.0, 76.0, 77.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 84.0, 83.0, 82.0, 104.0, 83.0, 82.0, 106.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 119.0, 117.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 148.0, 149.0, 150.0, 148.0, 147.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 54.0, 54.0, 55.0, 59.0, 54.0, 55.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 86.0, 80.0, 80.0, 79.0, 79.0, 79.0, 81.0, 84.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 133.0, 127.0, 133.0, 142.0, 131.0, 129.0, 160.0, 132.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 170.0, 168.0, 172.0, 180.0, 168.0, 172.0, 170.0, 169.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 71.0, 67.0, 66.0, 67.0, 65.0, 66.0, 65.0], "value": 67.6, "unit": "score"}]}]} 22:57:15 INFO - Return code: 0 22:57:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:57:15 ERROR - # TBPL SUCCESS # 22:57:15 INFO - Running post-action listener: _resource_record_post_action 22:57:15 INFO - [mozharness: 2016-09-23 05:57:15.257517Z] Finished run-tests step (success) 22:57:15 INFO - Running post-run listener: _resource_record_post_run 22:57:15 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7815168; Write bytes: 301154304; Read time: 1996; Write time: 191604 22:57:15 INFO - TinderboxPrint: CPU usage
13.4% 22:57:15 INFO - TinderboxPrint: I/O read bytes / time
7,815,168 / 1,996 22:57:15 INFO - TinderboxPrint: I/O write bytes / time
301,154,304 / 191,604 22:57:15 INFO - TinderboxPrint: CPU idle
8,263.8 (86.6%) 22:57:15 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 22:57:15 INFO - TinderboxPrint: Swap in / out
0 / 0 22:57:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 92164096; Read time: 16; Write time: 50188 22:57:15 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5779456; Write bytes: 124534784; Read time: 1736; Write time: 32712 22:57:15 INFO - Running post-run listener: _upload_blobber_files 22:57:15 INFO - Blob upload gear active. 22:57:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:57:15 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:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:57:16 INFO - (blobuploader) - INFO - Open directory for files ... 22:57:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:57:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:57:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:17 INFO - (blobuploader) - INFO - Done attempting. 22:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:20 INFO - (blobuploader) - INFO - Done attempting. 22:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:57:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:21 INFO - (blobuploader) - INFO - Done attempting. 22:57:21 INFO - (blobuploader) - INFO - Iteration through files over. 22:57:21 INFO - Return code: 0 22:57:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:57:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:57:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93bd181b10f8ee5ae27b9feb512d7b13e1d155389aa03bf4a428a0d821c90a1fa6ad8efb0c549cfe147c6caf769048d41fabb036a02d4eb74a4cab797ff26255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4408b44be22aee9f8dac3b1920970b974e1adb0bdb907ffe928c8f52737865690944f6218ae8826552f068fc597c3adeb71f6013e02c193501bec76db46932bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82d7ad9b486487cf3e79adbb48eb6e6564967689a534c90c82097fd03c9d41893330366023a929e8947fa835ab9f58f80b3e4e6d0c98a4c17e63ba7906d9ee46"} 22:57:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:57:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:57:21 INFO - Contents: 22:57:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93bd181b10f8ee5ae27b9feb512d7b13e1d155389aa03bf4a428a0d821c90a1fa6ad8efb0c549cfe147c6caf769048d41fabb036a02d4eb74a4cab797ff26255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4408b44be22aee9f8dac3b1920970b974e1adb0bdb907ffe928c8f52737865690944f6218ae8826552f068fc597c3adeb71f6013e02c193501bec76db46932bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82d7ad9b486487cf3e79adbb48eb6e6564967689a534c90c82097fd03c9d41893330366023a929e8947fa835ab9f58f80b3e4e6d0c98a4c17e63ba7906d9ee46"} 22:57:21 INFO - Running post-run listener: copy_logs_to_upload_dir 22:57:21 INFO - Copying logs to upload dir... 22:57:21 INFO - mkdir: /builds/slave/test/build/upload/logs 22:57:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.289169 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-22 22:57:21.366008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 22:57:21.369575) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93bd181b10f8ee5ae27b9feb512d7b13e1d155389aa03bf4a428a0d821c90a1fa6ad8efb0c549cfe147c6caf769048d41fabb036a02d4eb74a4cab797ff26255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4408b44be22aee9f8dac3b1920970b974e1adb0bdb907ffe928c8f52737865690944f6218ae8826552f068fc597c3adeb71f6013e02c193501bec76db46932bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82d7ad9b486487cf3e79adbb48eb6e6564967689a534c90c82097fd03c9d41893330366023a929e8947fa835ab9f58f80b3e4e6d0c98a4c17e63ba7906d9ee46"} build_url:https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93bd181b10f8ee5ae27b9feb512d7b13e1d155389aa03bf4a428a0d821c90a1fa6ad8efb0c549cfe147c6caf769048d41fabb036a02d4eb74a4cab797ff26255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4408b44be22aee9f8dac3b1920970b974e1adb0bdb907ffe928c8f52737865690944f6218ae8826552f068fc597c3adeb71f6013e02c193501bec76db46932bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82d7ad9b486487cf3e79adbb48eb6e6564967689a534c90c82097fd03c9d41893330366023a929e8947fa835ab9f58f80b3e4e6d0c98a4c17e63ba7906d9ee46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 22:57:21.398613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:57:21.399369) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474608209.756967-964246850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:57:21.482536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 22:57:21.483057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 22:57:21.483661) ========= ========= Total master_lag: 0.17 =========