builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1474892399.2 results: success (0) buildid: 20160926033554 builduid: b7726ee8b4e5476b8fb5982fbe887b44 revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.204346) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.204785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.205098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.236075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.236432) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 05:20:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.1M=0s 2016-09-26 05:20:01 (32.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.367637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.367954) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.417743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.418094) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 05:20:01,232 truncating revision to first 12 chars 2016-09-26 05:20:01,232 Setting DEBUG logging. 2016-09-26 05:20:01,232 attempt 1/10 2016-09-26 05:20:01,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 05:20:01,540 unpacking tar archive at: mozilla-central-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:20:00.087696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:20:00.087997) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:20:00.088408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:20:00.088761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:20:00.098574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-09-26 05:20:00.098879) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:01 INFO - MultiFileLogger online at 20160926 05:20:01 in /builds/slave/test 05:20:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:20:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:02 INFO - {'append_to_log': False, 05:20:02 INFO - 'base_work_dir': '/builds/slave/test', 05:20:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:20:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:02 INFO - 'branch': 'Firefox-Non-PGO', 05:20:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:02 INFO - 'config_files': ('talos/linux_config.py',), 05:20:02 INFO - 'default_actions': ('clobber', 05:20:02 INFO - 'read-buildbot-config', 05:20:02 INFO - 'download-and-extract', 05:20:02 INFO - 'populate-webroot', 05:20:02 INFO - 'create-virtualenv', 05:20:02 INFO - 'install', 05:20:02 INFO - 'run-tests'), 05:20:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:02 INFO - 'download_minidump_stackwalk': True, 05:20:02 INFO - 'download_symbols': 'ondemand', 05:20:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:02 INFO - 'installer_path': 'installer.exe', 05:20:02 INFO - 'log_level': 'info', 05:20:02 INFO - 'log_name': 'talos', 05:20:02 INFO - 'log_to_console': True, 05:20:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:02 INFO - 'opt_config_files': (), 05:20:02 INFO - 'pip_index': False, 05:20:02 INFO - 'sps_profile': False, 05:20:02 INFO - 'sps_profile_interval': 0, 05:20:02 INFO - 'suite': 'dromaeojs-e10s', 05:20:02 INFO - 'system_bits': '32', 05:20:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:02 INFO - 'title': 'talos-linux64-ix-042', 05:20:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:02 INFO - 'use_talos_json': True, 05:20:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:02 INFO - 'work_dir': 'build'} 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.006611Z] Running clobber step. 05:20:02 INFO - Running pre-action listener: _resource_record_pre_action 05:20:02 INFO - Running main action method: clobber 05:20:02 INFO - rmtree: /builds/slave/test/build 05:20:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:02 INFO - Running post-action listener: _resource_record_post_action 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.990455Z] Finished clobber step (success) 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.990554Z] Running read-buildbot-config step. 05:20:02 INFO - Running pre-action listener: _resource_record_pre_action 05:20:02 INFO - Running main action method: read_buildbot_config 05:20:02 INFO - Using buildbot properties: 05:20:02 INFO - { 05:20:02 INFO - "project": "", 05:20:02 INFO - "product": "firefox", 05:20:02 INFO - "script_repo_revision": "production", 05:20:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:20:02 INFO - "repository": "", 05:20:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:20:02 INFO - "buildid": "20160926033554", 05:20:02 INFO - "pgo_build": "False", 05:20:02 INFO - "basedir": "/builds/slave/test", 05:20:02 INFO - "buildnumber": 468, 05:20:02 INFO - "slavename": "talos-linux64-ix-042", 05:20:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:20:02 INFO - "platform": "ubuntu64_hw", 05:20:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:20:02 INFO - "branch": "mozilla-central", 05:20:02 INFO - "repo_path": "mozilla-central", 05:20:02 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 05:20:02 INFO - "stage_platform": "linux64", 05:20:02 INFO - "builduid": "b7726ee8b4e5476b8fb5982fbe887b44", 05:20:02 INFO - "slavebuilddir": "test" 05:20:02 INFO - } 05:20:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:20:02 INFO - Running post-action listener: _resource_record_post_action 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.992969Z] Finished read-buildbot-config step (success) 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.993057Z] Running download-and-extract step. 05:20:02 INFO - Running pre-action listener: _resource_record_pre_action 05:20:02 INFO - Running main action method: download_and_extract 05:20:02 INFO - mkdir: /builds/slave/test/build/tests 05:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:02 INFO - trying https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:20:02 INFO - Downloading https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/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 05:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/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 05:20:03 INFO - Downloaded 1361 bytes. 05:20:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:20:03 INFO - Using the following test package requirements: 05:20:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'jsshell-linux-x86_64.zip'], 05:20:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:20:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:03 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:20:04 INFO - Expected file size: 20410336 05:20:08 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 05:20:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:20:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:08 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:20:09 INFO - Expected file size: 20410336 05:20:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:14 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:20:14 INFO - Expected file size: 14414057 05:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:15 INFO - trying https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:15 INFO - Downloading https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/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 05:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/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 05:20:16 INFO - Downloaded 55740060 bytes. 05:20:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:16 INFO - mkdir: /builds/slave/test/properties 05:20:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:16 INFO - Contents: 05:20:16 INFO - build_url:https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:17 INFO - Running post-action listener: _resource_record_post_action 05:20:17 INFO - Running post-action listener: set_extra_try_arguments 05:20:17 INFO - [mozharness: 2016-09-26 12:20:17.106762Z] Finished download-and-extract step (success) 05:20:17 INFO - [mozharness: 2016-09-26 12:20:17.106988Z] Running populate-webroot step. 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: populate_webroot 05:20:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:17 INFO - '--tppagecycles', 05:20:17 INFO - '7'], 05:20:17 INFO - 'tests': ['tsvgm']}}, 05:20:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['damp', 'tps']}, 05:20:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'tests': ['damp', 'tps']}, 05:20:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['dromaeo_dom']}, 05:20:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['basic_compositor_video']}, 05:20:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:20:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['a11yr', 05:20:17 INFO - 'ts_paint', 05:20:17 INFO - 'tpaint', 05:20:17 INFO - 'sessionrestore', 05:20:17 INFO - 'sessionrestore_no_auto_restore', 05:20:17 INFO - 'tabpaint']}, 05:20:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['tsvgx', 05:20:17 INFO - 'tsvgr_opacity', 05:20:17 INFO - 'tart', 05:20:17 INFO - 'tscrollx', 05:20:17 INFO - 'cart']}, 05:20:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:17 INFO - 'tsvgr_opacity', 05:20:17 INFO - 'tart', 05:20:17 INFO - 'tscrollx', 05:20:17 INFO - 'cart']}, 05:20:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'talos_options': ['--disable-e10s'], 05:20:17 INFO - 'tests': ['tp5o']}, 05:20:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'tests': ['tp5o']}, 05:20:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'talos_options': ['--disable-e10s', 05:20:17 INFO - '--xperf_path', 05:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:17 INFO - 'tests': ['tp5n']}, 05:20:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:17 INFO - 'talos_options': ['--xperf_path', 05:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:17 INFO - 'tests': ['tp5n']}}, 05:20:17 INFO - 'talos.zip': {'path': '', 05:20:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:17 INFO - Running post-action listener: _resource_record_post_action 05:20:17 INFO - [mozharness: 2016-09-26 12:20:17.122250Z] Finished populate-webroot step (success) 05:20:17 INFO - [mozharness: 2016-09-26 12:20:17.122339Z] Running create-virtualenv step. 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: create_virtualenv 05:20:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:20:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:17 INFO - Using real prefix '/usr' 05:20:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:19 INFO - Installing pip.................done. 05:20:19 INFO - Return code: 0 05:20:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:20:19 INFO - Reading from file tmpfile_stdout 05:20:19 INFO - Output received: 05:20:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:20:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:19 INFO - Using env: {'DISPLAY': ':0', 05:20:19 INFO - 'HOME': '/home/cltbld', 05:20:19 INFO - 'LANG': 'en_US.UTF-8', 05:20:19 INFO - 'LANGUAGE': 'en_US:en', 05:20:19 INFO - 'LOGNAME': 'cltbld', 05:20:19 INFO - 'MAIL': '/var/mail/cltbld', 05:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:19 INFO - 'MOZ_NO_REMOTE': '1', 05:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:19 INFO - 'NO_EM_RESTART': '1', 05:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:19 INFO - 'PWD': '/builds/slave/test', 05:20:19 INFO - 'SHELL': '/bin/bash', 05:20:19 INFO - 'SHLVL': '1', 05:20:19 INFO - 'TERM': 'linux', 05:20:19 INFO - 'TMOUT': '86400', 05:20:19 INFO - 'USER': 'cltbld', 05:20:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:19 INFO - '_': '/tools/buildbot/bin/python'} 05:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:20:20 INFO - Cleaning up... 05:20:20 INFO - Return code: 0 05:20:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:20:20 INFO - Using env: {'DISPLAY': ':0', 05:20:20 INFO - 'HOME': '/home/cltbld', 05:20:20 INFO - 'LANG': 'en_US.UTF-8', 05:20:20 INFO - 'LANGUAGE': 'en_US:en', 05:20:20 INFO - 'LOGNAME': 'cltbld', 05:20:20 INFO - 'MAIL': '/var/mail/cltbld', 05:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:20 INFO - 'MOZ_NO_REMOTE': '1', 05:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:20 INFO - 'NO_EM_RESTART': '1', 05:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:20 INFO - 'PWD': '/builds/slave/test', 05:20:20 INFO - 'SHELL': '/bin/bash', 05:20:20 INFO - 'SHLVL': '1', 05:20:20 INFO - 'TERM': 'linux', 05:20:20 INFO - 'TMOUT': '86400', 05:20:20 INFO - 'USER': 'cltbld', 05:20:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:20 INFO - '_': '/tools/buildbot/bin/python'} 05:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:20 INFO - Downloading/unpacking psutil>=3.1.1 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:22 INFO - Installing collected packages: psutil 05:20:22 INFO - Running setup.py install for psutil 05:20:22 INFO - building 'psutil._psutil_linux' extension 05:20:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:20:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:20:22 INFO - building 'psutil._psutil_posix' extension 05:20:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:20:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:23 INFO - Successfully installed psutil 05:20:23 INFO - Cleaning up... 05:20:23 INFO - Return code: 0 05:20:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:23 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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:20:23 INFO - Using env: {'DISPLAY': ':0', 05:20:23 INFO - 'HOME': '/home/cltbld', 05:20:23 INFO - 'LANG': 'en_US.UTF-8', 05:20:23 INFO - 'LANGUAGE': 'en_US:en', 05:20:23 INFO - 'LOGNAME': 'cltbld', 05:20:23 INFO - 'MAIL': '/var/mail/cltbld', 05:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:23 INFO - 'MOZ_NO_REMOTE': '1', 05:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:23 INFO - 'NO_EM_RESTART': '1', 05:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:23 INFO - 'PWD': '/builds/slave/test', 05:20:23 INFO - 'SHELL': '/bin/bash', 05:20:23 INFO - 'SHLVL': '1', 05:20:23 INFO - 'TERM': 'linux', 05:20:23 INFO - 'TMOUT': '86400', 05:20:23 INFO - 'USER': 'cltbld', 05:20:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:23 INFO - '_': '/tools/buildbot/bin/python'} 05:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:25 INFO - Installing collected packages: mozsystemmonitor 05:20:25 INFO - Running setup.py install for mozsystemmonitor 05:20:25 INFO - Successfully installed mozsystemmonitor 05:20:25 INFO - Cleaning up... 05:20:25 INFO - Return code: 0 05:20:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:20:25 INFO - Using env: {'DISPLAY': ':0', 05:20:25 INFO - 'HOME': '/home/cltbld', 05:20:25 INFO - 'LANG': 'en_US.UTF-8', 05:20:25 INFO - 'LANGUAGE': 'en_US:en', 05:20:25 INFO - 'LOGNAME': 'cltbld', 05:20:25 INFO - 'MAIL': '/var/mail/cltbld', 05:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:25 INFO - 'MOZ_NO_REMOTE': '1', 05:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:25 INFO - 'NO_EM_RESTART': '1', 05:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:25 INFO - 'PWD': '/builds/slave/test', 05:20:25 INFO - 'SHELL': '/bin/bash', 05:20:25 INFO - 'SHLVL': '1', 05:20:25 INFO - 'TERM': 'linux', 05:20:25 INFO - 'TMOUT': '86400', 05:20:25 INFO - 'USER': 'cltbld', 05:20:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:25 INFO - '_': '/tools/buildbot/bin/python'} 05:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:27 INFO - warning: no files found matching '*.txt' 05:20:27 INFO - no previously-included directories found matching 'build' 05:20:27 INFO - no previously-included directories found matching 'dist' 05:20:27 INFO - no previously-included directories found matching '.git*' 05:20:27 INFO - Installing collected packages: jsonschema, functools32 05:20:27 INFO - Running setup.py install for functools32 05:20:27 INFO - warning: no files found matching '*.txt' 05:20:27 INFO - no previously-included directories found matching 'build' 05:20:27 INFO - no previously-included directories found matching 'dist' 05:20:27 INFO - no previously-included directories found matching '.git*' 05:20:27 INFO - Successfully installed jsonschema functools32 05:20:27 INFO - Cleaning up... 05:20:28 INFO - Return code: 0 05:20:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:20:28 INFO - Using env: {'DISPLAY': ':0', 05:20:28 INFO - 'HOME': '/home/cltbld', 05:20:28 INFO - 'LANG': 'en_US.UTF-8', 05:20:28 INFO - 'LANGUAGE': 'en_US:en', 05:20:28 INFO - 'LOGNAME': 'cltbld', 05:20:28 INFO - 'MAIL': '/var/mail/cltbld', 05:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:28 INFO - 'MOZ_NO_REMOTE': '1', 05:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:28 INFO - 'NO_EM_RESTART': '1', 05:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:28 INFO - 'PWD': '/builds/slave/test', 05:20:28 INFO - 'SHELL': '/bin/bash', 05:20:28 INFO - 'SHLVL': '1', 05:20:28 INFO - 'TERM': 'linux', 05:20:28 INFO - 'TMOUT': '86400', 05:20:28 INFO - 'USER': 'cltbld', 05:20:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:28 INFO - '_': '/tools/buildbot/bin/python'} 05:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:20:28 INFO - Cleaning up... 05:20:28 INFO - Return code: 0 05:20:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:20:28 INFO - Using env: {'DISPLAY': ':0', 05:20:28 INFO - 'HOME': '/home/cltbld', 05:20:28 INFO - 'LANG': 'en_US.UTF-8', 05:20:28 INFO - 'LANGUAGE': 'en_US:en', 05:20:28 INFO - 'LOGNAME': 'cltbld', 05:20:28 INFO - 'MAIL': '/var/mail/cltbld', 05:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:28 INFO - 'MOZ_NO_REMOTE': '1', 05:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:28 INFO - 'NO_EM_RESTART': '1', 05:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:28 INFO - 'PWD': '/builds/slave/test', 05:20:28 INFO - 'SHELL': '/bin/bash', 05:20:28 INFO - 'SHLVL': '1', 05:20:28 INFO - 'TERM': 'linux', 05:20:28 INFO - 'TMOUT': '86400', 05:20:28 INFO - 'USER': 'cltbld', 05:20:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:28 INFO - '_': '/tools/buildbot/bin/python'} 05:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - Downloading docopt-0.6.1.tar.gz 05:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:31 INFO - Running setup.py install for blobuploader 05:20:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:31 INFO - Running setup.py install for requests 05:20:31 INFO - Running setup.py install for docopt 05:20:31 INFO - Successfully installed blobuploader requests docopt 05:20:31 INFO - Cleaning up... 05:20:31 INFO - Return code: 0 05:20:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:31 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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:31 INFO - Using env: {'DISPLAY': ':0', 05:20:31 INFO - 'HOME': '/home/cltbld', 05:20:31 INFO - 'LANG': 'en_US.UTF-8', 05:20:31 INFO - 'LANGUAGE': 'en_US:en', 05:20:31 INFO - 'LOGNAME': 'cltbld', 05:20:31 INFO - 'MAIL': '/var/mail/cltbld', 05:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:31 INFO - 'MOZ_NO_REMOTE': '1', 05:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:31 INFO - 'NO_EM_RESTART': '1', 05:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:31 INFO - 'PWD': '/builds/slave/test', 05:20:31 INFO - 'SHELL': '/bin/bash', 05:20:31 INFO - 'SHLVL': '1', 05:20:31 INFO - 'TERM': 'linux', 05:20:31 INFO - 'TMOUT': '86400', 05:20:31 INFO - 'USER': 'cltbld', 05:20:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:31 INFO - '_': '/tools/buildbot/bin/python'} 05:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:31 INFO - Running setup.py (path:/tmp/pip-qaSTmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:32 INFO - Running setup.py (path:/tmp/pip-IFNQE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:32 INFO - Running setup.py (path:/tmp/pip-4JLW83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:32 INFO - Running setup.py (path:/tmp/pip-uhZNAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:32 INFO - Running setup.py (path:/tmp/pip-WLe1mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:32 INFO - Running setup.py (path:/tmp/pip-scNYoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:32 INFO - Running setup.py (path:/tmp/pip-4omvaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:32 INFO - Running setup.py (path:/tmp/pip-K2wtuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:32 INFO - Running setup.py (path:/tmp/pip-xyZ_By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:32 INFO - Running setup.py (path:/tmp/pip-Op7oxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:32 INFO - Running setup.py (path:/tmp/pip-2E86eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:32 INFO - Running setup.py (path:/tmp/pip-ApIZJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:32 INFO - Running setup.py (path:/tmp/pip-HNVTY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:32 INFO - Running setup.py (path:/tmp/pip-0Jkl8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:32 INFO - Running setup.py (path:/tmp/pip-f_jrQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:33 INFO - Running setup.py (path:/tmp/pip-Dq2vrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:33 INFO - Running setup.py (path:/tmp/pip-MMHTcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:33 INFO - Running setup.py install for manifestparser 05:20:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Running setup.py install for mozcrash 05:20:33 INFO - Running setup.py install for mozdebug 05:20:33 INFO - Running setup.py install for mozdevice 05:20:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Running setup.py install for mozfile 05:20:33 INFO - Running setup.py install for mozhttpd 05:20:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Running setup.py install for mozinfo 05:20:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Running setup.py install for mozInstall 05:20:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:33 INFO - Running setup.py install for mozleak 05:20:34 INFO - Running setup.py install for mozlog 05:20:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for moznetwork 05:20:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozprocess 05:20:34 INFO - Running setup.py install for mozprofile 05:20:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozrunner 05:20:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozscreenshot 05:20:34 INFO - Running setup.py install for moztest 05:20:34 INFO - Running setup.py install for mozversion 05:20:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:34 INFO - Cleaning up... 05:20:35 INFO - Return code: 0 05:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:35 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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:35 INFO - Using env: {'DISPLAY': ':0', 05:20:35 INFO - 'HOME': '/home/cltbld', 05:20:35 INFO - 'LANG': 'en_US.UTF-8', 05:20:35 INFO - 'LANGUAGE': 'en_US:en', 05:20:35 INFO - 'LOGNAME': 'cltbld', 05:20:35 INFO - 'MAIL': '/var/mail/cltbld', 05:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:35 INFO - 'MOZ_NO_REMOTE': '1', 05:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:35 INFO - 'NO_EM_RESTART': '1', 05:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:35 INFO - 'PWD': '/builds/slave/test', 05:20:35 INFO - 'SHELL': '/bin/bash', 05:20:35 INFO - 'SHLVL': '1', 05:20:35 INFO - 'TERM': 'linux', 05:20:35 INFO - 'TMOUT': '86400', 05:20:35 INFO - 'USER': 'cltbld', 05:20:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:35 INFO - '_': '/tools/buildbot/bin/python'} 05:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:35 INFO - Running setup.py (path:/tmp/pip-UGfkBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:35 INFO - Running setup.py (path:/tmp/pip-rws1Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:35 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)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:35 INFO - Running setup.py (path:/tmp/pip-Jy7jZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:35 INFO - Running setup.py (path:/tmp/pip-AgsFup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:35 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)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:35 INFO - Running setup.py (path:/tmp/pip-BUjGXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:35 INFO - Running setup.py (path:/tmp/pip-DREt2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:35 INFO - Running setup.py (path:/tmp/pip-d_i7ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:35 INFO - Running setup.py (path:/tmp/pip-lkuXGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:35 INFO - Running setup.py (path:/tmp/pip-aTlixx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:35 INFO - Running setup.py (path:/tmp/pip-NfNXCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:35 INFO - Running setup.py (path:/tmp/pip-wKZjBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:36 INFO - Running setup.py (path:/tmp/pip-q0XwOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:36 INFO - Running setup.py (path:/tmp/pip-MmrcoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:36 INFO - Running setup.py (path:/tmp/pip-6hUUoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:36 INFO - Running setup.py (path:/tmp/pip-nsJeLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:36 INFO - Running setup.py (path:/tmp/pip-ysswIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:36 INFO - Running setup.py (path:/tmp/pip-CpNbsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:20:36 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)) 05:20:36 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)) 05:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:36 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)) 05:20:36 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)) 05:20:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:38 INFO - Downloading blessings-1.6.tar.gz 05:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:38 INFO - Installing collected packages: blessings 05:20:38 INFO - Running setup.py install for blessings 05:20:38 INFO - Successfully installed blessings 05:20:38 INFO - Cleaning up... 05:20:38 INFO - Return code: 0 05:20:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:38 INFO - Reading from file tmpfile_stdout 05:20:38 INFO - Current package versions: 05:20:38 INFO - argparse == 1.2.1 05:20:38 INFO - blessings == 1.6 05:20:38 INFO - blobuploader == 1.2.4 05:20:38 INFO - docopt == 0.6.1 05:20:38 INFO - functools32 == 3.2.3-2 05:20:38 INFO - jsonschema == 2.5.1 05:20:38 INFO - manifestparser == 1.1 05:20:38 INFO - mozInstall == 1.12 05:20:38 INFO - mozcrash == 0.17 05:20:38 INFO - mozdebug == 0.1 05:20:38 INFO - mozdevice == 0.48 05:20:38 INFO - mozfile == 1.2 05:20:38 INFO - mozhttpd == 0.7 05:20:38 INFO - mozinfo == 0.9 05:20:38 INFO - mozleak == 0.1 05:20:38 INFO - mozlog == 3.4 05:20:38 INFO - moznetwork == 0.27 05:20:38 INFO - mozprocess == 0.23 05:20:38 INFO - mozprofile == 0.28 05:20:38 INFO - mozrunner == 6.12 05:20:38 INFO - mozscreenshot == 0.1 05:20:38 INFO - mozsystemmonitor == 0.3 05:20:38 INFO - moztest == 0.7 05:20:38 INFO - mozversion == 1.4 05:20:38 INFO - psutil == 3.1.1 05:20:38 INFO - requests == 1.2.3 05:20:38 INFO - wsgiref == 0.1.2 05:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:38 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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:38 INFO - Using env: {'DISPLAY': ':0', 05:20:38 INFO - 'HOME': '/home/cltbld', 05:20:38 INFO - 'LANG': 'en_US.UTF-8', 05:20:38 INFO - 'LANGUAGE': 'en_US:en', 05:20:38 INFO - 'LOGNAME': 'cltbld', 05:20:38 INFO - 'MAIL': '/var/mail/cltbld', 05:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:38 INFO - 'MOZ_NO_REMOTE': '1', 05:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:38 INFO - 'NO_EM_RESTART': '1', 05:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:38 INFO - 'PWD': '/builds/slave/test', 05:20:38 INFO - 'SHELL': '/bin/bash', 05:20:38 INFO - 'SHLVL': '1', 05:20:38 INFO - 'TERM': 'linux', 05:20:38 INFO - 'TMOUT': '86400', 05:20:38 INFO - 'USER': 'cltbld', 05:20:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:38 INFO - '_': '/tools/buildbot/bin/python'} 05:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:39 INFO - Cleaning up... 05:20:39 INFO - Return code: 0 05:20:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:39 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 0x7fab983cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1521ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:20:39 INFO - Using env: {'DISPLAY': ':0', 05:20:39 INFO - 'HOME': '/home/cltbld', 05:20:39 INFO - 'LANG': 'en_US.UTF-8', 05:20:39 INFO - 'LANGUAGE': 'en_US:en', 05:20:39 INFO - 'LOGNAME': 'cltbld', 05:20:39 INFO - 'MAIL': '/var/mail/cltbld', 05:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:39 INFO - 'MOZ_NO_REMOTE': '1', 05:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:39 INFO - 'NO_EM_RESTART': '1', 05:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:39 INFO - 'PWD': '/builds/slave/test', 05:20:39 INFO - 'SHELL': '/bin/bash', 05:20:39 INFO - 'SHLVL': '1', 05:20:39 INFO - 'TERM': 'linux', 05:20:39 INFO - 'TMOUT': '86400', 05:20:39 INFO - 'USER': 'cltbld', 05:20:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:39 INFO - '_': '/tools/buildbot/bin/python'} 05:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:39 INFO - Cleaning up... 05:20:39 INFO - Return code: 0 05:20:39 INFO - Running post-action listener: _resource_record_post_action 05:20:39 INFO - Running post-action listener: _start_resource_monitoring 05:20:39 INFO - Starting resource monitoring. 05:20:39 INFO - [mozharness: 2016-09-26 12:20:39.281645Z] Finished create-virtualenv step (success) 05:20:39 INFO - [mozharness: 2016-09-26 12:20:39.282236Z] Running install step. 05:20:39 INFO - Running pre-action listener: _resource_record_pre_action 05:20:39 INFO - Running main action method: install 05:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:39 INFO - Reading from file tmpfile_stdout 05:20:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:39 INFO - Reading from file tmpfile_stdout 05:20:39 INFO - Output received: 05:20:39 INFO - Usage: mozinstall [options] installer 05:20:39 INFO - Options: 05:20:39 INFO - -h, --help show this help message and exit 05:20:39 INFO - -d DEST, --destination=DEST 05:20:39 INFO - Directory to install application into. [default: 05:20:39 INFO - "/builds/slave/test"] 05:20:39 INFO - --app=APP Application being installed. [default: firefox] 05:20:39 INFO - mkdir: /builds/slave/test/build/application 05:20:39 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'] 05:20:39 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 05:20:55 INFO - Reading from file tmpfile_stdout 05:20:55 INFO - Output received: 05:20:55 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:55 INFO - Running post-action listener: _resource_record_post_action 05:20:55 INFO - [mozharness: 2016-09-26 12:20:55.668500Z] Finished install step (success) 05:20:55 INFO - [mozharness: 2016-09-26 12:20:55.668743Z] Running run-tests step. 05:20:55 INFO - Running pre-action listener: _resource_record_pre_action 05:20:55 INFO - Running main action method: run_tests 05:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:55 INFO - Python 2.7.3 05:20:55 INFO - Return code: 0 05:20:55 INFO - grabbing minidump binary from tooltool 05:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:55 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 0x151ef60>, '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 0x151fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15201d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:20:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:20:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:20:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:55 INFO - Return code: 0 05:20:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 05:20:55 INFO - Using env: {'DISPLAY': ':0', 05:20:55 INFO - 'HOME': '/home/cltbld', 05:20:55 INFO - 'LANG': 'en_US.UTF-8', 05:20:55 INFO - 'LANGUAGE': 'en_US:en', 05:20:55 INFO - 'LOGNAME': 'cltbld', 05:20:55 INFO - 'MAIL': '/var/mail/cltbld', 05:20:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:55 INFO - 'MOZ_NO_REMOTE': '1', 05:20:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:55 INFO - 'NO_EM_RESTART': '1', 05:20:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:55 INFO - 'PWD': '/builds/slave/test', 05:20:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:55 INFO - 'SHELL': '/bin/bash', 05:20:55 INFO - 'SHLVL': '1', 05:20:55 INFO - 'TERM': 'linux', 05:20:55 INFO - 'TMOUT': '86400', 05:20:55 INFO - 'USER': 'cltbld', 05:20:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934', 05:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:55 INFO - '_': '/tools/buildbot/bin/python'} 05:20:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:20:55 INFO - mozversion application_buildid: 20160926033554 05:20:55 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 05:20:55 INFO - mozversion application_display_name: Nightly 05:20:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:55 INFO - mozversion application_name: Firefox 05:20:55 INFO - mozversion application_remotingname: firefox 05:20:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:20:55 INFO - mozversion application_vendor: Mozilla 05:20:55 INFO - mozversion application_version: 52.0a1 05:20:55 INFO - mozversion platform_buildid: 20160926033554 05:20:55 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 05:20:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:20:55 INFO - mozversion platform_version: 52.0a1 05:20:55 INFO - using testdate: 1474892455 05:20:55 INFO - actual date: 1474892455 05:20:55 INFO - starting webserver on 'localhost:49856' 05:20:55 INFO - SUITE-START | Running 2 tests 05:20:55 INFO - TEST-START | dromaeo_css 05:20:55 INFO - operating with platform_type : linux_ 05:20:55 INFO - Initialising browser for dromaeo_css test... 05:20:55 INFO - TEST-INFO | started process 394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSedFp4/profile http://localhost:49856/getInfo.html) 05:21:00 INFO - PROCESS | 394 | __metrics Screen width/height:1600/1200 05:21:00 INFO - PROCESS | 394 | colorDepth:24 05:21:00 INFO - PROCESS | 394 | Browser inner width/height: 1024/697 05:21:00 INFO - PROCESS | 394 | __metrics 05:21:01 ERROR - PROCESS | 394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 05:21:02 INFO - TEST-INFO | 394: exit 0 05:21:02 INFO - Browser initialized. 05:21:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:02 INFO - TEST-INFO | started process 517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSedFp4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:14 INFO - PROCESS | 517 | RSS: Main: 186171392 05:21:14 INFO - PROCESS | 517 | 05:22:04 INFO - PROCESS | 517 | 1474892524495 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:24:17 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49856/tests/dromaeo/cssquery-ext.html) 05:24:18 INFO - PROCESS | 517 | RSS: Main: 200040448 05:24:18 INFO - PROCESS | 517 | 05:27:20 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-ext.html (next: http://localhost:49856/tests/dromaeo/cssquery-jquery.html) 05:27:21 INFO - PROCESS | 517 | RSS: Main: 196513792 05:27:21 INFO - PROCESS | 517 | 05:30:23 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49856/tests/dromaeo/cssquery-mootools.html) 05:30:23 INFO - PROCESS | 517 | RSS: Main: 198684672 05:30:23 INFO - PROCESS | 517 | 05:33:25 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49856/tests/dromaeo/cssquery-prototype.html) 05:33:26 INFO - PROCESS | 517 | RSS: Main: 195194880 05:33:26 INFO - PROCESS | 517 | 05:36:29 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49856/tests/dromaeo/cssquery-yui.html) 05:36:30 INFO - PROCESS | 517 | RSS: Main: 198217728 05:36:30 INFO - PROCESS | 517 | 05:39:32 INFO - PROCESS | 517 | Cycle 1(1): loaded http://localhost:49856/tests/dromaeo/cssquery-yui.html (next: http://localhost:49856/tests/dromaeo/cssquery-dojo.html) 05:39:33 INFO - PROCESS | 517 | RSS: Main: 199458816 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | __start_tp_report 05:39:33 INFO - PROCESS | 517 | _x_x_mozilla_page_load 05:39:33 INFO - PROCESS | 517 | _x_x_mozilla_page_load_details 05:39:33 INFO - PROCESS | 517 | |i|pagename|runs| 05:39:33 INFO - PROCESS | 517 | |0;dojo.html;2593.9092131775387;2606.687197536296;2610.569256072748;2632.197179860143;2640.524705553001;4500.437445319335;4663.673542851998;4670;4694.882627934303;4718.056388722252;4522.321651752239;4612.054528821592;4664.720116792995;4706.317583950334;4726.85819425417;4230.9153816923645;4301.935470967938;4308.332208507686;4357.128574285156;4414.337849322611;4363.236433624119;4384.079343337887;4402.691811573191;4421.579949904753;4473.306637471197;4173.6661067114555;4208.537060923296;4279.058607106432;4318.201132790444;4365.301551751736;4341.587549182823;4344.674149438773;4390.100029493946;4399.076193999264;4400.493943196541;4275.486941567001;4280.550542193056;4321.373400856858;4327.242732521828;4375.7155784873885;4553.430821147356;4588.862334129982;4689.554492323224;4716.3868697069165;4721.929171062437;5062.11413002723;5094.566961808214;5099;5145.382554093495;5149.407818100929;5100.285959965608;5101.846944591631;5108.872278193037;5111.514406131411;5168.870778230575;4472.664550158686;4521.4574251089425;4759.5002524734755;4764.475907650121;4820.325154478376;5103.642745007888;5138.332016837787;5144.819931302386;5164.56101231392;5215.68705877641;4931.802727890916;4931.901361972812;4940.086084074458;4946.060248552835;5008.749562521933;4807.870150514626;4865.829695960624;4882.584980276645;5016.698998060128;5039.5212454817465;4857;4885.487023862514;4888.486708895586;4905.754712264373;4906.411230652273;4841.419029716457;4878.317035615017;4882.658213924991;4933.950660493421;4941.135301322254;4113.382992551141;4125.216208920296;4142.316517774594;4178.26880295947;4181.958180418157;3573.76770509916;3588.946165807515;3633.291508155937;3644.562652481666;3706.09200745819;4326.740395576276;4348.108637729258;4355.041890784022;4357.825686972549;4420.381146639473;5042;5046.722430266371;5046.974765126224;5048.3184770056305;5088.542031217208;4182.581741825793;4237.279662457389;4364.323529852814;4373.1253749249645;4403.119376124788;4393.626541743924;4420.823167073281;4434.955650443519;4441.71128876622;4503.617192538671;4653.697509661861;4663.160631086302;4686.718796872198;4704.0827038728485;4744.667873248839;4849.854504364875;4964;4966.528179822911;4976.925346119883;5028.622853285945;4594.747288899142;4693.366395536559;4724.763761811964;4752.144613969519;4804.543568361;4959.355283813081;4962.900741985212;4968.105740966516;4969;5004.199328107486;4980.32765576657;5027.245913113063;5040.218766091261;5040.873978150576;5112.590992720499;4680.438347398334;4730.47964723887;4732.124556956974;4787.162246606899;4802.639802014793;4786.569208771228;4815.109204797123;4836.613070954386;4864.635152363658;4908.288298196813;4580.67935244543;4645.651576131736;4704.670673052853;4785.186518291968;4793.880152996203;4765.8570242892765;4802.495737947465;4836;4836.153673107263;4916.8770780730765;4585.587297143273;4674.368960190467;4726.787294571684;4739.431268247832;4783.689060211075 05:39:33 INFO - PROCESS | 517 | |1;ext.html;510.90803655342023;539.827255278311;551.2970962023417;558.1516095534787;560.0423276197702;27450.313742156457;30042.248943776445;30144.246393840138;38583.61416385835;39919.401208981886;39804;40222;40227;40266.19467610646;40312.39531407031;7517.436192285587;7737.110232323271;7742.729004484844;7744.148143704217;7773.455858089936;7630.923690763105;7697.230276972314;7703.8844417333785;7711.768646940601;7716.498427602216;7698.846023079535;7759;7760.767176984671;7767.650455729506;7776.844463110734;7697.0378702662165;7735.8452830943625;7738.419618528576;7738.651760670727;7740.845183096363;7654.923450765476;7716.2669546393;7734.03324584427;7739.496932699357;7747.612619369065;37112.62887371119;37402.438963415574;37453.438198427044;37528;37546.812265938766;2947.64628244612;3032.8331941743195;3056.9082927511986;3239.514072889062;3244.23760416302;28201.153965381072;28286.434271314458;28383.85808070967;28513;29874.551881721793;3487.7732947358595;3541.3448512025357;3578.4632305154173;3616.1140520572367;3628;238657;238899;239210;239308;240317.99999999825;31152.68847311543;32256.35487290241;52174.47825521772;52347.47652523502;52542;33352;33476.33047339088;33592.99221023373;33659;33661.83169084139;13136.60590182296;13231.139975901535;13236.13965092266;13236.669083272802;13281.734365312639;10196.898031019595;10199.337043092175;10211;10211.897881021094;10227.181825453947;7775.105862825847;7818.648160832776;7848.21517848222;7854.685812567547;7900.644470998819;3069.892553760608;3089.4130115278026;3118.6257649082254;3125.4374212641487;3143.1513491357205;830.1117803949836;852.9829403411896;860.0625318402971;934.6962237272777;938.9765155980015;26435.73564264371;27568.310792229953;27850.5822412664;28047.018354357908;28562.714372856422;868.8783570300163;929.6513807322254;978.5596481583174;992.93545919515;1035.321864178964;13509.864901351057;14357.78463323051;14613.19627420502;14641.780373294408;14668.486602968846;341946;351221;351373;351637;351762;46340.3048954266;47166.292505612444;47409;47468.52531474641;47484.28773568399;1183.1954271095565;1198.2091819399154;1216.720154364501;1219.0552321950559;1230.0958795285637;24620.753792461845;24749.62875556904;25224.409820820783;25607.359816004748;25616.48767024612;40644;41045.38431923583;41055.38416923689;41056.58943410528;41063.38404923869;306763;307896;308767;308931;309591;24852.75147248577;24900.252992410256;25210.369740755894;25219.117330894063;25246.747532525176;40212.3968140484;40248.798756006036;40394.79802600968;40818.38772418476;41289.79355103205;35000.64999349974;35194.47208291929;35234.47148292829;35398.64601353953;35819;35055.29889402249;35275.11812204613;35424.291514169054;35872.64127358693;35952.64047359493;33943.15142121368;34222.486662700576;34605.13487162841;34646.480302794975;34920.47619285763;29396.55905161467;31899.202519937186;31907.68092319047;31955.201119972186;31962.36075278435;24350;24407.38981525476;24519.877400612884;24782.38044048913;24854.50290994206 05:39:33 INFO - PROCESS | 517 | |2;jquery.html;349.86005597760874;363.2009578926362;371.39833469778955;373.9139997800504;382.4149051950515;15522;15529;17009.91495042523;17018.40435584755;17034.403795867147;16388.83611163888;16456.094914779682;16502.66994660106;16774.07742574158;16898.66202675946;4832.4925882782245;5075.9492405076035;5083.720395378253;5084.618653600976;5088.7964481420695;4985.476524964881;5011.173156429185;5058.038972595214;5073.036123136592;5074.619403544731;4881.804727810883;4964.255361695738;4992.07646585381;4996.7001979881325;5041.092603331399;4939.728314942677;4986.07757564848;5001.249812528132;5001.374828146481;5002.924956125661;4374.846880359172;4467.218236808578;4485.641148708096;4494.438195225597;4496.190685676577;18798;19719;19860.40418787439;20748.58502829935;20923;1790.7761529808774;1860.7767067951797;1908.3702378215294;1937.6124775044907;2121.3847984084596;9227.953860230657;9396.530173491366;9618.448303329618;9765.365251258716;11573.36346500942;1687.2997705952139;1715.4596302164778;1719.5099396672013;1769.5222289981762;1778.6976214043514;64213.67893160551;67349.66325168342;68054.3194568058;68857.3114268861;68995;9452.763680907894;9535.332526723201;9671.90328096724;9707.126358627616;9866.322725136744;12966.935165324114;12992.675183120498;13001;13010.804837927439;13013.284269365087;6575.901361479581;6788.801649615346;6891.724331026703;7057.964710176519;7193.964030179815;6506.41442270198;6528.640924749185;6679.79960601173;6912.447004239649;6932.792016239521;3952.822123004414;4026.7583944963394;4044.8988775280854;4048.230836141183;4151.6886233532005;1761.8414342708961;1771.2560724495743;1790.7672002639833;1814.219885449243;1851.2502436513234;731.6122455098806;788.8501184774874;882.6778225947482;893.6104357723802;900.1268769293774;16428.6714265714;16521.686963825076;16621.6675666486;16966;17242.568935776704;862.7153039496951;869.8260347930312;887.1173182683272;896.5786080542135;915.2632131134501;9077.273818094536;9410.482423466776;9564.760880977892;9849.50752462374;9951.751206219902;351067.64857338514;359009;359524;359934;361577;42614.14771704611;43088.78455607765;70251;78673;79739;846.1749793950848;878.7056336127341;878.8198419324024;882.4352414454754;883.1168831168832;14947.177905215318;15027.023243489139;15276;15442;15489.690206196039;37045.44431833471;37472.437913431866;37768.244635106596;38056.619433806416;38490.23019539649;51458;51569.74215128901;51897.22154167766;51995.48004519907;53032.46967530275;6458.7093580789915;6896.103506544117;7044.436445084483;7199.8560028800175;7862.488938218998;11418.257813242113;12210.694732631755;12335.198212116184;12476.625701228977;12490.562830300896;10072.345297555928;10287.177025838064;10317.329373590692;10401.115905148146;10846.728831779268;9477;10064.094231519199;10132.189424846141;10432.909928413523;10469.68590942273;10366.378017318984;10545.894541054799;10738.248322617343;10885.401302928098;10976.560937562408;7577.659005344663;7903.525788452711;7903.723369682263;7905.486143400661;7995;10370;10420.947895260475;10529.05238528536;10669.839952400875;10799.784004319712 05:39:33 INFO - PROCESS | 517 | |3;mootools.html;1323.3978539764407;1343.0464370297088;1381.6269607206054;1566.8271010736764;1605.899958528409;6717.563358381714;6959.269276725947;7111.146662400506;7704.46068775186;7774.22257774223;7094.822629434254;7377.372923301512;7387.445941554378;7527.059117610299;7543.6605352759125;2123.4054464749893;2161.459635091227;2174.2281490071036;2175.434387059368;2180.746071009168;2076.8546201765807;2153.450870028141;2154.5260042790637;2158.4064382294837;2161.9783802162015;2098.8845613491253;2124.6812978053263;2125.521757604542;2127.3405244374217;2173.1741938063515;2126.755423126345;2132.5628246209567;2142.368001439579;2146.3453646637768;2146.6672665736837;2102.9158833646634;2136.83973701973;2138.764735879052;2139.850210485267;2146.034284571949;7457.627118644046;7581.469297149201;7587.089549254069;7598.0502437195355;7608.657610407489;4346.695731298811;4450.376947227391;4467.642588592905;4468.262736648449;4470.26240670289;2755.3800394911186;2830.2358363242015;2870.956935645967;2888.595596616475;2939.118264520657;901.9413738107002;960.8894977077656;972.7568107973007;975.0298453039271;981.0630847540582;9766.07222313886;9779.217662587047;9795.804083918352;9810.65662701802;9832.655857044969;3903.277893589695;4034.717569770147;4047.251258517184;4189.455370801777;4225.915481690349;8286.00567931852;8399.076101628816;8404.621792019374;8412.705555305534;8444.831103377897;4469.776511174428;4487.977560112244;4511.1654343946475;4511.436070491189;4514.232580461329;3636.454531820248;3745.6254374562873;3982.661473774762;4051.108756073659;4078.877633670995;3498.8600455981477;3505.9298814023578;3570.9821450892578;3601.9639803602154;3634.109643137448;1211.8000529912465;1212.6422705301957;1224.3388570172185;1226.3132645718426;1229.4344601483417;646.5991085527004;784.3881772217679;798.7044793426469;807.8828569857455;820.8153165537825;4969.279454479152;5195.870103247449;5282.709450980233;5302;5570.721463926788;847.3814115695577;868.3617541107282;872.8647059705755;894.7673604862653;901.9052999434965;3485.5643044619424;3573.7855728656364;3637.1452708613456;3667.94498082529;3753.099256178552;9011.369204155777;9237.752903358096;9286.257099432029;9355.391899526645;9391.671291504901;9266.351355405057;9286.07139286066;9294.674686385944;9323.766905827408;9365.063493650581;6890;6966.616836073963;7048.154221493351;7049.295070493013;7166.498345115792;4836.177849765478;4972.751362431936;5083.237514372874;5092.465291144525;5144.9742751286;8267.255946964562;8453.112423195722;8564.443311184754;8578.313734901069;8603.311735061305;8320.625571849161;8552.273056790242;8691.391602587759;8700.78248043804;8712.91287087121;5783.971080144573;6012.308584512837;6246.500279977682;6351.428371446592;6416.935830641633;6953.304669533006;7166.426685865223;7303.379212766974;7329.863871099988;7361.705531778669;6433.356664333529;6454.419102280817;6491.318411566906;6639.302873198438;6668.866622667422;6377.266614339224;6432.163818703726;6435.388638079375;6466.935330646634;6516.543841931019;5904.261967254093;5998.990338236739;6006.129111278753;6009.158717779427;6050.334463208956;4281.828726850891;4319.740815551077;4397.230484665235;4408.515063342966;4418.0059486615255;4370.213361594943;4401.075774087478;4445.5109937907455;4447;4453.844115455943 05:39:33 INFO - PROCESS | 517 | |4;prototype.html;286.6388350678145;288.90321742216355;297.37254393230285;300.06679227602154;303.362937830556;4772.069446457942;4877.878053048676;4955.207166853304;4996.550310472061;4999.275105109761;4712.835050773224;4820.8553743387665;4862.586680132193;4873.634477414191;4876.268924531784;3847.4228865670093;3852.248811481762;3852.5569559500736;3857.3635350167187;3859.787711675857;3615.0781550704532;3859.1316953685478;3866.941995870064;3868.5492940147446;3870.283997460479;3777.3956167013284;3791.393377059671;3792.848286068554;3794.981025094871;3804.5814960354337;3778.9985653801764;3787.6401741834484;3793.4878791363367;3794.5636251831115;3801.8669346573015;3205.599300087489;3328.5007248912857;3330.200751819546;3338.2989572189867;3354.748393870445;4771.880702982418;4772.856814295576;4781.928271075936;4787.281907713836;4791;4340.392345071693;4340.656045735299;4348.608625223745;4349.26062569364;4359.542248063971;4881.925976285212;5106.923396149061;5111.6932984020705;5114.772454610904;5116.846494605168;3623.5832879218965;3623.981880090609;3632.2020599803004;3635.745497815154;3640.981795091034;5263.421023687391;5285.9207111892965;5290.894182116374;5294.54996325309;5322.414534401213;3553.928921421557;3555.1645363339594;3560.786352818839;3567.6789088981595;3576.1046645278043;3506.7194624429985;3576.3920133576835;3726.142987112925;3786.981065094712;3795.4686343911876;4319.352097185384;4320.783960801948;4321.762303073298;4326.524082350938;4337.4795024596615;5136.614753893473;5145.897082058413;5146.228065790161;5170.793168273302;5189.652674025233;1218.8476440444945;1254.6110705681267;1255.8869701726705;1282.742911946298;1295.8898493628146;855.724969795001;872.7730789994647;886.609891647673;889.2441424788877;890.1676932068536;4428.269335559597;4440.667799660089;4442.933355999663;4450.332450132506;4459.420275364182;5148.562372198405;5155.9742201288755;5156.819511317086;5174.353205849269;5180.274761533388;4411.205982923105;4428.7121337112985;4438.467383913951;4443.866683999485;4462.397576327219;2317.6986991690974;2425.8787060646896;2434.5009273099326;2440.7071151461582;2451.33813870254;4297.78511074445;4306.720063195882;4311.396404503372;4329.393884856123;4338.544452832471;4688.507062238586;4697.906041879211;4711.95288047122;4718.882027949328;4721.905561888743;4325.545817689161;4613.40025796651;4953.777080031407;4974.925376119289;4995.800167993385;5322.920156197582;5325.458570051028;5327.147656375117;5329.1206950852675;5329.893402131858;5192.27308176848;5228.536009917229;5236.9738151309;5243.921341179809;5257.132573125392;4706.341112244357;4955.1576232039915;4991.376077990251;4997.400311962442;5009.173486374707;3676;3711.740178187501;3728.496652951817;3739.08392443853;3741.5136032315627;5027.296178534935;5274.657147285414;5309.283246761638;5309.495597918191;5322.840314790563;4740.691855029412;5122.692638441706;5148.403994761636;5159.948400515947;5183.922241166461;5151.587872970228;5157.432682404858;5159.922601161061;5189.5609063739985;5194.74026298676;4880.585150262267;5033.169527028146;5037.319961805256;5059.822906198266;5135.948640513547;5164.804957892956;5169.612279079009;5173.689578625294;5194.3247377840635;5195.59688404096;5046.924296135488;5055.115354812967;5065.848024559269;5066.9239961401345;5078.568321692697 05:39:33 INFO - PROCESS | 517 | |5;yui.html;640.9967950160249;655.6361219523163;674.352621483376;746.9066366704162;759.9886001709975;13022.609321720352;13436.3953622087;13513.121647092932;13521.661958451032;13565.118267312619;13199.736005279889;13381.464741410357;13411.664708382295;13433.529826456075;13449.125806822574;616.602291521968;639.0350570638346;737;748.3265061444689;759.5139110968985;774.7056118674896;774.802425381527;774.8062984253936;775.2402645407504;778.1557010643459;832.5296207642663;834.1033389106705;837.6523742646795;837.660747397305;839.0099682374795;828.2462958707578;828.7928017995501;829.4276948905236;830.1739768929954;831.4429332347281;610.8350745298744;611.7675283392327;611.9541034422436;612.2530512774408;612.9172561704157;13397.86602133976;13442.663933401645;13449.865501344959;13457.932710336483;13466.192028478225;13656.385462654205;13914.791278130837;13942.16347019172;14291.714165716732;14395.78406323906;11037.613683521038;11073.446327683583;11102.167337449724;11114.888851111547;11149.275297105662;3347.5313456116164;3386.9491957620658;3403.081168084603;3410.4543273076188;3508.456189290664;51172.488275117146;52622.73688631571;52662.21006684903;66202;67516.6624166876;10489.475526223658;10591.311564748266;10701.25091243621;10763.300385475075;10813.08088812444;18295.451136465927;18576.44270671882;18615;18620.627587448445;18929.621407571773;6370.617762934239;6786.4910131739325;6960.756373526902;7053.647317634201;7055.541389809646;3586.5158203642695;3669.2844895245703;3710.8515659373325;3733.253349330145;3768.3970564709516;3097.411491816548;3216.8552415141376;3221.5650887130405;3228.951565726516;3239.5626590409993;514.5446280042189;533.1443033930564;538.3943064052941;539.1723704114166;552.5331095224528;421.54052083229425;460.26587592789446;510.9310243117206;514.5086442447454;531.2031952071892;7480.139783924918;7637.312641862259;7699.076110866732;8043.39674524413;8106.272770080996;492.87431704915736;498.4765995704568;503.88662550926483;511.9070783876451;519.3482179864321;3714.517112775322;3863.517060367454;3950.664193543581;4031.5363733170475;4032.536258330271;87558.7464752117;99651.50174249083;100948.49525752472;104138;104659.476702616;82597;88293.11706882977;88625.55687221652;88693.55653221693;88831;78062;78477.21522784814;78837;79408.20591794123;79814;7035.753748618774;7269.963650181715;7329.230430804689;7380;7647.273509016634;43071.56928430676;43664.781676091414;44188;45279;45640.771796140805;63130;66932.33067669261;67719.3228067713;67931.66034169798;69729.30270697227;9320.673776417792;9602.807943841224;9643.180329671775;9676.806463870542;9716.75708107303;10370.844437333597;10576.4711764413;10715.678529644123;10853.240273180802;11367.943160284145;9407.4825884577;9412;9634.373765705206;9662;10229.795404091728;9229.815403692022;9368.250539956924;9453.810923781624;9554.904450955402;9661.516924153904;8580.485170889766;8702.869456958277;8891.4665120093;9106.499142547224;9453.669121580711;8298.875516867372;8431.367647426345;8435.15648435176;8561.785955351166;8725.083866193958;7642.235776422313;7717.845643087219;8024.959875200587;8068.435209535276;8071.273585377344 05:39:33 INFO - PROCESS | 517 | __end_tp_report 05:39:33 INFO - PROCESS | 517 | __start_cc_report 05:39:33 INFO - PROCESS | 517 | _x_x_mozilla_cycle_collect,349 05:39:33 INFO - PROCESS | 517 | __end_cc_report 05:39:33 INFO - PROCESS | 517 | __startTimestamp1474893573140__endTimestamp 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | ------- Summary: start ------- 05:39:33 INFO - PROCESS | 517 | Number of tests: 6 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#0] dojo.html Cycles:165 Average:4609.39 Median:4721.93 stddev:487.30 (10.3%) stddev-sans-first:462.43 05:39:33 INFO - PROCESS | 517 | Values: 2593.9 2606.7 2610.6 2632.2 2640.5 4500.4 4663.7 4670.0 4694.9 4718.1 4522.3 4612.1 4664.7 4706.3 4726.9 4230.9 4301.9 4308.3 4357.1 4414.3 4363.2 4384.1 4402.7 4421.6 4473.3 4173.7 4208.5 4279.1 4318.2 4365.3 4341.6 4344.7 4390.1 4399.1 4400.5 4275.5 4280.6 4321.4 4327.2 4375.7 4553.4 4588.9 4689.6 4716.4 4721.9 5062.1 5094.6 5099.0 5145.4 5149.4 5100.3 5101.8 5108.9 5111.5 5168.9 4472.7 4521.5 4759.5 4764.5 4820.3 5103.6 5138.3 5144.8 5164.6 5215.7 4931.8 4931.9 4940.1 4946.1 5008.7 4807.9 4865.8 4882.6 5016.7 5039.5 4857.0 4885.5 4888.5 4905.8 4906.4 4841.4 4878.3 4882.7 4934.0 4941.1 4113.4 4125.2 4142.3 4178.3 4182.0 3573.8 3588.9 3633.3 3644.6 3706.1 4326.7 4348.1 4355.0 4357.8 4420.4 5042.0 5046.7 5047.0 5048.3 5088.5 4182.6 4237.3 4364.3 4373.1 4403.1 4393.6 4420.8 4435.0 4441.7 4503.6 4653.7 4663.2 4686.7 4704.1 4744.7 4849.9 4964.0 4966.5 4976.9 5028.6 4594.7 4693.4 4724.8 4752.1 4804.5 4959.4 4962.9 4968.1 4969.0 5004.2 4980.3 5027.2 5040.2 5040.9 5112.6 4680.4 4730.5 4732.1 4787.2 4802.6 4786.6 4815.1 4836.6 4864.6 4908.3 4580.7 4645.7 4704.7 4785.2 4793.9 4765.9 4802.5 4836.0 4836.2 4916.9 4585.6 4674.4 4726.8 4739.4 4783.7 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#1] ext.html Cycles:180 Average:43887.92 Median:351297.00 stddev:79652.50 (22.7%) stddev-sans-first:79809.37 05:39:33 INFO - PROCESS | 517 | Values: 510.9 539.8 551.3 558.2 560.0 27450.3 30042.2 30144.2 38583.6 39919.4 39804.0 40222.0 40227.0 40266.2 40312.4 7517.4 7737.1 7742.7 7744.1 7773.5 7630.9 7697.2 7703.9 7711.8 7716.5 7698.8 7759.0 7760.8 7767.7 7776.8 7697.0 7735.8 7738.4 7738.7 7740.8 7654.9 7716.3 7734.0 7739.5 7747.6 37112.6 37402.4 37453.4 37528.0 37546.8 2947.6 3032.8 3056.9 3239.5 3244.2 28201.2 28286.4 28383.9 28513.0 29874.6 3487.8 3541.3 3578.5 3616.1 3628.0 238657.0 238899.0 239210.0 239308.0 240318.0 31152.7 32256.4 52174.5 52347.5 52542.0 33352.0 33476.3 33593.0 33659.0 33661.8 13136.6 13231.1 13236.1 13236.7 13281.7 10196.9 10199.3 10211.0 10211.9 10227.2 7775.1 7818.6 7848.2 7854.7 7900.6 3069.9 3089.4 3118.6 3125.4 3143.2 830.1 853.0 860.1 934.7 939.0 26435.7 27568.3 27850.6 28047.0 28562.7 868.9 929.7 978.6 992.9 1035.3 13509.9 14357.8 14613.2 14641.8 14668.5 341946.0 351221.0 351373.0 351637.0 351762.0 46340.3 47166.3 47409.0 47468.5 47484.3 1183.2 1198.2 1216.7 1219.1 1230.1 24620.8 24749.6 25224.4 25607.4 25616.5 40644.0 41045.4 41055.4 41056.6 41063.4 306763.0 307896.0 308767.0 308931.0 309591.0 24852.8 24900.3 25210.4 25219.1 25246.7 40212.4 40248.8 40394.8 40818.4 41289.8 35000.6 35194.5 35234.5 35398.6 35819.0 35055.3 35275.1 35424.3 35872.6 35952.6 33943.2 34222.5 34605.1 34646.5 34920.5 29396.6 31899.2 31907.7 31955.2 31962.4 24350.0 24407.4 24519.9 24782.4 24854.5 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#2] jquery.html Cycles:180 Average:22916.21 Median:42851.47 stddev:59137.82 (138.0%) stddev-sans-first:59279.44 05:39:33 INFO - PROCESS | 517 | Values: 349.9 363.2 371.4 373.9 382.4 15522.0 15529.0 17009.9 17018.4 17034.4 16388.8 16456.1 16502.7 16774.1 16898.7 4832.5 5075.9 5083.7 5084.6 5088.8 4985.5 5011.2 5058.0 5073.0 5074.6 4881.8 4964.3 4992.1 4996.7 5041.1 4939.7 4986.1 5001.2 5001.4 5002.9 4374.8 4467.2 4485.6 4494.4 4496.2 18798.0 19719.0 19860.4 20748.6 20923.0 1790.8 1860.8 1908.4 1937.6 2121.4 9228.0 9396.5 9618.4 9765.4 11573.4 1687.3 1715.5 1719.5 1769.5 1778.7 64213.7 67349.7 68054.3 68857.3 68995.0 9452.8 9535.3 9671.9 9707.1 9866.3 12966.9 12992.7 13001.0 13010.8 13013.3 6575.9 6788.8 6891.7 7058.0 7194.0 6506.4 6528.6 6679.8 6912.4 6932.8 3952.8 4026.8 4044.9 4048.2 4151.7 1761.8 1771.3 1790.8 1814.2 1851.3 731.6 788.9 882.7 893.6 900.1 16428.7 16521.7 16621.7 16966.0 17242.6 862.7 869.8 887.1 896.6 915.3 9077.3 9410.5 9564.8 9849.5 9951.8 351067.6 359009.0 359524.0 359934.0 361577.0 42614.1 43088.8 70251.0 78673.0 79739.0 846.2 878.7 878.8 882.4 883.1 14947.2 15027.0 15276.0 15442.0 15489.7 37045.4 37472.4 37768.2 38056.6 38490.2 51458.0 51569.7 51897.2 51995.5 53032.5 6458.7 6896.1 7044.4 7199.9 7862.5 11418.3 12210.7 12335.2 12476.6 12490.6 10072.3 10287.2 10317.3 10401.1 10846.7 9477.0 10064.1 10132.2 10432.9 10469.7 10366.4 10545.9 10738.2 10885.4 10976.6 7577.7 7903.5 7903.7 7905.5 7995.0 10370.0 10420.9 10529.1 10669.8 10799.8 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#3] mootools.html Cycles:180 Average:4929.14 Median:5844.12 stddev:2699.02 (46.2%) stddev-sans-first:2692.99 05:39:33 INFO - PROCESS | 517 | Values: 1323.4 1343.0 1381.6 1566.8 1605.9 6717.6 6959.3 7111.1 7704.5 7774.2 7094.8 7377.4 7387.4 7527.1 7543.7 2123.4 2161.5 2174.2 2175.4 2180.7 2076.9 2153.5 2154.5 2158.4 2162.0 2098.9 2124.7 2125.5 2127.3 2173.2 2126.8 2132.6 2142.4 2146.3 2146.7 2102.9 2136.8 2138.8 2139.9 2146.0 7457.6 7581.5 7587.1 7598.1 7608.7 4346.7 4450.4 4467.6 4468.3 4470.3 2755.4 2830.2 2871.0 2888.6 2939.1 901.9 960.9 972.8 975.0 981.1 9766.1 9779.2 9795.8 9810.7 9832.7 3903.3 4034.7 4047.3 4189.5 4225.9 8286.0 8399.1 8404.6 8412.7 8444.8 4469.8 4488.0 4511.2 4511.4 4514.2 3636.5 3745.6 3982.7 4051.1 4078.9 3498.9 3505.9 3571.0 3602.0 3634.1 1211.8 1212.6 1224.3 1226.3 1229.4 646.6 784.4 798.7 807.9 820.8 4969.3 5195.9 5282.7 5302.0 5570.7 847.4 868.4 872.9 894.8 901.9 3485.6 3573.8 3637.1 3667.9 3753.1 9011.4 9237.8 9286.3 9355.4 9391.7 9266.4 9286.1 9294.7 9323.8 9365.1 6890.0 6966.6 7048.2 7049.3 7166.5 4836.2 4972.8 5083.2 5092.5 5145.0 8267.3 8453.1 8564.4 8578.3 8603.3 8320.6 8552.3 8691.4 8700.8 8712.9 5784.0 6012.3 6246.5 6351.4 6416.9 6953.3 7166.4 7303.4 7329.9 7361.7 6433.4 6454.4 6491.3 6639.3 6668.9 6377.3 6432.2 6435.4 6466.9 6516.5 5904.3 5999.0 6006.1 6009.2 6050.3 4281.8 4319.7 4397.2 4408.5 4418.0 4370.2 4401.1 4445.5 4447.0 4453.8 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#4] prototype.html Cycles:180 Average:4189.44 Median:4712.39 stddev:1236.74 (26.2%) stddev-sans-first:1205.02 05:39:33 INFO - PROCESS | 517 | Values: 286.6 288.9 297.4 300.1 303.4 4772.1 4877.9 4955.2 4996.6 4999.3 4712.8 4820.9 4862.6 4873.6 4876.3 3847.4 3852.2 3852.6 3857.4 3859.8 3615.1 3859.1 3866.9 3868.5 3870.3 3777.4 3791.4 3792.8 3795.0 3804.6 3779.0 3787.6 3793.5 3794.6 3801.9 3205.6 3328.5 3330.2 3338.3 3354.7 4771.9 4772.9 4781.9 4787.3 4791.0 4340.4 4340.7 4348.6 4349.3 4359.5 4881.9 5106.9 5111.7 5114.8 5116.8 3623.6 3624.0 3632.2 3635.7 3641.0 5263.4 5285.9 5290.9 5294.5 5322.4 3553.9 3555.2 3560.8 3567.7 3576.1 3506.7 3576.4 3726.1 3787.0 3795.5 4319.4 4320.8 4321.8 4326.5 4337.5 5136.6 5145.9 5146.2 5170.8 5189.7 1218.8 1254.6 1255.9 1282.7 1295.9 855.7 872.8 886.6 889.2 890.2 4428.3 4440.7 4442.9 4450.3 4459.4 5148.6 5156.0 5156.8 5174.4 5180.3 4411.2 4428.7 4438.5 4443.9 4462.4 2317.7 2425.9 2434.5 2440.7 2451.3 4297.8 4306.7 4311.4 4329.4 4338.5 4688.5 4697.9 4712.0 4718.9 4721.9 4325.5 4613.4 4953.8 4974.9 4995.8 5322.9 5325.5 5327.1 5329.1 5329.9 5192.3 5228.5 5237.0 5243.9 5257.1 4706.3 4955.2 4991.4 4997.4 5009.2 3676.0 3711.7 3728.5 3739.1 3741.5 5027.3 5274.7 5309.3 5309.5 5322.8 4740.7 5122.7 5148.4 5159.9 5183.9 5151.6 5157.4 5159.9 5189.6 5194.7 4880.6 5033.2 5037.3 5059.8 5135.9 5164.8 5169.6 5173.7 5194.3 5195.6 5046.9 5055.1 5065.8 5066.9 5078.6 05:39:33 INFO - PROCESS | 517 | 05:39:33 INFO - PROCESS | 517 | [#5] yui.html Cycles:180 Average:17690.64 Median:612.59 stddev:26194.14 (4276.0%) stddev-sans-first:26236.34 05:39:33 INFO - PROCESS | 517 | Values: 641.0 655.6 674.4 746.9 760.0 13022.6 13436.4 13513.1 13521.7 13565.1 13199.7 13381.5 13411.7 13433.5 13449.1 616.6 639.0 737.0 748.3 759.5 774.7 774.8 774.8 775.2 778.2 832.5 834.1 837.7 837.7 839.0 828.2 828.8 829.4 830.2 831.4 610.8 611.8 612.0 612.3 612.9 13397.9 13442.7 13449.9 13457.9 13466.2 13656.4 13914.8 13942.2 14291.7 14395.8 11037.6 11073.4 11102.2 11114.9 11149.3 3347.5 3386.9 3403.1 3410.5 3508.5 51172.5 52622.7 52662.2 66202.0 67516.7 10489.5 10591.3 10701.3 10763.3 10813.1 18295.5 18576.4 18615.0 18620.6 18929.6 6370.6 6786.5 6960.8 7053.6 7055.5 3586.5 3669.3 3710.9 3733.3 3768.4 3097.4 3216.9 3221.6 3229.0 3239.6 514.5 533.1 538.4 539.2 552.5 421.5 460.3 510.9 514.5 531.2 7480.1 7637.3 7699.1 8043.4 8106.3 492.9 498.5 503.9 511.9 519.3 3714.5 3863.5 3950.7 4031.5 4032.5 87558.7 99651.5 100948.5 104138.0 104659.5 82597.0 88293.1 88625.6 88693.6 88831.0 78062.0 78477.2 78837.0 79408.2 79814.0 7035.8 7270.0 7329.2 7380.0 7647.3 43071.6 43664.8 44188.0 45279.0 45640.8 63130.0 66932.3 67719.3 67931.7 69729.3 9320.7 9602.8 9643.2 9676.8 9716.8 10370.8 10576.5 10715.7 10853.2 11367.9 9407.5 9412.0 9634.4 9662.0 10229.8 9229.8 9368.3 9453.8 9554.9 9661.5 8580.5 8702.9 8891.5 9106.5 9453.7 8298.9 8431.4 8435.2 8561.8 8725.1 7642.2 7717.8 8025.0 8068.4 8071.3 05:39:33 INFO - PROCESS | 517 | -------- Summary: end -------- 05:39:33 INFO - PROCESS | 517 | 05:39:34 INFO - TEST-INFO | 517: exit 0 05:39:34 INFO - TEST-OK | dromaeo_css | took 1118300ms 05:39:34 INFO - TEST-START | kraken 05:39:34 INFO - operating with platform_type : linux_ 05:39:34 INFO - Initialising browser for kraken test... 05:39:34 INFO - TEST-INFO | started process 889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7IRog/profile http://localhost:49856/getInfo.html) 05:39:39 INFO - PROCESS | 889 | __metrics Screen width/height:1600/1200 05:39:39 INFO - PROCESS | 889 | colorDepth:24 05:39:39 INFO - PROCESS | 889 | Browser inner width/height: 1024/697 05:39:39 INFO - PROCESS | 889 | __metrics 05:39:39 ERROR - PROCESS | 889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 05:39:40 INFO - TEST-INFO | 889: exit 0 05:39:40 INFO - Browser initialized. 05:39:40 INFO - Running cycle 1/1 for kraken test... 05:39:40 INFO - TEST-INFO | started process 1008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7IRog/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:53 INFO - PROCESS | 1008 | RSS: Main: 186060800 05:39:53 INFO - PROCESS | 1008 | 05:39:56 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49856/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:57 INFO - PROCESS | 1008 | RSS: Main: 199933952 05:39:57 INFO - PROCESS | 1008 | 05:39:59 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49856/tests/kraken/driver.html?testName=audio-dft) 05:40:00 INFO - PROCESS | 1008 | RSS: Main: 198000640 05:40:00 INFO - PROCESS | 1008 | 05:40:03 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49856/tests/kraken/driver.html?testName=audio-fft) 05:40:04 INFO - PROCESS | 1008 | RSS: Main: 193671168 05:40:04 INFO - PROCESS | 1008 | 05:40:06 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49856/tests/kraken/driver.html?testName=audio-oscillator) 05:40:06 INFO - PROCESS | 1008 | RSS: Main: 194068480 05:40:06 INFO - PROCESS | 1008 | 05:40:09 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:09 INFO - PROCESS | 1008 | RSS: Main: 194756608 05:40:09 INFO - PROCESS | 1008 | 05:40:12 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49856/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:13 INFO - PROCESS | 1008 | RSS: Main: 194482176 05:40:13 INFO - PROCESS | 1008 | 05:40:17 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49856/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:17 INFO - PROCESS | 1008 | RSS: Main: 192659456 05:40:17 INFO - PROCESS | 1008 | 05:40:20 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49856/tests/kraken/driver.html?testName=json-parse-financial) 05:40:21 INFO - PROCESS | 1008 | RSS: Main: 193974272 05:40:21 INFO - PROCESS | 1008 | 05:40:23 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:23 INFO - PROCESS | 1008 | RSS: Main: 194187264 05:40:23 INFO - PROCESS | 1008 | 05:40:25 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:26 INFO - PROCESS | 1008 | RSS: Main: 194113536 05:40:26 INFO - PROCESS | 1008 | 05:40:28 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:29 INFO - PROCESS | 1008 | RSS: Main: 194551808 05:40:29 INFO - PROCESS | 1008 | 05:40:32 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:32 INFO - PROCESS | 1008 | RSS: Main: 194871296 05:40:32 INFO - PROCESS | 1008 | 05:40:35 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:36 INFO - PROCESS | 1008 | RSS: Main: 194617344 05:40:36 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | Cycle 1(1): loaded http://localhost:49856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49856/tests/kraken/driver.html?testName=ai-astar) 05:40:38 INFO - PROCESS | 1008 | RSS: Main: 197132288 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | __start_tp_report 05:40:38 INFO - PROCESS | 1008 | _x_x_mozilla_page_load 05:40:38 INFO - PROCESS | 1008 | _x_x_mozilla_page_load_details 05:40:38 INFO - PROCESS | 1008 | |i|pagename|runs| 05:40:38 INFO - PROCESS | 1008 | |0;ai-astar;107;114;114;115;115;115;116;115;115;117 05:40:38 INFO - PROCESS | 1008 | |1;audio-beat-detection;155;127;130;176;126;127;126;127;160;127 05:40:38 INFO - PROCESS | 1008 | |2;audio-dft;169;175;163;165;167;167;162;167;162;167 05:40:38 INFO - PROCESS | 1008 | |3;audio-fft;76;77;78;118;79;79;76;77;113;77 05:40:38 INFO - PROCESS | 1008 | |4;audio-oscillator;84;84;123;84;85;84;100;84;84;113 05:40:38 INFO - PROCESS | 1008 | |5;imaging-gaussian-blur;119;118;119;118;118;119;120;120;119;119 05:40:38 INFO - PROCESS | 1008 | |6;imaging-darkroom;149;147;149;150;149;151;150;149;147;148 05:40:38 INFO - PROCESS | 1008 | |7;imaging-desaturate;95;96;95;97;97;97;97;97;96;96 05:40:38 INFO - PROCESS | 1008 | |8;json-parse-financial;65;67;64;64;64;66;66;65;67;66 05:40:38 INFO - PROCESS | 1008 | |9;json-stringify-tinderbox;66;66;66;67;66;66;67;67;67;66 05:40:38 INFO - PROCESS | 1008 | |10;stanford-crypto-aes;84;84;84;84;84;86;83;92;83;93 05:40:38 INFO - PROCESS | 1008 | |11;stanford-crypto-ccm;138;136;145;147;146;137;143;136;168;150 05:40:38 INFO - PROCESS | 1008 | |12;stanford-crypto-pbkdf2;187;177;180;175;178;178;182;177;179;180 05:40:38 INFO - PROCESS | 1008 | |13;stanford-crypto-sha256-iterative;71;73;71;75;68;73;77;70;69;71 05:40:38 INFO - PROCESS | 1008 | __end_tp_report 05:40:38 INFO - PROCESS | 1008 | __start_cc_report 05:40:38 INFO - PROCESS | 1008 | _x_x_mozilla_cycle_collect,866 05:40:38 INFO - PROCESS | 1008 | __end_cc_report 05:40:38 INFO - PROCESS | 1008 | __startTimestamp1474893638377__endTimestamp 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ------- Summary: start ------- 05:40:38 INFO - PROCESS | 1008 | Number of tests: 14 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 05:40:38 INFO - PROCESS | 1008 | Values: 107.0 114.0 114.0 115.0 115.0 115.0 116.0 115.0 115.0 117.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:128.50 stddev:18.42 (14.3%) stddev-sans-first:18.49 05:40:38 INFO - PROCESS | 1008 | Values: 155.0 127.0 130.0 176.0 126.0 127.0 126.0 127.0 160.0 127.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:3.86 (2.3%) stddev-sans-first:3.98 05:40:38 INFO - PROCESS | 1008 | Values: 169.0 175.0 163.0 165.0 167.0 167.0 162.0 167.0 162.0 167.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#3] audio-fft Cycles:10 Average:85.00 Median:77.00 stddev:16.15 (21.0%) stddev-sans-first:16.80 05:40:38 INFO - PROCESS | 1008 | Values: 76.0 77.0 78.0 118.0 79.0 79.0 76.0 77.0 113.0 77.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:14.52 (17.3%) stddev-sans-first:15.07 05:40:38 INFO - PROCESS | 1008 | Values: 84.0 84.0 123.0 84.0 85.0 84.0 100.0 84.0 84.0 113.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 05:40:38 INFO - PROCESS | 1008 | Values: 119.0 118.0 119.0 118.0 118.0 119.0 120.0 120.0 119.0 119.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 05:40:38 INFO - PROCESS | 1008 | Values: 149.0 147.0 149.0 150.0 149.0 151.0 150.0 149.0 147.0 148.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.73 05:40:38 INFO - PROCESS | 1008 | Values: 95.0 96.0 95.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 05:40:38 INFO - PROCESS | 1008 | Values: 65.0 67.0 64.0 64.0 64.0 66.0 66.0 65.0 67.0 66.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:40:38 INFO - PROCESS | 1008 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 67.0 66.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.00 stddev:3.68 (4.4%) stddev-sans-first:3.86 05:40:38 INFO - PROCESS | 1008 | Values: 84.0 84.0 84.0 84.0 84.0 86.0 83.0 92.0 83.0 93.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:145.50 stddev:9.64 (6.6%) stddev-sans-first:9.92 05:40:38 INFO - PROCESS | 1008 | Values: 138.0 136.0 145.0 147.0 146.0 137.0 143.0 136.0 168.0 150.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:179.50 stddev:3.33 (1.9%) stddev-sans-first:2.07 05:40:38 INFO - PROCESS | 1008 | Values: 187.0 177.0 180.0 175.0 178.0 178.0 182.0 177.0 179.0 180.0 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:2.74 (3.8%) stddev-sans-first:2.89 05:40:38 INFO - PROCESS | 1008 | Values: 71.0 73.0 71.0 75.0 68.0 73.0 77.0 70.0 69.0 71.0 05:40:38 INFO - PROCESS | 1008 | -------- Summary: end -------- 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | 05:40:38 INFO - PROCESS | 1008 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:40:38 INFO - PROCESS | 1008 | 05:40:39 INFO - TEST-INFO | 1008: exit 0 05:40:39 INFO - TEST-OK | kraken | took 65404ms 05:40:39 INFO - SUITE-END | took 1183s 05:40:40 INFO - Completed test suite (00:19:44) 05:40:40 INFO - javascript benchmark 05:40:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6186.898224257409, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.9092131775387, 2606.687197536296, 2610.569256072748, 2632.197179860143, 2640.524705553001, 4500.437445319335, 4663.673542851998, 4670.0, 4694.882627934303, 4718.056388722252, 4522.321651752239, 4612.054528821592, 4664.720116792995, 4706.317583950334, 4726.85819425417, 4230.9153816923645, 4301.935470967938, 4308.332208507686, 4357.128574285156, 4414.337849322611, 4363.236433624119, 4384.079343337887, 4402.691811573191, 4421.579949904753, 4473.306637471197, 4173.6661067114555, 4208.537060923296, 4279.058607106432, 4318.201132790444, 4365.301551751736, 4341.587549182823, 4344.674149438773, 4390.100029493946, 4399.076193999264, 4400.493943196541, 4275.486941567001, 4280.550542193056, 4321.373400856858, 4327.242732521828, 4375.7155784873885, 4553.430821147356, 4588.862334129982, 4689.554492323224, 4716.3868697069165, 4721.929171062437, 5062.11413002723, 5094.566961808214, 5099.0, 5145.382554093495, 5149.407818100929, 5100.285959965608, 5101.846944591631, 5108.872278193037, 5111.514406131411, 5168.870778230575, 4472.664550158686, 4521.4574251089425, 4759.5002524734755, 4764.475907650121, 4820.325154478376, 5103.642745007888, 5138.332016837787, 5144.819931302386, 5164.56101231392, 5215.68705877641, 4931.802727890916, 4931.901361972812, 4940.086084074458, 4946.060248552835, 5008.749562521933, 4807.870150514626, 4865.829695960624, 4882.584980276645, 5016.698998060128, 5039.5212454817465, 4857.0, 4885.487023862514, 4888.486708895586, 4905.754712264373, 4906.411230652273, 4841.419029716457, 4878.317035615017, 4882.658213924991, 4933.950660493421, 4941.135301322254, 4113.382992551141, 4125.216208920296, 4142.316517774594, 4178.26880295947, 4181.958180418157, 3573.76770509916, 3588.946165807515, 3633.291508155937, 3644.562652481666, 3706.09200745819, 4326.740395576276, 4348.108637729258, 4355.041890784022, 4357.825686972549, 4420.381146639473, 5042.0, 5046.722430266371, 5046.974765126224, 5048.3184770056305, 5088.542031217208, 4182.581741825793, 4237.279662457389, 4364.323529852814, 4373.1253749249645, 4403.119376124788, 4393.626541743924, 4420.823167073281, 4434.955650443519, 4441.71128876622, 4503.617192538671, 4653.697509661861, 4663.160631086302, 4686.718796872198, 4704.0827038728485, 4744.667873248839, 4849.854504364875, 4964.0, 4966.528179822911, 4976.925346119883, 5028.622853285945, 4594.747288899142, 4693.366395536559, 4724.763761811964, 4752.144613969519, 4804.543568361, 4959.355283813081, 4962.900741985212, 4968.105740966516, 4969.0, 5004.199328107486, 4980.32765576657, 5027.245913113063, 5040.218766091261, 5040.873978150576, 5112.590992720499, 4680.438347398334, 4730.47964723887, 4732.124556956974, 4787.162246606899, 4802.639802014793, 4786.569208771228, 4815.109204797123, 4836.613070954386, 4864.635152363658, 4908.288298196813, 4580.67935244543, 4645.651576131736, 4704.670673052853, 4785.186518291968, 4793.880152996203, 4765.8570242892765, 4802.495737947465, 4836.0, 4836.153673107263, 4916.8770780730765, 4585.587297143273, 4674.368960190467, 4726.787294571684, 4739.431268247832, 4783.689060211075], "value": 4578.297491668834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.90803655342023, 539.827255278311, 551.2970962023417, 558.1516095534787, 560.0423276197702, 27450.313742156457, 30042.248943776445, 30144.246393840138, 38583.61416385835, 39919.401208981886, 39804.0, 40222.0, 40227.0, 40266.19467610646, 40312.39531407031, 7517.436192285587, 7737.110232323271, 7742.729004484844, 7744.148143704217, 7773.455858089936, 7630.923690763105, 7697.230276972314, 7703.8844417333785, 7711.768646940601, 7716.498427602216, 7698.846023079535, 7759.0, 7760.767176984671, 7767.650455729506, 7776.844463110734, 7697.0378702662165, 7735.8452830943625, 7738.419618528576, 7738.651760670727, 7740.845183096363, 7654.923450765476, 7716.2669546393, 7734.03324584427, 7739.496932699357, 7747.612619369065, 37112.62887371119, 37402.438963415574, 37453.438198427044, 37528.0, 37546.812265938766, 2947.64628244612, 3032.8331941743195, 3056.9082927511986, 3239.514072889062, 3244.23760416302, 28201.153965381072, 28286.434271314458, 28383.85808070967, 28513.0, 29874.551881721793, 3487.7732947358595, 3541.3448512025357, 3578.4632305154173, 3616.1140520572367, 3628.0, 238657.0, 238899.0, 239210.0, 239308.0, 240317.99999999825, 31152.68847311543, 32256.35487290241, 52174.47825521772, 52347.47652523502, 52542.0, 33352.0, 33476.33047339088, 33592.99221023373, 33659.0, 33661.83169084139, 13136.60590182296, 13231.139975901535, 13236.13965092266, 13236.669083272802, 13281.734365312639, 10196.898031019595, 10199.337043092175, 10211.0, 10211.897881021094, 10227.181825453947, 7775.105862825847, 7818.648160832776, 7848.21517848222, 7854.685812567547, 7900.644470998819, 3069.892553760608, 3089.4130115278026, 3118.6257649082254, 3125.4374212641487, 3143.1513491357205, 830.1117803949836, 852.9829403411896, 860.0625318402971, 934.6962237272777, 938.9765155980015, 26435.73564264371, 27568.310792229953, 27850.5822412664, 28047.018354357908, 28562.714372856422, 868.8783570300163, 929.6513807322254, 978.5596481583174, 992.93545919515, 1035.321864178964, 13509.864901351057, 14357.78463323051, 14613.19627420502, 14641.780373294408, 14668.486602968846, 341946.0, 351221.0, 351373.0, 351637.0, 351762.0, 46340.3048954266, 47166.292505612444, 47409.0, 47468.52531474641, 47484.28773568399, 1183.1954271095565, 1198.2091819399154, 1216.720154364501, 1219.0552321950559, 1230.0958795285637, 24620.753792461845, 24749.62875556904, 25224.409820820783, 25607.359816004748, 25616.48767024612, 40644.0, 41045.38431923583, 41055.38416923689, 41056.58943410528, 41063.38404923869, 306763.0, 307896.0, 308767.0, 308931.0, 309591.0, 24852.75147248577, 24900.252992410256, 25210.369740755894, 25219.117330894063, 25246.747532525176, 40212.3968140484, 40248.798756006036, 40394.79802600968, 40818.38772418476, 41289.79355103205, 35000.64999349974, 35194.47208291929, 35234.47148292829, 35398.64601353953, 35819.0, 35055.29889402249, 35275.11812204613, 35424.291514169054, 35872.64127358693, 35952.64047359493, 33943.15142121368, 34222.486662700576, 34605.13487162841, 34646.480302794975, 34920.47619285763, 29396.55905161467, 31899.202519937186, 31907.68092319047, 31955.201119972186, 31962.36075278435, 24350.0, 24407.38981525476, 24519.877400612884, 24782.38044048913, 24854.50290994206], "value": 15955.176157351154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.86005597760874, 363.2009578926362, 371.39833469778955, 373.9139997800504, 382.4149051950515, 15522.0, 15529.0, 17009.91495042523, 17018.40435584755, 17034.403795867147, 16388.83611163888, 16456.094914779682, 16502.66994660106, 16774.07742574158, 16898.66202675946, 4832.4925882782245, 5075.9492405076035, 5083.720395378253, 5084.618653600976, 5088.7964481420695, 4985.476524964881, 5011.173156429185, 5058.038972595214, 5073.036123136592, 5074.619403544731, 4881.804727810883, 4964.255361695738, 4992.07646585381, 4996.7001979881325, 5041.092603331399, 4939.728314942677, 4986.07757564848, 5001.249812528132, 5001.374828146481, 5002.924956125661, 4374.846880359172, 4467.218236808578, 4485.641148708096, 4494.438195225597, 4496.190685676577, 18798.0, 19719.0, 19860.40418787439, 20748.58502829935, 20923.0, 1790.7761529808774, 1860.7767067951797, 1908.3702378215294, 1937.6124775044907, 2121.3847984084596, 9227.953860230657, 9396.530173491366, 9618.448303329618, 9765.365251258716, 11573.36346500942, 1687.2997705952139, 1715.4596302164778, 1719.5099396672013, 1769.5222289981762, 1778.6976214043514, 64213.67893160551, 67349.66325168342, 68054.3194568058, 68857.3114268861, 68995.0, 9452.763680907894, 9535.332526723201, 9671.90328096724, 9707.126358627616, 9866.322725136744, 12966.935165324114, 12992.675183120498, 13001.0, 13010.804837927439, 13013.284269365087, 6575.901361479581, 6788.801649615346, 6891.724331026703, 7057.964710176519, 7193.964030179815, 6506.41442270198, 6528.640924749185, 6679.79960601173, 6912.447004239649, 6932.792016239521, 3952.822123004414, 4026.7583944963394, 4044.8988775280854, 4048.230836141183, 4151.6886233532005, 1761.8414342708961, 1771.2560724495743, 1790.7672002639833, 1814.219885449243, 1851.2502436513234, 731.6122455098806, 788.8501184774874, 882.6778225947482, 893.6104357723802, 900.1268769293774, 16428.6714265714, 16521.686963825076, 16621.6675666486, 16966.0, 17242.568935776704, 862.7153039496951, 869.8260347930312, 887.1173182683272, 896.5786080542135, 915.2632131134501, 9077.273818094536, 9410.482423466776, 9564.760880977892, 9849.50752462374, 9951.751206219902, 351067.64857338514, 359009.0, 359524.0, 359934.0, 361577.0, 42614.14771704611, 43088.78455607765, 70251.0, 78673.0, 79739.0, 846.1749793950848, 878.7056336127341, 878.8198419324024, 882.4352414454754, 883.1168831168832, 14947.177905215318, 15027.023243489139, 15276.0, 15442.0, 15489.690206196039, 37045.44431833471, 37472.437913431866, 37768.244635106596, 38056.619433806416, 38490.23019539649, 51458.0, 51569.74215128901, 51897.22154167766, 51995.48004519907, 53032.46967530275, 6458.7093580789915, 6896.103506544117, 7044.436445084483, 7199.8560028800175, 7862.488938218998, 11418.257813242113, 12210.694732631755, 12335.198212116184, 12476.625701228977, 12490.562830300896, 10072.345297555928, 10287.177025838064, 10317.329373590692, 10401.115905148146, 10846.728831779268, 9477.0, 10064.094231519199, 10132.189424846141, 10432.909928413523, 10469.68590942273, 10366.378017318984, 10545.894541054799, 10738.248322617343, 10885.401302928098, 10976.560937562408, 7577.659005344663, 7903.525788452711, 7903.723369682263, 7905.486143400661, 7995.0, 10370.0, 10420.947895260475, 10529.05238528536, 10669.839952400875, 10799.784004319712], "value": 7984.9579439908675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.3978539764407, 1343.0464370297088, 1381.6269607206054, 1566.8271010736764, 1605.899958528409, 6717.563358381714, 6959.269276725947, 7111.146662400506, 7704.46068775186, 7774.22257774223, 7094.822629434254, 7377.372923301512, 7387.445941554378, 7527.059117610299, 7543.6605352759125, 2123.4054464749893, 2161.459635091227, 2174.2281490071036, 2175.434387059368, 2180.746071009168, 2076.8546201765807, 2153.450870028141, 2154.5260042790637, 2158.4064382294837, 2161.9783802162015, 2098.8845613491253, 2124.6812978053263, 2125.521757604542, 2127.3405244374217, 2173.1741938063515, 2126.755423126345, 2132.5628246209567, 2142.368001439579, 2146.3453646637768, 2146.6672665736837, 2102.9158833646634, 2136.83973701973, 2138.764735879052, 2139.850210485267, 2146.034284571949, 7457.627118644046, 7581.469297149201, 7587.089549254069, 7598.0502437195355, 7608.657610407489, 4346.695731298811, 4450.376947227391, 4467.642588592905, 4468.262736648449, 4470.26240670289, 2755.3800394911186, 2830.2358363242015, 2870.956935645967, 2888.595596616475, 2939.118264520657, 901.9413738107002, 960.8894977077656, 972.7568107973007, 975.0298453039271, 981.0630847540582, 9766.07222313886, 9779.217662587047, 9795.804083918352, 9810.65662701802, 9832.655857044969, 3903.277893589695, 4034.717569770147, 4047.251258517184, 4189.455370801777, 4225.915481690349, 8286.00567931852, 8399.076101628816, 8404.621792019374, 8412.705555305534, 8444.831103377897, 4469.776511174428, 4487.977560112244, 4511.1654343946475, 4511.436070491189, 4514.232580461329, 3636.454531820248, 3745.6254374562873, 3982.661473774762, 4051.108756073659, 4078.877633670995, 3498.8600455981477, 3505.9298814023578, 3570.9821450892578, 3601.9639803602154, 3634.109643137448, 1211.8000529912465, 1212.6422705301957, 1224.3388570172185, 1226.3132645718426, 1229.4344601483417, 646.5991085527004, 784.3881772217679, 798.7044793426469, 807.8828569857455, 820.8153165537825, 4969.279454479152, 5195.870103247449, 5282.709450980233, 5302.0, 5570.721463926788, 847.3814115695577, 868.3617541107282, 872.8647059705755, 894.7673604862653, 901.9052999434965, 3485.5643044619424, 3573.7855728656364, 3637.1452708613456, 3667.94498082529, 3753.099256178552, 9011.369204155777, 9237.752903358096, 9286.257099432029, 9355.391899526645, 9391.671291504901, 9266.351355405057, 9286.07139286066, 9294.674686385944, 9323.766905827408, 9365.063493650581, 6890.0, 6966.616836073963, 7048.154221493351, 7049.295070493013, 7166.498345115792, 4836.177849765478, 4972.751362431936, 5083.237514372874, 5092.465291144525, 5144.9742751286, 8267.255946964562, 8453.112423195722, 8564.443311184754, 8578.313734901069, 8603.311735061305, 8320.625571849161, 8552.273056790242, 8691.391602587759, 8700.78248043804, 8712.91287087121, 5783.971080144573, 6012.308584512837, 6246.500279977682, 6351.428371446592, 6416.935830641633, 6953.304669533006, 7166.426685865223, 7303.379212766974, 7329.863871099988, 7361.705531778669, 6433.356664333529, 6454.419102280817, 6491.318411566906, 6639.302873198438, 6668.866622667422, 6377.266614339224, 6432.163818703726, 6435.388638079375, 6466.935330646634, 6516.543841931019, 5904.261967254093, 5998.990338236739, 6006.129111278753, 6009.158717779427, 6050.334463208956, 4281.828726850891, 4319.740815551077, 4397.230484665235, 4408.515063342966, 4418.0059486615255, 4370.213361594943, 4401.075774087478, 4445.5109937907455, 4447.0, 4453.844115455943], "value": 4008.861940383544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.6388350678145, 288.90321742216355, 297.37254393230285, 300.06679227602154, 303.362937830556, 4772.069446457942, 4877.878053048676, 4955.207166853304, 4996.550310472061, 4999.275105109761, 4712.835050773224, 4820.8553743387665, 4862.586680132193, 4873.634477414191, 4876.268924531784, 3847.4228865670093, 3852.248811481762, 3852.5569559500736, 3857.3635350167187, 3859.787711675857, 3615.0781550704532, 3859.1316953685478, 3866.941995870064, 3868.5492940147446, 3870.283997460479, 3777.3956167013284, 3791.393377059671, 3792.848286068554, 3794.981025094871, 3804.5814960354337, 3778.9985653801764, 3787.6401741834484, 3793.4878791363367, 3794.5636251831115, 3801.8669346573015, 3205.599300087489, 3328.5007248912857, 3330.200751819546, 3338.2989572189867, 3354.748393870445, 4771.880702982418, 4772.856814295576, 4781.928271075936, 4787.281907713836, 4791.0, 4340.392345071693, 4340.656045735299, 4348.608625223745, 4349.26062569364, 4359.542248063971, 4881.925976285212, 5106.923396149061, 5111.6932984020705, 5114.772454610904, 5116.846494605168, 3623.5832879218965, 3623.981880090609, 3632.2020599803004, 3635.745497815154, 3640.981795091034, 5263.421023687391, 5285.9207111892965, 5290.894182116374, 5294.54996325309, 5322.414534401213, 3553.928921421557, 3555.1645363339594, 3560.786352818839, 3567.6789088981595, 3576.1046645278043, 3506.7194624429985, 3576.3920133576835, 3726.142987112925, 3786.981065094712, 3795.4686343911876, 4319.352097185384, 4320.783960801948, 4321.762303073298, 4326.524082350938, 4337.4795024596615, 5136.614753893473, 5145.897082058413, 5146.228065790161, 5170.793168273302, 5189.652674025233, 1218.8476440444945, 1254.6110705681267, 1255.8869701726705, 1282.742911946298, 1295.8898493628146, 855.724969795001, 872.7730789994647, 886.609891647673, 889.2441424788877, 890.1676932068536, 4428.269335559597, 4440.667799660089, 4442.933355999663, 4450.332450132506, 4459.420275364182, 5148.562372198405, 5155.9742201288755, 5156.819511317086, 5174.353205849269, 5180.274761533388, 4411.205982923105, 4428.7121337112985, 4438.467383913951, 4443.866683999485, 4462.397576327219, 2317.6986991690974, 2425.8787060646896, 2434.5009273099326, 2440.7071151461582, 2451.33813870254, 4297.78511074445, 4306.720063195882, 4311.396404503372, 4329.393884856123, 4338.544452832471, 4688.507062238586, 4697.906041879211, 4711.95288047122, 4718.882027949328, 4721.905561888743, 4325.545817689161, 4613.40025796651, 4953.777080031407, 4974.925376119289, 4995.800167993385, 5322.920156197582, 5325.458570051028, 5327.147656375117, 5329.1206950852675, 5329.893402131858, 5192.27308176848, 5228.536009917229, 5236.9738151309, 5243.921341179809, 5257.132573125392, 4706.341112244357, 4955.1576232039915, 4991.376077990251, 4997.400311962442, 5009.173486374707, 3676.0, 3711.740178187501, 3728.496652951817, 3739.08392443853, 3741.5136032315627, 5027.296178534935, 5274.657147285414, 5309.283246761638, 5309.495597918191, 5322.840314790563, 4740.691855029412, 5122.692638441706, 5148.403994761636, 5159.948400515947, 5183.922241166461, 5151.587872970228, 5157.432682404858, 5159.922601161061, 5189.5609063739985, 5194.74026298676, 4880.585150262267, 5033.169527028146, 5037.319961805256, 5059.822906198266, 5135.948640513547, 5164.804957892956, 5169.612279079009, 5173.689578625294, 5194.3247377840635, 5195.59688404096, 5046.924296135488, 5055.115354812967, 5065.848024559269, 5066.9239961401345, 5078.568321692697], "value": 3795.683725406456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9967950160249, 655.6361219523163, 674.352621483376, 746.9066366704162, 759.9886001709975, 13022.609321720352, 13436.3953622087, 13513.121647092932, 13521.661958451032, 13565.118267312619, 13199.736005279889, 13381.464741410357, 13411.664708382295, 13433.529826456075, 13449.125806822574, 616.602291521968, 639.0350570638346, 737.0, 748.3265061444689, 759.5139110968985, 774.7056118674896, 774.802425381527, 774.8062984253936, 775.2402645407504, 778.1557010643459, 832.5296207642663, 834.1033389106705, 837.6523742646795, 837.660747397305, 839.0099682374795, 828.2462958707578, 828.7928017995501, 829.4276948905236, 830.1739768929954, 831.4429332347281, 610.8350745298744, 611.7675283392327, 611.9541034422436, 612.2530512774408, 612.9172561704157, 13397.86602133976, 13442.663933401645, 13449.865501344959, 13457.932710336483, 13466.192028478225, 13656.385462654205, 13914.791278130837, 13942.16347019172, 14291.714165716732, 14395.78406323906, 11037.613683521038, 11073.446327683583, 11102.167337449724, 11114.888851111547, 11149.275297105662, 3347.5313456116164, 3386.9491957620658, 3403.081168084603, 3410.4543273076188, 3508.456189290664, 51172.488275117146, 52622.73688631571, 52662.21006684903, 66202.0, 67516.6624166876, 10489.475526223658, 10591.311564748266, 10701.25091243621, 10763.300385475075, 10813.08088812444, 18295.451136465927, 18576.44270671882, 18615.0, 18620.627587448445, 18929.621407571773, 6370.617762934239, 6786.4910131739325, 6960.756373526902, 7053.647317634201, 7055.541389809646, 3586.5158203642695, 3669.2844895245703, 3710.8515659373325, 3733.253349330145, 3768.3970564709516, 3097.411491816548, 3216.8552415141376, 3221.5650887130405, 3228.951565726516, 3239.5626590409993, 514.5446280042189, 533.1443033930564, 538.3943064052941, 539.1723704114166, 552.5331095224528, 421.54052083229425, 460.26587592789446, 510.9310243117206, 514.5086442447454, 531.2031952071892, 7480.139783924918, 7637.312641862259, 7699.076110866732, 8043.39674524413, 8106.272770080996, 492.87431704915736, 498.4765995704568, 503.88662550926483, 511.9070783876451, 519.3482179864321, 3714.517112775322, 3863.517060367454, 3950.664193543581, 4031.5363733170475, 4032.536258330271, 87558.7464752117, 99651.50174249083, 100948.49525752472, 104138.0, 104659.476702616, 82597.0, 88293.11706882977, 88625.55687221652, 88693.55653221693, 88831.0, 78062.0, 78477.21522784814, 78837.0, 79408.20591794123, 79814.0, 7035.753748618774, 7269.963650181715, 7329.230430804689, 7380.0, 7647.273509016634, 43071.56928430676, 43664.781676091414, 44188.0, 45279.0, 45640.771796140805, 63130.0, 66932.33067669261, 67719.3228067713, 67931.66034169798, 69729.30270697227, 9320.673776417792, 9602.807943841224, 9643.180329671775, 9676.806463870542, 9716.75708107303, 10370.844437333597, 10576.4711764413, 10715.678529644123, 10853.240273180802, 11367.943160284145, 9407.4825884577, 9412.0, 9634.373765705206, 9662.0, 10229.795404091728, 9229.815403692022, 9368.250539956924, 9453.810923781624, 9554.904450955402, 9661.516924153904, 8580.485170889766, 8702.869456958277, 8891.4665120093, 9106.499142547224, 9453.669121580711, 8298.875516867372, 8431.367647426345, 8435.15648435176, 8561.785955351166, 8725.083866193958, 7642.235776422313, 7717.845643087219, 8024.959875200587, 8068.435209535276, 8071.273585377344], "value": 6318.321224414204, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 117.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 130.0, 176.0, 126.0, 127.0, 126.0, 127.0, 160.0, 127.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 163.0, 165.0, 167.0, 167.0, 162.0, 167.0, 162.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 118.0, 79.0, 79.0, 76.0, 77.0, 113.0, 77.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 123.0, 84.0, 85.0, 84.0, 100.0, 84.0, 84.0, 113.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 118.0, 118.0, 119.0, 120.0, 120.0, 119.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 150.0, 149.0, 151.0, 150.0, 149.0, 147.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 64.0, 64.0, 66.0, 66.0, 65.0, 67.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 86.0, 83.0, 92.0, 83.0, 93.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 145.0, 147.0, 146.0, 137.0, 143.0, 136.0, 168.0, 150.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 177.0, 180.0, 175.0, 178.0, 178.0, 182.0, 177.0, 179.0, 180.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 75.0, 68.0, 73.0, 77.0, 70.0, 69.0, 71.0], "value": 71.8, "unit": "score"}]}]} 05:40:40 INFO - Return code: 0 05:40:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:40:40 ERROR - # TBPL SUCCESS # 05:40:40 INFO - Running post-action listener: _resource_record_post_action 05:40:40 INFO - [mozharness: 2016-09-26 12:40:40.166579Z] Finished run-tests step (success) 05:40:40 INFO - Running post-run listener: _resource_record_post_run 05:40:40 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406687744; Read time: 8; Write time: 281584 05:40:40 INFO - TinderboxPrint: CPU usage
13.4% 05:40:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:40:40 INFO - TinderboxPrint: I/O write bytes / time
406,687,744 / 281,584 05:40:40 INFO - TinderboxPrint: CPU idle
8,288.7 (86.6%) 05:40:40 INFO - TinderboxPrint: CPU user
1,218.8 (12.7%) 05:40:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115916800; Read time: 0; Write time: 59684 05:40:40 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289652736; Read time: 0; Write time: 221880 05:40:40 INFO - Running post-run listener: _upload_blobber_files 05:40:40 INFO - Blob upload gear active. 05:40:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:40:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:42 INFO - (blobuploader) - INFO - Done attempting. 05:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:42 INFO - (blobuploader) - INFO - Done attempting. 05:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:46 INFO - (blobuploader) - INFO - Done attempting. 05:40:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:46 INFO - Return code: 0 05:40:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afea81391663600a932d33de9b73b5be043da99633d60bace22692a1a412a23a4be8735f6885f6a76d862f5bc46ef15e418489b01e269fe5eaf8e7e3c2de5ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9a72ff481b7768b951a4bd2616f66f4c0545c97526c665df99a3fa2b5c83383a7cd816b2d279cf40e43ad981fdb2b20e2e91a01f9bb75ae4658699bab903be2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/948496055abde81043a72d987a65d103c575a5d7b5c377a37dc814b7f117b1f1a71673572e70683ad8dd5200148c75d182423f852b71e63ad54c189cdc043766"} 05:40:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:46 INFO - Contents: 05:40:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afea81391663600a932d33de9b73b5be043da99633d60bace22692a1a412a23a4be8735f6885f6a76d862f5bc46ef15e418489b01e269fe5eaf8e7e3c2de5ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9a72ff481b7768b951a4bd2616f66f4c0545c97526c665df99a3fa2b5c83383a7cd816b2d279cf40e43ad981fdb2b20e2e91a01f9bb75ae4658699bab903be2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/948496055abde81043a72d987a65d103c575a5d7b5c377a37dc814b7f117b1f1a71673572e70683ad8dd5200148c75d182423f852b71e63ad54c189cdc043766"} 05:40:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:46 INFO - Copying logs to upload dir... 05:40:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.680517 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-09-26 05:40:44.794863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:44.798606) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 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/Firefox-Non-PGO/sha512/afea81391663600a932d33de9b73b5be043da99633d60bace22692a1a412a23a4be8735f6885f6a76d862f5bc46ef15e418489b01e269fe5eaf8e7e3c2de5ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9a72ff481b7768b951a4bd2616f66f4c0545c97526c665df99a3fa2b5c83383a7cd816b2d279cf40e43ad981fdb2b20e2e91a01f9bb75ae4658699bab903be2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/948496055abde81043a72d987a65d103c575a5d7b5c377a37dc814b7f117b1f1a71673572e70683ad8dd5200148c75d182423f852b71e63ad54c189cdc043766"} build_url:https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/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/Firefox-Non-PGO/sha512/afea81391663600a932d33de9b73b5be043da99633d60bace22692a1a412a23a4be8735f6885f6a76d862f5bc46ef15e418489b01e269fe5eaf8e7e3c2de5ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9a72ff481b7768b951a4bd2616f66f4c0545c97526c665df99a3fa2b5c83383a7cd816b2d279cf40e43ad981fdb2b20e2e91a01f9bb75ae4658699bab903be2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/948496055abde81043a72d987a65d103c575a5d7b5c377a37dc814b7f117b1f1a71673572e70683ad8dd5200148c75d182423f852b71e63ad54c189cdc043766"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:44.825372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:44.825935) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1474889747.719108-1023126934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:44.908347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:40:44.908712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:40:44.909046) ========= ========= Total master_lag: 0.16 =========