builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1483335301.2 results: success (0) buildid: 20170101194819 builduid: 88c2aa907f6f42e8b48e065479ab9bb3 revision: addb771c9a728f749feea0328c7ffd4a56888c26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.199562) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.200072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.200375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.215406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.215718) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-01 21:35:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.4M=0s 2017-01-01 21:35:02 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.384103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.614462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.614749) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016401 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.669133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:01.669487) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev addb771c9a728f749feea0328c7ffd4a56888c26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev addb771c9a728f749feea0328c7ffd4a56888c26 --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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-01 21:35:02,861 truncating revision to first 12 chars 2017-01-01 21:35:02,861 Setting DEBUG logging. 2017-01-01 21:35:02,861 attempt 1/10 2017-01-01 21:35:02,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/addb771c9a72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-01 21:35:03,214 unpacking tar archive at: mozilla-beta-addb771c9a72/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:02.363451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:02.363857) ========= script_repo_revision: addb771c9a728f749feea0328c7ffd4a56888c26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:02.364258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:02.364541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 21:35:02.377363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-01 21:35:02.377736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:35:03 INFO - MultiFileLogger online at 20170101 21:35:03 in /builds/slave/test 21:35:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:35:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:35:03 INFO - {'append_to_log': False, 21:35:03 INFO - 'base_work_dir': '/builds/slave/test', 21:35:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:35:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:35:03 INFO - 'branch': 'Mozilla-Beta', 21:35:03 INFO - 'buildbot_json_path': 'buildprops.json', 21:35:03 INFO - 'config_files': ('talos/linux_config.py',), 21:35:03 INFO - 'default_actions': ('clobber', 21:35:03 INFO - 'read-buildbot-config', 21:35:03 INFO - 'download-and-extract', 21:35:03 INFO - 'populate-webroot', 21:35:03 INFO - 'create-virtualenv', 21:35:03 INFO - 'install', 21:35:03 INFO - 'run-tests'), 21:35:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:35:03 INFO - 'download_minidump_stackwalk': True, 21:35:03 INFO - 'download_symbols': 'ondemand', 21:35:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:35:03 INFO - 'tooltool.py': '/tools/tooltool.py', 21:35:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:35:03 INFO - '/tools/misc-python/virtualenv.py')}, 21:35:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:35:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:35:03 INFO - 'installer_path': 'installer.exe', 21:35:03 INFO - 'log_level': 'info', 21:35:03 INFO - 'log_name': 'talos', 21:35:03 INFO - 'log_to_console': True, 21:35:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:35:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:35:03 INFO - 'opt_config_files': (), 21:35:03 INFO - 'pip_index': False, 21:35:03 INFO - 'sps_profile': False, 21:35:03 INFO - 'sps_profile_interval': 0, 21:35:03 INFO - 'suite': 'dromaeojs', 21:35:03 INFO - 'system_bits': '32', 21:35:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:35:03 INFO - 'title': 'talos-linux64-ix-039', 21:35:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:35:03 INFO - 'use_talos_json': True, 21:35:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:35:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:35:03 INFO - 'work_dir': 'build'} 21:35:03 INFO - [mozharness: 2017-01-02 05:35:03.666164Z] Running clobber step. 21:35:03 INFO - Running pre-action listener: _resource_record_pre_action 21:35:03 INFO - Running main action method: clobber 21:35:03 INFO - rmtree: /builds/slave/test/build 21:35:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:35:04 INFO - Running post-action listener: _resource_record_post_action 21:35:04 INFO - [mozharness: 2017-01-02 05:35:04.123351Z] Finished clobber step (success) 21:35:04 INFO - [mozharness: 2017-01-02 05:35:04.123451Z] Running read-buildbot-config step. 21:35:04 INFO - Running pre-action listener: _resource_record_pre_action 21:35:04 INFO - Running main action method: read_buildbot_config 21:35:04 INFO - Using buildbot properties: 21:35:04 INFO - { 21:35:04 INFO - "project": "", 21:35:04 INFO - "product": "firefox", 21:35:04 INFO - "script_repo_revision": "production", 21:35:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 21:35:04 INFO - "repository": "", 21:35:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 21:35:04 INFO - "buildid": "20170101194819", 21:35:04 INFO - "pgo_build": "True", 21:35:04 INFO - "basedir": "/builds/slave/test", 21:35:04 INFO - "buildnumber": 39, 21:35:04 INFO - "slavename": "talos-linux64-ix-039", 21:35:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:35:04 INFO - "platform": "ubuntu64_hw", 21:35:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:35:04 INFO - "branch": "mozilla-beta", 21:35:04 INFO - "repo_path": "releases/mozilla-beta", 21:35:04 INFO - "revision": "addb771c9a728f749feea0328c7ffd4a56888c26", 21:35:04 INFO - "stage_platform": "linux64-pgo", 21:35:04 INFO - "builduid": "88c2aa907f6f42e8b48e065479ab9bb3", 21:35:04 INFO - "slavebuilddir": "test" 21:35:04 INFO - } 21:35:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 21:35:04 INFO - Running post-action listener: _resource_record_post_action 21:35:04 INFO - [mozharness: 2017-01-02 05:35:04.125908Z] Finished read-buildbot-config step (success) 21:35:04 INFO - [mozharness: 2017-01-02 05:35:04.125998Z] Running download-and-extract step. 21:35:04 INFO - Running pre-action listener: _resource_record_pre_action 21:35:04 INFO - Running main action method: download_and_extract 21:35:04 INFO - mkdir: /builds/slave/test/build/tests 21:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:04 INFO - trying https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:35:04 INFO - Downloading https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:35:04 INFO - Downloaded 1327 bytes. 21:35:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:35:04 INFO - Using the following test package requirements: 21:35:04 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:35:04 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:35:04 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 21:35:04 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'jsshell-linux-x86_64.zip'], 21:35:04 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:35:04 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:35:04 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 21:35:04 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 21:35:04 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:35:04 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:35:04 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:35:04 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:35:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:35:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:35:04 INFO - Fetch https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:35:05 INFO - Expected file size: 21964230 21:35:09 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:35:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:35:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:35:09 INFO - Fetch https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:35:10 INFO - Expected file size: 21964230 21:35:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 21:35:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:35:14 INFO - Fetch https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 21:35:15 INFO - Expected file size: 14414089 21:35: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')]} 21:35:15 INFO - trying https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:35:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:35:16 INFO - Downloaded 56953876 bytes. 21:35:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:35:16 INFO - mkdir: /builds/slave/test/properties 21:35:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:16 INFO - Contents: 21:35:16 INFO - build_url:https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:35:17 INFO - Running post-action listener: _resource_record_post_action 21:35:17 INFO - Running post-action listener: set_extra_try_arguments 21:35:17 INFO - [mozharness: 2017-01-02 05:35:17.617593Z] Finished download-and-extract step (success) 21:35:17 INFO - [mozharness: 2017-01-02 05:35:17.617822Z] Running populate-webroot step. 21:35:17 INFO - Running pre-action listener: _resource_record_pre_action 21:35:17 INFO - Running main action method: populate_webroot 21:35:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:35:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:35:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:35:17 INFO - '--tppagecycles', 21:35:17 INFO - '7'], 21:35:17 INFO - 'tests': ['tsvgm']}}, 21:35:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:35:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:35:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['damp', 'tps']}, 21:35:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'tests': ['damp', 'tps']}, 21:35:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['dromaeo_dom']}, 21:35:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['basic_compositor_video']}, 21:35:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:35:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['a11yr', 21:35:17 INFO - 'ts_paint', 21:35:17 INFO - 'tpaint', 21:35:17 INFO - 'sessionrestore', 21:35:17 INFO - 'sessionrestore_no_auto_restore', 21:35:17 INFO - 'tabpaint']}, 21:35:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['tsvgx', 21:35:17 INFO - 'tsvgr_opacity', 21:35:17 INFO - 'tart', 21:35:17 INFO - 'tscrollx', 21:35:17 INFO - 'cart']}, 21:35:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:17 INFO - 'tsvgr_opacity', 21:35:17 INFO - 'tart', 21:35:17 INFO - 'tscrollx', 21:35:17 INFO - 'cart']}, 21:35:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'talos_options': ['--disable-e10s'], 21:35:17 INFO - 'tests': ['tp5o']}, 21:35:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'tests': ['tp5o']}, 21:35:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'talos_options': ['--disable-e10s', 21:35:17 INFO - '--xperf_path', 21:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:17 INFO - 'tests': ['tp5n']}, 21:35:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:17 INFO - 'talos_options': ['--xperf_path', 21:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:17 INFO - 'tests': ['tp5n']}}, 21:35:17 INFO - 'talos.zip': {'path': '', 21:35:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:35:17 INFO - Running post-action listener: _resource_record_post_action 21:35:17 INFO - [mozharness: 2017-01-02 05:35:17.633083Z] Finished populate-webroot step (success) 21:35:17 INFO - [mozharness: 2017-01-02 05:35:17.633177Z] Running create-virtualenv step. 21:35:17 INFO - Running pre-action listener: _resource_record_pre_action 21:35:17 INFO - Running main action method: create_virtualenv 21:35:17 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35: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 21:35:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:35:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:17 INFO - Using real prefix '/usr' 21:35:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:18 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:20 INFO - Installing pip.................done. 21:35:20 INFO - Return code: 0 21:35:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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', 'pip>=1.5'] in /builds/slave/test/build 21:35: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 pip>=1.5 21:35:20 INFO - Using env: {'DISPLAY': ':0', 21:35:20 INFO - 'HOME': '/home/cltbld', 21:35:20 INFO - 'LANG': 'en_US.UTF-8', 21:35:20 INFO - 'LANGUAGE': 'en_US:en', 21:35:20 INFO - 'LOGNAME': 'cltbld', 21:35:20 INFO - 'MAIL': '/var/mail/cltbld', 21:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:20 INFO - 'MOZ_NO_REMOTE': '1', 21:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:20 INFO - 'NO_EM_RESTART': '1', 21:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:20 INFO - 'PWD': '/builds/slave/test', 21:35:20 INFO - 'SHELL': '/bin/bash', 21:35:20 INFO - 'SHLVL': '1', 21:35:20 INFO - 'TERM': 'linux', 21:35:20 INFO - 'TMOUT': '86400', 21:35:20 INFO - 'USER': 'cltbld', 21:35:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:20 INFO - '_': '/tools/buildbot/bin/python'} 21:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35: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 21:35:20 INFO - Cleaning up... 21:35:20 INFO - Return code: 0 21:35:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:20 INFO - Using env: {'DISPLAY': ':0', 21:35:20 INFO - 'HOME': '/home/cltbld', 21:35:20 INFO - 'LANG': 'en_US.UTF-8', 21:35:20 INFO - 'LANGUAGE': 'en_US:en', 21:35:20 INFO - 'LOGNAME': 'cltbld', 21:35:20 INFO - 'MAIL': '/var/mail/cltbld', 21:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:20 INFO - 'MOZ_NO_REMOTE': '1', 21:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:20 INFO - 'NO_EM_RESTART': '1', 21:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:20 INFO - 'PWD': '/builds/slave/test', 21:35:20 INFO - 'SHELL': '/bin/bash', 21:35:20 INFO - 'SHLVL': '1', 21:35:20 INFO - 'TERM': 'linux', 21:35:20 INFO - 'TMOUT': '86400', 21:35:20 INFO - 'USER': 'cltbld', 21:35:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:20 INFO - '_': '/tools/buildbot/bin/python'} 21:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:20 INFO - Downloading/unpacking psutil>=3.1.1 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:22 INFO - Installing collected packages: psutil 21:35:22 INFO - Running setup.py install for psutil 21:35:22 INFO - building 'psutil._psutil_linux' extension 21:35: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 21:35: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 21:35:22 INFO - building 'psutil._psutil_posix' extension 21:35: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 21:35:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:35:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:23 INFO - Successfully installed psutil 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:23 INFO - Using env: {'DISPLAY': ':0', 21:35:23 INFO - 'HOME': '/home/cltbld', 21:35:23 INFO - 'LANG': 'en_US.UTF-8', 21:35:23 INFO - 'LANGUAGE': 'en_US:en', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MAIL': '/var/mail/cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SHLVL': '1', 21:35:23 INFO - 'TERM': 'linux', 21:35:23 INFO - 'TMOUT': '86400', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - '_': '/tools/buildbot/bin/python'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:25 INFO - Installing collected packages: mozsystemmonitor 21:35:25 INFO - Running setup.py install for mozsystemmonitor 21:35:25 INFO - Successfully installed mozsystemmonitor 21:35:25 INFO - Cleaning up... 21:35:25 INFO - Return code: 0 21:35:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:25 INFO - Using env: {'DISPLAY': ':0', 21:35:25 INFO - 'HOME': '/home/cltbld', 21:35:25 INFO - 'LANG': 'en_US.UTF-8', 21:35:25 INFO - 'LANGUAGE': 'en_US:en', 21:35:25 INFO - 'LOGNAME': 'cltbld', 21:35:25 INFO - 'MAIL': '/var/mail/cltbld', 21:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:25 INFO - 'MOZ_NO_REMOTE': '1', 21:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:25 INFO - 'NO_EM_RESTART': '1', 21:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:25 INFO - 'PWD': '/builds/slave/test', 21:35:25 INFO - 'SHELL': '/bin/bash', 21:35:25 INFO - 'SHLVL': '1', 21:35:25 INFO - 'TERM': 'linux', 21:35:25 INFO - 'TMOUT': '86400', 21:35:25 INFO - 'USER': 'cltbld', 21:35:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:25 INFO - '_': '/tools/buildbot/bin/python'} 21:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:28 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:28 INFO - warning: no files found matching '*.txt' 21:35:28 INFO - no previously-included directories found matching 'build' 21:35:28 INFO - no previously-included directories found matching 'dist' 21:35:28 INFO - no previously-included directories found matching '.git*' 21:35:28 INFO - Installing collected packages: jsonschema, functools32 21:35:28 INFO - Running setup.py install for functools32 21:35:28 INFO - warning: no files found matching '*.txt' 21:35:28 INFO - no previously-included directories found matching 'build' 21:35:28 INFO - no previously-included directories found matching 'dist' 21:35:28 INFO - no previously-included directories found matching '.git*' 21:35:28 INFO - Successfully installed jsonschema functools32 21:35:28 INFO - Cleaning up... 21:35:28 INFO - Return code: 0 21:35:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:28 INFO - Using env: {'DISPLAY': ':0', 21:35:28 INFO - 'HOME': '/home/cltbld', 21:35:28 INFO - 'LANG': 'en_US.UTF-8', 21:35:28 INFO - 'LANGUAGE': 'en_US:en', 21:35:28 INFO - 'LOGNAME': 'cltbld', 21:35:28 INFO - 'MAIL': '/var/mail/cltbld', 21:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:28 INFO - 'MOZ_NO_REMOTE': '1', 21:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:28 INFO - 'NO_EM_RESTART': '1', 21:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:28 INFO - 'PWD': '/builds/slave/test', 21:35:28 INFO - 'SHELL': '/bin/bash', 21:35:28 INFO - 'SHLVL': '1', 21:35:28 INFO - 'TERM': 'linux', 21:35:28 INFO - 'TMOUT': '86400', 21:35:28 INFO - 'USER': 'cltbld', 21:35:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:28 INFO - '_': '/tools/buildbot/bin/python'} 21:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:28 INFO - Cleaning up... 21:35:28 INFO - Return code: 0 21:35:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:28 INFO - Using env: {'DISPLAY': ':0', 21:35:28 INFO - 'HOME': '/home/cltbld', 21:35:28 INFO - 'LANG': 'en_US.UTF-8', 21:35:28 INFO - 'LANGUAGE': 'en_US:en', 21:35:28 INFO - 'LOGNAME': 'cltbld', 21:35:28 INFO - 'MAIL': '/var/mail/cltbld', 21:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:28 INFO - 'MOZ_NO_REMOTE': '1', 21:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:28 INFO - 'NO_EM_RESTART': '1', 21:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:28 INFO - 'PWD': '/builds/slave/test', 21:35:28 INFO - 'SHELL': '/bin/bash', 21:35:28 INFO - 'SHLVL': '1', 21:35:28 INFO - 'TERM': 'linux', 21:35:28 INFO - 'TMOUT': '86400', 21:35:28 INFO - 'USER': 'cltbld', 21:35:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:28 INFO - '_': '/tools/buildbot/bin/python'} 21:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:28 INFO - Downloading/unpacking blobuploader==1.2.4 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:30 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:31 INFO - Downloading docopt-0.6.1.tar.gz 21:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:31 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:31 INFO - Running setup.py install for blobuploader 21:35:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:31 INFO - Running setup.py install for requests 21:35:32 INFO - Running setup.py install for docopt 21:35:32 INFO - Successfully installed blobuploader requests docopt 21:35:32 INFO - Cleaning up... 21:35:32 INFO - Return code: 0 21:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:32 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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:32 INFO - Using env: {'DISPLAY': ':0', 21:35:32 INFO - 'HOME': '/home/cltbld', 21:35:32 INFO - 'LANG': 'en_US.UTF-8', 21:35:32 INFO - 'LANGUAGE': 'en_US:en', 21:35:32 INFO - 'LOGNAME': 'cltbld', 21:35:32 INFO - 'MAIL': '/var/mail/cltbld', 21:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:32 INFO - 'MOZ_NO_REMOTE': '1', 21:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:32 INFO - 'NO_EM_RESTART': '1', 21:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:32 INFO - 'PWD': '/builds/slave/test', 21:35:32 INFO - 'SHELL': '/bin/bash', 21:35:32 INFO - 'SHLVL': '1', 21:35:32 INFO - 'TERM': 'linux', 21:35:32 INFO - 'TMOUT': '86400', 21:35:32 INFO - 'USER': 'cltbld', 21:35:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:32 INFO - '_': '/tools/buildbot/bin/python'} 21:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:32 INFO - Running setup.py (path:/tmp/pip-RFwpGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:32 INFO - Running setup.py (path:/tmp/pip-lD3O4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:32 INFO - Running setup.py (path:/tmp/pip-YMkekN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:32 INFO - Running setup.py (path:/tmp/pip-6ArfCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:32 INFO - Running setup.py (path:/tmp/pip-VfPDpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:32 INFO - Running setup.py (path:/tmp/pip-VKLZia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:32 INFO - Running setup.py (path:/tmp/pip-5WH6cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:32 INFO - Running setup.py (path:/tmp/pip-TD9vDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:32 INFO - Running setup.py (path:/tmp/pip-FzP81o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:33 INFO - Running setup.py (path:/tmp/pip-gYdud5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:33 INFO - Running setup.py (path:/tmp/pip-3Ig_52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:33 INFO - Running setup.py (path:/tmp/pip-pFF23G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:33 INFO - Running setup.py (path:/tmp/pip-3enLx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:33 INFO - Running setup.py (path:/tmp/pip-fW7FZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:33 INFO - Running setup.py (path:/tmp/pip-Ep4kHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:33 INFO - Running setup.py (path:/tmp/pip-5UtRms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:33 INFO - Running setup.py (path:/tmp/pip-tKu9YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:33 INFO - Running setup.py install for manifestparser 21:35:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:33 INFO - Running setup.py install for mozcrash 21:35:33 INFO - Running setup.py install for mozdebug 21:35:33 INFO - Running setup.py install for mozdevice 21:35:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozfile 21:35:34 INFO - Running setup.py install for mozhttpd 21:35:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozinfo 21:35:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozInstall 21:35:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozleak 21:35:34 INFO - Running setup.py install for mozlog 21:35:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for moznetwork 21:35:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozprocess 21:35:34 INFO - Running setup.py install for mozprofile 21:35:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozrunner 21:35:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for mozscreenshot 21:35:35 INFO - Running setup.py install for moztest 21:35:35 INFO - Running setup.py install for mozversion 21:35:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:35 INFO - Cleaning up... 21:35:35 INFO - Return code: 0 21:35:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:35 INFO - Using env: {'DISPLAY': ':0', 21:35:35 INFO - 'HOME': '/home/cltbld', 21:35:35 INFO - 'LANG': 'en_US.UTF-8', 21:35:35 INFO - 'LANGUAGE': 'en_US:en', 21:35:35 INFO - 'LOGNAME': 'cltbld', 21:35:35 INFO - 'MAIL': '/var/mail/cltbld', 21:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:35 INFO - 'MOZ_NO_REMOTE': '1', 21:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:35 INFO - 'NO_EM_RESTART': '1', 21:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:35 INFO - 'PWD': '/builds/slave/test', 21:35:35 INFO - 'SHELL': '/bin/bash', 21:35:35 INFO - 'SHLVL': '1', 21:35:35 INFO - 'TERM': 'linux', 21:35:35 INFO - 'TMOUT': '86400', 21:35:35 INFO - 'USER': 'cltbld', 21:35:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:35 INFO - '_': '/tools/buildbot/bin/python'} 21:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:35 INFO - Running setup.py (path:/tmp/pip-cP9k9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35: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)) 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:35 INFO - Running setup.py (path:/tmp/pip-dTQ3Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35: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)) 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:35 INFO - Running setup.py (path:/tmp/pip-WBixw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35: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)) 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:35 INFO - Running setup.py (path:/tmp/pip-8GAUyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35: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)) 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:35 INFO - Running setup.py (path:/tmp/pip-JonKG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35: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)) 21:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:35 INFO - Running setup.py (path:/tmp/pip-o8A57x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:36 INFO - Running setup.py (path:/tmp/pip-r9_UkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:36 INFO - Running setup.py (path:/tmp/pip-Om6Rx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:36 INFO - Running setup.py (path:/tmp/pip-UUoXuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:36 INFO - Running setup.py (path:/tmp/pip-n3ZHlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:36 INFO - Running setup.py (path:/tmp/pip-4ULY3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:36 INFO - Running setup.py (path:/tmp/pip-GLlDA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:36 INFO - Running setup.py (path:/tmp/pip-oFEnXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:36 INFO - Running setup.py (path:/tmp/pip-3uKd8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:36 INFO - Running setup.py (path:/tmp/pip-uRoTVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:36 INFO - Running setup.py (path:/tmp/pip-Qcz40e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35: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)) 21:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:36 INFO - Running setup.py (path:/tmp/pip-30qaMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:38 INFO - Downloading blessings-1.6.tar.gz 21:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:38 INFO - Installing collected packages: blessings 21:35:38 INFO - Running setup.py install for blessings 21:35:38 INFO - Successfully installed blessings 21:35:38 INFO - Cleaning up... 21:35:39 INFO - Return code: 0 21:35:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:39 INFO - Reading from file tmpfile_stdout 21:35:39 INFO - Current package versions: 21:35:39 INFO - argparse == 1.2.1 21:35:39 INFO - blessings == 1.6 21:35:39 INFO - blobuploader == 1.2.4 21:35:39 INFO - docopt == 0.6.1 21:35:39 INFO - functools32 == 3.2.3-2 21:35:39 INFO - jsonschema == 2.5.1 21:35:39 INFO - manifestparser == 1.1 21:35:39 INFO - mozInstall == 1.12 21:35:39 INFO - mozcrash == 0.17 21:35:39 INFO - mozdebug == 0.1 21:35:39 INFO - mozdevice == 0.48 21:35:39 INFO - mozfile == 1.2 21:35:39 INFO - mozhttpd == 0.7 21:35:39 INFO - mozinfo == 0.9 21:35:39 INFO - mozleak == 0.1 21:35:39 INFO - mozlog == 3.4 21:35:39 INFO - moznetwork == 0.27 21:35:39 INFO - mozprocess == 0.23 21:35:39 INFO - mozprofile == 0.28 21:35:39 INFO - mozrunner == 6.12 21:35:39 INFO - mozscreenshot == 0.1 21:35:39 INFO - mozsystemmonitor == 0.3 21:35:39 INFO - moztest == 0.7 21:35:39 INFO - mozversion == 1.4 21:35:39 INFO - psutil == 3.1.1 21:35:39 INFO - requests == 1.2.3 21:35:39 INFO - wsgiref == 0.1.2 21:35:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:39 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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:39 INFO - Using env: {'DISPLAY': ':0', 21:35:39 INFO - 'HOME': '/home/cltbld', 21:35:39 INFO - 'LANG': 'en_US.UTF-8', 21:35:39 INFO - 'LANGUAGE': 'en_US:en', 21:35:39 INFO - 'LOGNAME': 'cltbld', 21:35:39 INFO - 'MAIL': '/var/mail/cltbld', 21:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:39 INFO - 'MOZ_NO_REMOTE': '1', 21:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:39 INFO - 'NO_EM_RESTART': '1', 21:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:39 INFO - 'PWD': '/builds/slave/test', 21:35:39 INFO - 'SHELL': '/bin/bash', 21:35:39 INFO - 'SHLVL': '1', 21:35:39 INFO - 'TERM': 'linux', 21:35:39 INFO - 'TMOUT': '86400', 21:35:39 INFO - 'USER': 'cltbld', 21:35:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:39 INFO - '_': '/tools/buildbot/bin/python'} 21:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35: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)) 21:35:39 INFO - Cleaning up... 21:35:39 INFO - Return code: 0 21:35:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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 0x7f0ebaadbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35: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 21:35: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 21:35:39 INFO - Using env: {'DISPLAY': ':0', 21:35:39 INFO - 'HOME': '/home/cltbld', 21:35:39 INFO - 'LANG': 'en_US.UTF-8', 21:35:39 INFO - 'LANGUAGE': 'en_US:en', 21:35:39 INFO - 'LOGNAME': 'cltbld', 21:35:39 INFO - 'MAIL': '/var/mail/cltbld', 21:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:39 INFO - 'MOZ_NO_REMOTE': '1', 21:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:39 INFO - 'NO_EM_RESTART': '1', 21:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:39 INFO - 'PWD': '/builds/slave/test', 21:35:39 INFO - 'SHELL': '/bin/bash', 21:35:39 INFO - 'SHLVL': '1', 21:35:39 INFO - 'TERM': 'linux', 21:35:39 INFO - 'TMOUT': '86400', 21:35:39 INFO - 'USER': 'cltbld', 21:35:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:39 INFO - '_': '/tools/buildbot/bin/python'} 21:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:39 INFO - Cleaning up... 21:35:39 INFO - Return code: 0 21:35:39 INFO - Running post-action listener: _resource_record_post_action 21:35:39 INFO - Running post-action listener: _start_resource_monitoring 21:35:39 INFO - Starting resource monitoring. 21:35:39 INFO - [mozharness: 2017-01-02 05:35:39.751324Z] Finished create-virtualenv step (success) 21:35:39 INFO - [mozharness: 2017-01-02 05:35:39.751825Z] Running install step. 21:35:39 INFO - Running pre-action listener: _resource_record_pre_action 21:35:39 INFO - Running main action method: install 21:35:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:39 INFO - Reading from file tmpfile_stdout 21:35:39 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:40 INFO - Reading from file tmpfile_stdout 21:35:40 INFO - Output received: 21:35:40 INFO - Usage: mozinstall [options] installer 21:35:40 INFO - Options: 21:35:40 INFO - -h, --help show this help message and exit 21:35:40 INFO - -d DEST, --destination=DEST 21:35:40 INFO - Directory to install application into. [default: 21:35:40 INFO - "/builds/slave/test"] 21:35:40 INFO - --app=APP Application being installed. [default: firefox] 21:35:40 INFO - mkdir: /builds/slave/test/build/application 21:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:35:53 INFO - Reading from file tmpfile_stdout 21:35:53 INFO - Output received: 21:35:53 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:53 INFO - Running post-action listener: _resource_record_post_action 21:35:53 INFO - [mozharness: 2017-01-02 05:35:53.546458Z] Finished install step (success) 21:35:53 INFO - [mozharness: 2017-01-02 05:35:53.546700Z] Running run-tests step. 21:35:53 INFO - Running pre-action listener: _resource_record_pre_action 21:35:53 INFO - Running main action method: run_tests 21:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:53 INFO - Python 2.7.3 21:35:53 INFO - Return code: 0 21:35:53 INFO - grabbing minidump binary from tooltool 21:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:53 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 0x1b0cf60>, '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 0x1b0dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:35:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:35:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:35:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:53 INFO - Return code: 0 21:35:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:35:53 INFO - Using env: {'DISPLAY': ':0', 21:35:53 INFO - 'HOME': '/home/cltbld', 21:35:53 INFO - 'LANG': 'en_US.UTF-8', 21:35:53 INFO - 'LANGUAGE': 'en_US:en', 21:35:53 INFO - 'LOGNAME': 'cltbld', 21:35:53 INFO - 'MAIL': '/var/mail/cltbld', 21:35:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:53 INFO - 'MOZ_NO_REMOTE': '1', 21:35:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:53 INFO - 'NO_EM_RESTART': '1', 21:35:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:53 INFO - 'PWD': '/builds/slave/test', 21:35:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:53 INFO - 'SHELL': '/bin/bash', 21:35:53 INFO - 'SHLVL': '1', 21:35:53 INFO - 'TERM': 'linux', 21:35:53 INFO - 'TMOUT': '86400', 21:35:53 INFO - 'USER': 'cltbld', 21:35:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340', 21:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:53 INFO - '_': '/tools/buildbot/bin/python'} 21:35:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:35:53 INFO - mozversion application_buildid: 20170101194819 21:35:53 INFO - mozversion application_changeset: addb771c9a728f749feea0328c7ffd4a56888c26 21:35:53 INFO - mozversion application_display_name: Firefox 21:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:53 INFO - mozversion application_name: Firefox 21:35:53 INFO - mozversion application_remotingname: firefox 21:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:35:53 INFO - mozversion application_vendor: Mozilla 21:35:53 INFO - mozversion application_version: 51.0 21:35:53 INFO - mozversion platform_buildid: 20170101194819 21:35:53 INFO - mozversion platform_changeset: addb771c9a728f749feea0328c7ffd4a56888c26 21:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:35:53 INFO - mozversion platform_version: 51.0 21:35:53 INFO - using testdate: 1483335353 21:35:53 INFO - actual date: 1483335353 21:35:53 INFO - starting webserver on 'localhost:44186' 21:35:53 INFO - SUITE-START | Running 2 tests 21:35:53 INFO - TEST-START | dromaeo_css 21:35:53 INFO - operating with platform_type : linux_ 21:35:53 INFO - Initialising browser for dromaeo_css test... 21:35:53 INFO - TEST-INFO | started process 18945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8S1WnU/profile http://localhost:44186/getInfo.html) 21:35:58 INFO - PROCESS | 18945 | __metrics Screen width/height:1600/1200 21:35:58 INFO - PROCESS | 18945 | colorDepth:24 21:35:58 INFO - PROCESS | 18945 | Browser inner width/height: 1024/697 21:35:58 INFO - PROCESS | 18945 | __metrics 21:35:58 INFO - PROCESS | 18945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:35:58 INFO - PROCESS | 18945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:59 INFO - PROCESS | 18945 | console.error: PushService: 21:35:59 INFO - PROCESS | 18945 | stateChangeProcessEnqueue: Error transitioning state 21:35:59 INFO - PROCESS | 18945 | UnknownError 21:35:59 INFO - TEST-INFO | 18945: exit 0 21:35:59 INFO - Browser initialized. 21:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:59 INFO - TEST-INFO | started process 19038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8S1WnU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:11 INFO - PROCESS | 19038 | RSS: Main: 146657280 21:36:11 INFO - PROCESS | 19038 | 21:37:02 INFO - PROCESS | 19038 | 1483335422388 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] 21:39:11 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44186/tests/dromaeo/cssquery-ext.html) 21:39:12 INFO - PROCESS | 19038 | RSS: Main: 249106432 21:39:12 INFO - PROCESS | 19038 | 21:42:14 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-ext.html (next: http://localhost:44186/tests/dromaeo/cssquery-jquery.html) 21:42:15 INFO - PROCESS | 19038 | RSS: Main: 234295296 21:42:15 INFO - PROCESS | 19038 | 21:45:17 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44186/tests/dromaeo/cssquery-mootools.html) 21:45:18 INFO - PROCESS | 19038 | RSS: Main: 174972928 21:45:18 INFO - PROCESS | 19038 | 21:48:19 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44186/tests/dromaeo/cssquery-prototype.html) 21:48:20 INFO - PROCESS | 19038 | RSS: Main: 219353088 21:48:20 INFO - PROCESS | 19038 | 21:51:23 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44186/tests/dromaeo/cssquery-yui.html) 21:51:23 INFO - PROCESS | 19038 | RSS: Main: 177393664 21:51:23 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:44186/tests/dromaeo/cssquery-yui.html (next: http://localhost:44186/tests/dromaeo/cssquery-dojo.html) 21:54:26 INFO - PROCESS | 19038 | RSS: Main: 263675904 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | __start_tp_report 21:54:26 INFO - PROCESS | 19038 | _x_x_mozilla_page_load 21:54:26 INFO - PROCESS | 19038 | _x_x_mozilla_page_load_details 21:54:26 INFO - PROCESS | 19038 | |i|pagename|runs| 21:54:26 INFO - PROCESS | 19038 | |0;dojo.html;3079.5688603595495;3130.6869313068687;3140.952885706716;3161.320316132034;3178.9046328610134;5505.091659876116;5565.165225216219;5581.079121944885;5584.972075139629;5586.190002449643;5502.295537315597;5547.44525547445;5561.860953476165;5564.693941833208;5572.875683536354;5071.644984851062;5076.23856421536;5089.134847076006;5108.335916330871;5148.433672296044;4996.300517927493;5150.201718733602;5171.896562068757;5176.715280659562;5177.559907407875;4978.303037574742;4996.975015124937;5011.523905228997;5024.773885175176;5076.796928122871;5059.924101138467;5083.999999999982;5150.0472412603785;5154.5103215194495;5190.896182076375;4853.538913803183;5058.696478211283;5077.39071311445;5118.38579370478;5145.434002259748;5348.197770334481;5362.973185134088;5366.597505187126;5394.568434525228;5491.176323551459;5766.942330576682;5779.913301300484;5871.500922421599;5876.647401155901;5878.353381128072;5765.538756899438;5918.792842250544;5924.081767326072;5931;5934.821955341346;5452.40023597404;5509.201165830972;5595.992721310163;5601.8599535011135;5622.325320961429;6087.634741915499;6115;6122.816315510542;6126.479249263863;6127.509799216052;5607.327120745455;5884.558658100659;5890.3815099414805;5892.793752218652;5893.410658934073;5729.427057294321;5759.107338362561;5824.650520968756;5828.766849326064;5894.469497745224;5830.82507524775;5832.096025116114;5833.445822646841;5833.67914764692;5838.7080645967535;5795.478406943395;5859.912101318484;5864.648121112747;5865;5879.5002424794375;4457.665675074382;4481.170983368087;4498.640108791289;4510.932336014962;4568.543145685471;4026.134381108076;4047.9797601012397;4052.452918855976;4053.1691003344245;4078.3678529827926;5688;5718.571107166979;5719.685417302005;5723.942760572341;5742.942570574324;5650.943490565124;5705.087186050212;5885.529157667376;5922.851928701731;5942.168096466498;5587.552995760329;5692.943070569324;5696.458836410535;5697.4587414195585;5719.256496655408;5190.714510701948;5194.506521880416;5200.817971370984;5202.635815492879;5226.947730522722;5916.319623243382;5967.492763115184;6049.939500604937;6096.664683442275;6181.629102253879;5957.255343082114;5966.582339236212;5973.522118230444;5990.520758339409;6008.759649614141;6086.269647642134;6105.9694701526205;6159.969200153971;6160.476359509492;6163.3528479509005;5664.405237450009;5704.458076482728;5735.512481438957;5854.502367298827;5861.9413805863105;5843.357230704704;5916.083007133901;5936.22829032223;5968.194293770285;5971.104334349882;5786.971065144648;5786.971065144816;5792.652440853562;5793.246877905845;5795.507381872588;5639.238702775073;5641.774329026793;5787.826365209051;5790.160426738184;5793.478586927196;5617.634853734494;5682.516986056232;5690.37405885344;5698.487136157766;5783.884322313615;5777.422257774357;5810.099434587646;5814.098814683731;5815.5929084963645;5819.679917604403;5469.589780766379;5525.226468294361;5623.8875222496135;5673.461021202979;5675.31896172462 21:54:26 INFO - PROCESS | 19038 | |1;ext.html;591.1812140185841;621.2079598511897;629.5184184099163;639.188230946698;659.1661548141599;34180.82909585452;34770.65229347709;46545.7672711636;47869.52130478694;47911.04177916448;44569.108617827624;48342;48347.75826120865;48351.51648483514;48465.273020904715;8438.367122465808;9393.577289021994;9526.09502097303;9539.761505962337;9551.474668893208;8516.318694504425;8807;8818;11100.167487438433;11362.37506937118;11482.425878706073;11497.827532587018;11540.307581545134;11544;11546.769064618702;11398.886011139906;11477.426128693533;11489;11491.023263022653;11502.884971150264;11208.327500350006;11261.15541334395;11267.436628168558;11269.943650281779;11283.943580282128;44759.77620111879;45004;45048.09903801938;45124;45284.32073518867;3830.898327719207;3923.293807114718;4120.546739858613;4202.348635961431;4639.443266807971;33938.321233575436;34057.82971085153;34191.48712769311;34219.486707699405;34251.143721406916;4752.263399173134;4763.428388593391;4830.879228019293;4843.70937743733;4891.046245981999;348079;348495.2575237133;348936;350185;352515;62534.37465625376;62893.68553157296;62916.370836291964;62930;62961.68519157375;40487.392689109685;41256.79371603123;41456;43729.56270437319;65818;19534.12096455663;19750.802491974897;19751.40745777629;19757.110930008184;19759.40721778349;14724.55826325212;14747.55757327282;14788.92605536987;14804.555863324118;14805.111693298437;18391.632167356576;18828.341008064654;18854.528636783914;20214.797852021587;20856.270030548858;7284.49008569395;7288.234735352818;7394.408447324201;7619.69521219145;7780.766577002699;987.7086259553305;992.3549692699803;1086.6468397770757;1086.6685660873509;1206.6018213989362;33920.32159356799;34077.82961085179;34174;34363.82818085943;34753.478697819555;1145.3585991844593;1163.4473625028213;1192.701824543864;1203.6389083275158;1243.4528807324748;18172.182251798702;18210.544736381697;18271.54321141982;18298.725519117223;18303.81696183048;521774;529747;530087;531044;531886;63548;64059.67970160119;64145;64168.67915660392;64170;1422.9217393043482;1428.9071210371292;1463.5024091808623;1465.3625672832352;1472.963175920589;31138.532922005736;33359.49960750542;33479.49780753242;33518.664813351555;33974.49038264379;55154.44845551493;61060.69469652623;62761.37238627555;62764.68617656882;68317.3168268311;475333;478086;480924;481732;481950;37271.25457490889;40734.38898416585;46683.53316466792;46879;47723.52276477191;47439;50997;51058.234126488875;51170.74414627903;51441.485585143666;43133.56866431421;44335.11329773451;44842.327365090205;45085.77457112693;46020.539794601624;44093.77953110214;44181.55818441774;45786.31320530261;45997.77001114973;49150.75424622997;44227.778861105486;44336.334954976344;44537.55462445334;44927.775361122985;45009;36553.268934621694;38963.415548767356;39535.80232098821;39834;40120.79939600283;29686.218826870456;29756.10731678053;29950.400991980474;30253.243668908453;30278.84860575683 21:54:26 INFO - PROCESS | 19038 | |2;jquery.html;392.34478421036863;421.9810108545115;438.5548668101876;439.27446338075003;446.9307257375108;16072.598185045379;18855.774374665638;21075.789242107556;21132.89433552834;21303.786962130373;19885.3040143595;20666.27668031619;20696.689549656767;20786.376408707725;20982.05580748866;5655.632383895034;5711.657300561969;5936.287645482548;5943.791967281146;5949.6727679977585;5787.710614469281;5826.747249341412;5864.824055278327;5878.970605146968;5882.294124705041;5794.449527294922;5830.7084645767545;5836.2996440427205;5839.591228613998;5843.2403787507565;5939.910901336461;6080.513558915321;6089.117078023706;6092.421219984094;6092.939070609282;5839.737211825478;5860.062390017577;5918.852028699274;5940.465358117747;5986.401359864022;13503.66240843977;13546.187228766306;13625.795613065811;13765.931170344184;13767;2157.52534442424;2340.754220806825;2429.137656132083;2823.322402623376;3030.1212648331957;9698.224142068617;10071.143952764023;10263.332883362558;10425.478726063666;10559;1818.6999145141035;1850.1859181959894;1966.8721533100302;2005.5487515309085;2017.5561376497146;83472.58263708703;86234.13765862324;86544.56727716321;88110.55944720235;89744;10752.623658172082;11689.357085360387;11834.349110798988;11895.799277133758;12276.263424194576;14582.343794529059;15482.458113965957;15491.767623485657;15498.84501154974;16151.757723634155;6750.257471678112;8406.369522285853;8880.378373513791;8907.643694252158;8952.68665596714;8675.175858293453;8771.561421928878;8775.517346545874;8916.465012099165;8940.821183576421;4743.739094349844;4836.12949669063;5262.684238945675;5293.258943747878;5308.708021058802;1933.4296382567177;1939.1177014458387;1961.3135402608973;1990.741203643517;2038.1134206620168;996.6113215845826;996.6760802739138;997.2072202598952;1009.4195837393528;1106.8948449897248;19339.51651208703;19935.501612459804;19951.501212469804;19983.900080499505;20066.398008059783;993.6621548673486;1012.7366884610054;1047.7904419116207;1055.3562326980536;1065.7815147894662;10407.635732749317;10788.514516846604;10930.726731831768;11318.886811131948;11393.632764068365;565084;573461;578472;579539;581292;60022.39977600255;98683.50658246662;98830;99447.50276248572;99782.50108749409;1055.883852776194;1066.269605320358;1102.393683474086;1102.5424448853637;1109.4175557832202;17166.656666866344;17318.31322899003;17385.13074346303;17515.3869614568;17783.310585494357;41777.58222417737;42347.7882610585;42996.14007719891;43244.56755432405;43538.782306088266;59300;60411;62321.68839155775;62544;63655.3634463668;8451.8732219018;8537.957310213409;8700.042995270642;8716.520591367282;8857.778555536162;12275.815862761887;13276.86723132795;13277.535286264934;13704.931475342959;14061.226632535308;10991.230613856953;11910.642680719593;12059.57791477294;12102.152849300464;12251.264924104582;11164;11166.106711463226;11174.497147628213;11410.543578256777;11721;11755.177137600285;11813.822792657946;11887;11941.701457463285;12405.565805196775;7671.309582137635;8108.9594552026865;8144.75565733029;8403.95798021006;9184.908150918673;8427.325813934993;8508.149185081442;8554.572271386281;8985.326100542356;9184.219341355792 21:54:26 INFO - PROCESS | 19038 | |3;mootools.html;1414.6180531256568;1536.4852774320598;1569.905805651661;1741.43403393897;1892.7255547945556;8273.172682731723;9228.584713687884;9536.570854311556;9552.61789528419;9816.263780216477;9586.856197157049;9680.370775899562;9685.128338449538;9687.612495500189;9694.709158725233;2504.4114633061217;2552.1960582416573;2555.0418593027616;2557.207265747615;2557.360659835041;2450.47314827313;2515.3585835611893;2526.1916186820226;2528.216252961588;2531.8227724059325;2475.3687809608523;2490.9377265568414;2497.650328953948;2499.6750422445057;2502.8998840046374;2387.3792813868345;2406.590879550472;2414.553307638084;2466.4203912080648;2469.444375015625;2410.6384042393606;2445.461998360358;2454.8527088374753;2455.2756936703713;2460.188137914484;9404.15362617361;9477.336586438953;9511.952440237823;9564.330496865223;9574;5424.83725488236;5607.831765047055;5614.129809879434;5702.714864256812;5720.599558030939;3602.9099272518133;3621.94567081494;3650.634936506328;3652.853885844563;3706.3513885070006;1180.3803003423186;1202.058675239482;1235.975280494385;1256.6167318967712;1259.1815320041953;12752.2986235757;12766.61700148997;12810.231386116862;12818.871811281955;12826.294553799537;4628.652851036119;4645.9303110453375;4726.361941137971;4776.259679749644;4950.3069570260195;10025.047620476043;10042.895281519028;10049.397036177706;10057.346272492265;10065.69802905914;5534.529564987021;5540.833774986757;5541.251930989265;5566.860828479321;5587.580931430159;4566.360709500673;4699.483056863743;5047.293378926953;5160.40655324635;5196.662216955886;3995.400689896481;3997.040710229582;4032.052467670095;4127.9174416512105;4136.276151673445;1210.0501106631427;1221.3709939381226;1227.2145826670937;1234.919730217533;1242.4781591731494;949.3876449690049;965.9468729219819;978.6934442519316;992.4194346307347;1011.0445628880638;6000.7899723510345;6020.57855950088;6023.066424704178;6119.571629985859;6194.81415557534;493.56812788809793;495.77690039482377;506.65800584605245;507.6345031577259;507.70045673053073;4208.784239108884;4211.4525111735275;4240.1519696060295;4309.267424537836;4374.825006999685;11326.546938122548;11781.469833857496;11786;11794.88205117955;11807.940960295144;11738.647840564796;11744.530218791324;11747.47136378865;11760.764784704257;11767.941160294144;8260.421770476009;8662.047174810767;8747;8828.735137945872;8830.293576513863;6156.815295541141;6272.529560283088;6373.7131829066875;6393.1369265148605;6459.418652321314;10473.476326183812;10709.410982396043;10823.67528974132;10834.241603088023;10857.67426977192;11014.1739369546;11023.06303964172;11099;11120.555177792798;11124.388158651353;7706.614669266626;7719.291291767384;8212.384071194803;8250.216229458192;8346.666133354598;9299.907000929905;9327.347085703936;9418.670346537838;9422.670206542738;9428.387154834914;8016.679332826621;8026.1171271158955;8051.718189863327;8258.25675689191;8395.580220988804;7921.287084162453;7959.880601791094;7973.561454120079;8046.919530804851;8280.378971577034;7387.335139837441;7398.778036658909;7431.145418276968;7531.284527969834;7627.923720762721;5218.765155568084;5359.517643412111;5363.704996225089;5499.7250137492165;5502.8349149525575;5102.668326558762;5113.335266415343;5187.19598462239;5276.15581506957;5386.703731294817 21:54:26 INFO - PROCESS | 19038 | |4;prototype.html;320.67291362809937;339.1842618502501;339.88274045454307;348.21477568083975;355.32842926868216;5603.777827749041;5631.18347839563;5633;5711.228984087147;5726.942730572699;5247;5361.651492652974;5407.161889907071;5475.698836563987;5529.25828364066;4241.406203131564;4262.339337402707;4285.528591854893;4302.311630139178;4306.18182545317;4277.593628605277;4295.828166873322;4300.720453170549;4308.676849236304;4335.718178318415;4075.53131389891;4269.765162916038;4273.209456250588;4297.35539669049;4308.97845510772;4278.679099067583;4284.33592793116;4285.500074973735;4290.721103128287;4293.914121717579;3762.6989840812944;3784.3944968805135;3797.8290976906105;3804.239152169577;3811.9809400953095;5275.762590683428;5435.83692489226;5467.840203119746;5494.230807686927;5536.2249285100115;4892.853214403538;4894.779734911902;4914.311996320518;4929.137400954819;4933.28467372229;5750.7412166452195;5755.395683453219;5785.27684039495;5786.135862747967;5817.709114544298;4052.6352628263303;4132.690048246363;4149.232392007458;4153.335466325373;4180.268453020709;6002.189704389895;6020.247469066367;6037.72830222641;6044.244469441276;6054.69726513677;4240.427542281815;4279.646194592961;4290.721103128349;4300.16146851361;4306.763128027988;4057.1885622875543;4250.808713607895;4250.85122020734;4344.826206951687;4346.630536404377;4863.635227357962;4874.7562621868765;4877.463479017305;4881.585065269421;4895.657303988758;5836.358000619928;5851.853703657443;5877.23595932526;5879.853003674943;5880.441358070976;1472.2491529320123;1487.2340744516582;1500.932458039391;1503.0831192972278;1507.148461119464;913.5706218077493;929.5677509957767;953.537534295866;958.5686441101532;965.0253244223245;4998.9006815774455;4999.375078115236;5012.899742005139;5035.173268316033;5041.974790126099;5223.634345595848;5245.527902488718;5267.657602255841;5281.521174071267;5288.624957511075;4742.978402246541;5007.749612519359;5038.622103342191;5049.949500505021;5085.703145697823;2804.6213761142394;2808.4242730240253;2816.957745633817;2818.25316291183;2829.2926768307925;5388.649737767033;5390.328998010629;5410.864728381822;5432.293801805819;5450.182472629137;5260.526552610283;5301.867453313621;5703.258576385127;6162.476189523851;6179.938200618026;6218.787336469345;6223.595466294676;6227.532935029891;6232.220972378453;6263.959745963828;5952.821415357546;6021.187139736079;6057.242844644419;6064.363241859542;6066.1507388966465;5993.430624090704;6004.819855404345;6012.218411606463;6016.5487588431915;6021.066734656135;6250.687465626609;6262.405071518198;6264.812055638338;6266.373362663697;6281.968590157203;4037.656799172103;4041.333180025263;4199.370094485852;4238.364245363096;4286.528481867054;5832.650040997553;5855.121731740273;5985.551083668655;6025.548083893813;6037;5875.236219291465;5876.206712093813;5899.882002360015;5901.970490147522;5905.405540504125;5755.769769209185;5828.94171058284;5866.096282340099;5876.237128861239;5899.292084949833;5794.420557944172;5809.564282678901;5812.854678633068;5815.331236907809;5825.271841019872;5800.622959507618;5883.441073098049;5926.614770039933;5942.6731529766275;5965.850853728692;5753.280839895013;5755.597108202385;5766.711664416678;5788.681622510802;5829.183914252093 21:54:26 INFO - PROCESS | 19038 | |5;yui.html;803.2248879830962;805.4764403137959;848.1518481518477;875.7504111328273;884.7301573020229;18347.44957651271;19037.23851045958;19188.328408505706;19525.414237572895;19731.704024439645;17215.397461088865;17566.912165439186;17622.471325860213;17716.557086072855;17765.91117044416;745.2473002267722;875.829213303406;901.9233365163936;903.9141281578272;904.4121321141278;762.5805806806262;842.616609442702;857.3269983063296;870.0255713600776;874.9825003499926;945.2721404518517;946.7775072857872;947.8578213267996;947.9289053321029;948.8434408322619;937.7327461673425;939.9154076133112;941.0495399646338;941.6092321686492;942.9292803039765;694.7950354645392;696.1576492444149;696.24109720405;697.3514631392802;697.4490152779298;16526.173691315387;16559.503214903572;16576.17119144038;16580.917095414567;16612.335506579722;14323.641908952255;15326.540203793904;15726.49572649575;15911.443099491462;16340.509784706477;13105;13211.735765284737;13455.798163027563;13587.660308492366;13691.178529288174;4055.878323650295;4097.180563887235;4123;4194.454720886265;4195.895102622429;82453.58773206096;85386;88522;90139;90883;12180.330081845406;12257.570985015482;12273.509059637692;12299.139060265874;12377.257364558156;22956.426089347566;23024.079036838673;23162.3051308461;23191.072357105862;23690.526189476113;9127.90872091284;9285.907140928639;9313.115254050854;9363.4381937084;9806;5125.897482050338;5217.817376391884;5229.320188375563;5273.288106105703;5379.704116273642;3637.5816781070516;3750.3249415104997;3753.0617345663586;3753.5683396409217;3754.4743735877;581.2705055155837;587.327510001055;599.9070144127667;600.5825950964038;609.5245708347496;731.9048523691886;747.0885519665999;748.8914107454498;758.8478589295974;766.7124828189429;8989.775255618662;9418.858717119248;9476.194523465445;9503.524823758922;9576.952115239379;636.0268788753215;674.3795707948699;747.8130467383154;769.4306213402042;792.6710415177637;4340.891477713082;4609.815607375667;4625.722456652545;4627.629789616823;4712.5994290485005;61480.385196147465;61572.69213653903;62785;98425.50787246162;102469;96381;96811;97346;98054.50972745233;98266.5086674562;80388.59805701052;86631.56684216538;89027.10972890317;89349;91044.08955910489;9847.45838978863;9909.405435673883;10048.49757512136;10151;10156;52206.738966304925;52385.214221787464;52768.472315276354;53667.46332536625;53936.73031634817;71516.64241678758;74235;75872.62063689646;77668;77980;12453.1905426147;12598.748025039264;13184;13425.462981481021;13578.25319607431;14809.481668141563;15029.248537573296;15190.544283671508;15212.619684507976;16090.436834710728;13894.930525347309;14146.575602731935;14538.41846326135;14705.632359191106;14780.33488492999;13998.37007334652;14040.297985100908;14378.35297411598;14398.568042958728;14412.42350306018;10713.732156696145;13978.650533736738;14001.229932353412;14021.439142434188;14290.714185716019;10806.130829284653;11267.323960562393;11515.769684606428;11842.82235766447;12385.531592282725;11252.66242012741;11354.205205635857;11495.436414711467;11518.214676725122;11939.582114625946 21:54:26 INFO - PROCESS | 19038 | __end_tp_report 21:54:26 INFO - PROCESS | 19038 | __start_cc_report 21:54:26 INFO - PROCESS | 19038 | _x_x_mozilla_cycle_collect,856 21:54:26 INFO - PROCESS | 19038 | __end_cc_report 21:54:26 INFO - PROCESS | 19038 | __startTimestamp1483336466450__endTimestamp 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | ------- Summary: start ------- 21:54:26 INFO - PROCESS | 19038 | Number of tests: 6 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#0] dojo.html Cycles:165 Average:5492.31 Median:5697.46 stddev:616.84 (10.8%) stddev-sans-first:588.98 21:54:26 INFO - PROCESS | 19038 | Values: 3079.6 3130.7 3141.0 3161.3 3178.9 5505.1 5565.2 5581.1 5585.0 5586.2 5502.3 5547.4 5561.9 5564.7 5572.9 5071.6 5076.2 5089.1 5108.3 5148.4 4996.3 5150.2 5171.9 5176.7 5177.6 4978.3 4997.0 5011.5 5024.8 5076.8 5059.9 5084.0 5150.0 5154.5 5190.9 4853.5 5058.7 5077.4 5118.4 5145.4 5348.2 5363.0 5366.6 5394.6 5491.2 5766.9 5779.9 5871.5 5876.6 5878.4 5765.5 5918.8 5924.1 5931.0 5934.8 5452.4 5509.2 5596.0 5601.9 5622.3 6087.6 6115.0 6122.8 6126.5 6127.5 5607.3 5884.6 5890.4 5892.8 5893.4 5729.4 5759.1 5824.7 5828.8 5894.5 5830.8 5832.1 5833.4 5833.7 5838.7 5795.5 5859.9 5864.6 5865.0 5879.5 4457.7 4481.2 4498.6 4510.9 4568.5 4026.1 4048.0 4052.5 4053.2 4078.4 5688.0 5718.6 5719.7 5723.9 5742.9 5650.9 5705.1 5885.5 5922.9 5942.2 5587.6 5692.9 5696.5 5697.5 5719.3 5190.7 5194.5 5200.8 5202.6 5226.9 5916.3 5967.5 6049.9 6096.7 6181.6 5957.3 5966.6 5973.5 5990.5 6008.8 6086.3 6106.0 6160.0 6160.5 6163.4 5664.4 5704.5 5735.5 5854.5 5861.9 5843.4 5916.1 5936.2 5968.2 5971.1 5787.0 5787.0 5792.7 5793.2 5795.5 5639.2 5641.8 5787.8 5790.2 5793.5 5617.6 5682.5 5690.4 5698.5 5783.9 5777.4 5810.1 5814.1 5815.6 5819.7 5469.6 5525.2 5623.9 5673.5 5675.3 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#1] ext.html Cycles:180 Average:63182.80 Median:23667.96 stddev:121334.09 (512.7%) stddev-sans-first:121583.45 21:54:26 INFO - PROCESS | 19038 | Values: 591.2 621.2 629.5 639.2 659.2 34180.8 34770.7 46545.8 47869.5 47911.0 44569.1 48342.0 48347.8 48351.5 48465.3 8438.4 9393.6 9526.1 9539.8 9551.5 8516.3 8807.0 8818.0 11100.2 11362.4 11482.4 11497.8 11540.3 11544.0 11546.8 11398.9 11477.4 11489.0 11491.0 11502.9 11208.3 11261.2 11267.4 11269.9 11283.9 44759.8 45004.0 45048.1 45124.0 45284.3 3830.9 3923.3 4120.5 4202.3 4639.4 33938.3 34057.8 34191.5 34219.5 34251.1 4752.3 4763.4 4830.9 4843.7 4891.0 348079.0 348495.3 348936.0 350185.0 352515.0 62534.4 62893.7 62916.4 62930.0 62961.7 40487.4 41256.8 41456.0 43729.6 65818.0 19534.1 19750.8 19751.4 19757.1 19759.4 14724.6 14747.6 14788.9 14804.6 14805.1 18391.6 18828.3 18854.5 20214.8 20856.3 7284.5 7288.2 7394.4 7619.7 7780.8 987.7 992.4 1086.6 1086.7 1206.6 33920.3 34077.8 34174.0 34363.8 34753.5 1145.4 1163.4 1192.7 1203.6 1243.5 18172.2 18210.5 18271.5 18298.7 18303.8 521774.0 529747.0 530087.0 531044.0 531886.0 63548.0 64059.7 64145.0 64168.7 64170.0 1422.9 1428.9 1463.5 1465.4 1473.0 31138.5 33359.5 33479.5 33518.7 33974.5 55154.4 61060.7 62761.4 62764.7 68317.3 475333.0 478086.0 480924.0 481732.0 481950.0 37271.3 40734.4 46683.5 46879.0 47723.5 47439.0 50997.0 51058.2 51170.7 51441.5 43133.6 44335.1 44842.3 45085.8 46020.5 44093.8 44181.6 45786.3 45997.8 49150.8 44227.8 44336.3 44537.6 44927.8 45009.0 36553.3 38963.4 39535.8 39834.0 40120.8 29686.2 29756.1 29950.4 30253.2 30278.8 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#2] jquery.html Cycles:180 Average:31490.40 Median:21084.96 stddev:94670.82 (449.0%) stddev-sans-first:94907.60 21:54:26 INFO - PROCESS | 19038 | Values: 392.3 422.0 438.6 439.3 446.9 16072.6 18855.8 21075.8 21132.9 21303.8 19885.3 20666.3 20696.7 20786.4 20982.1 5655.6 5711.7 5936.3 5943.8 5949.7 5787.7 5826.7 5864.8 5879.0 5882.3 5794.4 5830.7 5836.3 5839.6 5843.2 5939.9 6080.5 6089.1 6092.4 6092.9 5839.7 5860.1 5918.9 5940.5 5986.4 13503.7 13546.2 13625.8 13765.9 13767.0 2157.5 2340.8 2429.1 2823.3 3030.1 9698.2 10071.1 10263.3 10425.5 10559.0 1818.7 1850.2 1966.9 2005.5 2017.6 83472.6 86234.1 86544.6 88110.6 89744.0 10752.6 11689.4 11834.3 11895.8 12276.3 14582.3 15482.5 15491.8 15498.8 16151.8 6750.3 8406.4 8880.4 8907.6 8952.7 8675.2 8771.6 8775.5 8916.5 8940.8 4743.7 4836.1 5262.7 5293.3 5308.7 1933.4 1939.1 1961.3 1990.7 2038.1 996.6 996.7 997.2 1009.4 1106.9 19339.5 19935.5 19951.5 19983.9 20066.4 993.7 1012.7 1047.8 1055.4 1065.8 10407.6 10788.5 10930.7 11318.9 11393.6 565084.0 573461.0 578472.0 579539.0 581292.0 60022.4 98683.5 98830.0 99447.5 99782.5 1055.9 1066.3 1102.4 1102.5 1109.4 17166.7 17318.3 17385.1 17515.4 17783.3 41777.6 42347.8 42996.1 43244.6 43538.8 59300.0 60411.0 62321.7 62544.0 63655.4 8451.9 8538.0 8700.0 8716.5 8857.8 12275.8 13276.9 13277.5 13704.9 14061.2 10991.2 11910.6 12059.6 12102.2 12251.3 11164.0 11166.1 11174.5 11410.5 11721.0 11755.2 11813.8 11887.0 11941.7 12405.6 7671.3 8109.0 8144.8 8404.0 9184.9 8427.3 8508.1 8554.6 8985.3 9184.2 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#3] mootools.html Cycles:180 Average:6114.85 Median:4751.31 stddev:3526.03 (74.2%) stddev-sans-first:3518.23 21:54:26 INFO - PROCESS | 19038 | Values: 1414.6 1536.5 1569.9 1741.4 1892.7 8273.2 9228.6 9536.6 9552.6 9816.3 9586.9 9680.4 9685.1 9687.6 9694.7 2504.4 2552.2 2555.0 2557.2 2557.4 2450.5 2515.4 2526.2 2528.2 2531.8 2475.4 2490.9 2497.7 2499.7 2502.9 2387.4 2406.6 2414.6 2466.4 2469.4 2410.6 2445.5 2454.9 2455.3 2460.2 9404.2 9477.3 9512.0 9564.3 9574.0 5424.8 5607.8 5614.1 5702.7 5720.6 3602.9 3621.9 3650.6 3652.9 3706.4 1180.4 1202.1 1236.0 1256.6 1259.2 12752.3 12766.6 12810.2 12818.9 12826.3 4628.7 4645.9 4726.4 4776.3 4950.3 10025.0 10042.9 10049.4 10057.3 10065.7 5534.5 5540.8 5541.3 5566.9 5587.6 4566.4 4699.5 5047.3 5160.4 5196.7 3995.4 3997.0 4032.1 4127.9 4136.3 1210.1 1221.4 1227.2 1234.9 1242.5 949.4 965.9 978.7 992.4 1011.0 6000.8 6020.6 6023.1 6119.6 6194.8 493.6 495.8 506.7 507.6 507.7 4208.8 4211.5 4240.2 4309.3 4374.8 11326.5 11781.5 11786.0 11794.9 11807.9 11738.6 11744.5 11747.5 11760.8 11767.9 8260.4 8662.0 8747.0 8828.7 8830.3 6156.8 6272.5 6373.7 6393.1 6459.4 10473.5 10709.4 10823.7 10834.2 10857.7 11014.2 11023.1 11099.0 11120.6 11124.4 7706.6 7719.3 8212.4 8250.2 8346.7 9299.9 9327.3 9418.7 9422.7 9428.4 8016.7 8026.1 8051.7 8258.3 8395.6 7921.3 7959.9 7973.6 8046.9 8280.4 7387.3 7398.8 7431.1 7531.3 7627.9 5218.8 5359.5 5363.7 5499.7 5502.8 5102.7 5113.3 5187.2 5276.2 5386.7 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#4] prototype.html Cycles:180 Average:4817.30 Median:5389.49 stddev:1438.07 (26.7%) stddev-sans-first:1401.94 21:54:26 INFO - PROCESS | 19038 | Values: 320.7 339.2 339.9 348.2 355.3 5603.8 5631.2 5633.0 5711.2 5726.9 5247.0 5361.7 5407.2 5475.7 5529.3 4241.4 4262.3 4285.5 4302.3 4306.2 4277.6 4295.8 4300.7 4308.7 4335.7 4075.5 4269.8 4273.2 4297.4 4309.0 4278.7 4284.3 4285.5 4290.7 4293.9 3762.7 3784.4 3797.8 3804.2 3812.0 5275.8 5435.8 5467.8 5494.2 5536.2 4892.9 4894.8 4914.3 4929.1 4933.3 5750.7 5755.4 5785.3 5786.1 5817.7 4052.6 4132.7 4149.2 4153.3 4180.3 6002.2 6020.2 6037.7 6044.2 6054.7 4240.4 4279.6 4290.7 4300.2 4306.8 4057.2 4250.8 4250.9 4344.8 4346.6 4863.6 4874.8 4877.5 4881.6 4895.7 5836.4 5851.9 5877.2 5879.9 5880.4 1472.2 1487.2 1500.9 1503.1 1507.1 913.6 929.6 953.5 958.6 965.0 4998.9 4999.4 5012.9 5035.2 5042.0 5223.6 5245.5 5267.7 5281.5 5288.6 4743.0 5007.7 5038.6 5049.9 5085.7 2804.6 2808.4 2817.0 2818.3 2829.3 5388.6 5390.3 5410.9 5432.3 5450.2 5260.5 5301.9 5703.3 6162.5 6179.9 6218.8 6223.6 6227.5 6232.2 6264.0 5952.8 6021.2 6057.2 6064.4 6066.2 5993.4 6004.8 6012.2 6016.5 6021.1 6250.7 6262.4 6264.8 6266.4 6282.0 4037.7 4041.3 4199.4 4238.4 4286.5 5832.7 5855.1 5985.6 6025.5 6037.0 5875.2 5876.2 5899.9 5902.0 5905.4 5755.8 5828.9 5866.1 5876.2 5899.3 5794.4 5809.6 5812.9 5815.3 5825.3 5800.6 5883.4 5926.6 5942.7 5965.9 5753.3 5755.6 5766.7 5788.7 5829.2 21:54:26 INFO - PROCESS | 19038 | 21:54:26 INFO - PROCESS | 19038 | [#5] yui.html Cycles:180 Average:20633.49 Median:28712.28 stddev:27958.81 (97.4%) stddev-sans-first:27997.59 21:54:26 INFO - PROCESS | 19038 | Values: 803.2 805.5 848.2 875.8 884.7 18347.4 19037.2 19188.3 19525.4 19731.7 17215.4 17566.9 17622.5 17716.6 17765.9 745.2 875.8 901.9 903.9 904.4 762.6 842.6 857.3 870.0 875.0 945.3 946.8 947.9 947.9 948.8 937.7 939.9 941.0 941.6 942.9 694.8 696.2 696.2 697.4 697.4 16526.2 16559.5 16576.2 16580.9 16612.3 14323.6 15326.5 15726.5 15911.4 16340.5 13105.0 13211.7 13455.8 13587.7 13691.2 4055.9 4097.2 4123.0 4194.5 4195.9 82453.6 85386.0 88522.0 90139.0 90883.0 12180.3 12257.6 12273.5 12299.1 12377.3 22956.4 23024.1 23162.3 23191.1 23690.5 9127.9 9285.9 9313.1 9363.4 9806.0 5125.9 5217.8 5229.3 5273.3 5379.7 3637.6 3750.3 3753.1 3753.6 3754.5 581.3 587.3 599.9 600.6 609.5 731.9 747.1 748.9 758.8 766.7 8989.8 9418.9 9476.2 9503.5 9577.0 636.0 674.4 747.8 769.4 792.7 4340.9 4609.8 4625.7 4627.6 4712.6 61480.4 61572.7 62785.0 98425.5 102469.0 96381.0 96811.0 97346.0 98054.5 98266.5 80388.6 86631.6 89027.1 89349.0 91044.1 9847.5 9909.4 10048.5 10151.0 10156.0 52206.7 52385.2 52768.5 53667.5 53936.7 71516.6 74235.0 75872.6 77668.0 77980.0 12453.2 12598.7 13184.0 13425.5 13578.3 14809.5 15029.2 15190.5 15212.6 16090.4 13894.9 14146.6 14538.4 14705.6 14780.3 13998.4 14040.3 14378.4 14398.6 14412.4 10713.7 13978.7 14001.2 14021.4 14290.7 10806.1 11267.3 11515.8 11842.8 12385.5 11252.7 11354.2 11495.4 11518.2 11939.6 21:54:26 INFO - PROCESS | 19038 | -------- Summary: end -------- 21:54:26 INFO - PROCESS | 19038 | 21:54:27 INFO - TEST-INFO | 19038: exit 0 21:54:27 INFO - TEST-OK | dromaeo_css | took 1113354ms 21:54:27 INFO - TEST-START | kraken 21:54:27 INFO - operating with platform_type : linux_ 21:54:27 INFO - Initialising browser for kraken test... 21:54:27 INFO - TEST-INFO | started process 19344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXiYZWs/profile http://localhost:44186/getInfo.html) 21:54:31 INFO - PROCESS | 19344 | __metrics Screen width/height:1600/1200 21:54:31 INFO - PROCESS | 19344 | colorDepth:24 21:54:31 INFO - PROCESS | 19344 | Browser inner width/height: 1024/697 21:54:31 INFO - PROCESS | 19344 | __metrics 21:54:31 INFO - PROCESS | 19344 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:54:31 INFO - PROCESS | 19344 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:32 INFO - PROCESS | 19344 | console.error: PushService: 21:54:32 INFO - PROCESS | 19344 | stateChangeProcessEnqueue: Error transitioning state 21:54:32 INFO - PROCESS | 19344 | UnknownError 21:54:32 INFO - TEST-INFO | 19344: exit 0 21:54:32 INFO - Browser initialized. 21:54:32 INFO - Running cycle 1/1 for kraken test... 21:54:32 INFO - TEST-INFO | started process 19436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXiYZWs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:44 INFO - PROCESS | 19436 | RSS: Main: 143462400 21:54:44 INFO - PROCESS | 19436 | 21:54:47 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44186/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:47 INFO - PROCESS | 19436 | RSS: Main: 187174912 21:54:47 INFO - PROCESS | 19436 | 21:54:50 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44186/tests/kraken/driver.html?testName=audio-dft) 21:54:51 INFO - PROCESS | 19436 | RSS: Main: 174366720 21:54:51 INFO - PROCESS | 19436 | 21:54:53 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44186/tests/kraken/driver.html?testName=audio-fft) 21:54:54 INFO - PROCESS | 19436 | RSS: Main: 266076160 21:54:54 INFO - PROCESS | 19436 | 21:54:56 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44186/tests/kraken/driver.html?testName=audio-oscillator) 21:54:57 INFO - PROCESS | 19436 | RSS: Main: 173031424 21:54:57 INFO - PROCESS | 19436 | 21:54:59 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:59 INFO - PROCESS | 19436 | RSS: Main: 174288896 21:54:59 INFO - PROCESS | 19436 | 21:55:02 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44186/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:03 INFO - PROCESS | 19436 | RSS: Main: 209879040 21:55:03 INFO - PROCESS | 19436 | 21:55:06 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44186/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:07 INFO - PROCESS | 19436 | RSS: Main: 209846272 21:55:07 INFO - PROCESS | 19436 | 21:55:10 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44186/tests/kraken/driver.html?testName=json-parse-financial) 21:55:10 INFO - PROCESS | 19436 | RSS: Main: 208031744 21:55:10 INFO - PROCESS | 19436 | 21:55:12 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:12 INFO - PROCESS | 19436 | RSS: Main: 170500096 21:55:12 INFO - PROCESS | 19436 | 21:55:14 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:15 INFO - PROCESS | 19436 | RSS: Main: 178188288 21:55:15 INFO - PROCESS | 19436 | 21:55:16 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:17 INFO - PROCESS | 19436 | RSS: Main: 187068416 21:55:17 INFO - PROCESS | 19436 | 21:55:20 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:20 INFO - PROCESS | 19436 | RSS: Main: 195534848 21:55:20 INFO - PROCESS | 19436 | 21:55:23 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:24 INFO - PROCESS | 19436 | RSS: Main: 192954368 21:55:24 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:44186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44186/tests/kraken/driver.html?testName=ai-astar) 21:55:25 INFO - PROCESS | 19436 | RSS: Main: 245047296 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | __start_tp_report 21:55:25 INFO - PROCESS | 19436 | _x_x_mozilla_page_load 21:55:25 INFO - PROCESS | 19436 | _x_x_mozilla_page_load_details 21:55:25 INFO - PROCESS | 19436 | |i|pagename|runs| 21:55:25 INFO - PROCESS | 19436 | |0;ai-astar;110;109;110;110;111;110;111;110;111;110 21:55:25 INFO - PROCESS | 19436 | |1;audio-beat-detection;145;115;118;162;118;118;117;115;146;121 21:55:25 INFO - PROCESS | 19436 | |2;audio-dft;162;163;160;159;161;162;163;161;162;161 21:55:25 INFO - PROCESS | 19436 | |3;audio-fft;75;75;75;117;75;75;79;76;103;76 21:55:25 INFO - PROCESS | 19436 | |4;audio-oscillator;81;82;120;82;81;81;100;81;81;102 21:55:25 INFO - PROCESS | 19436 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;119;116;117 21:55:25 INFO - PROCESS | 19436 | |6;imaging-darkroom;147;145;146;145;146;145;146;147;146;144 21:55:25 INFO - PROCESS | 19436 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;94 21:55:25 INFO - PROCESS | 19436 | |8;json-parse-financial;50;52;49;50;54;50;49;50;49;48 21:55:25 INFO - PROCESS | 19436 | |9;json-stringify-tinderbox;60;60;60;61;60;61;60;60;59;60 21:55:25 INFO - PROCESS | 19436 | |10;stanford-crypto-aes;73;74;79;75;82;74;74;76;73;73 21:55:25 INFO - PROCESS | 19436 | |11;stanford-crypto-ccm;122;122;124;124;120;120;118;119;160;121 21:55:25 INFO - PROCESS | 19436 | |12;stanford-crypto-pbkdf2;157;159;154;157;157;155;157;159;154;157 21:55:25 INFO - PROCESS | 19436 | |13;stanford-crypto-sha256-iterative;66;63;64;63;63;61;66;62;63;61 21:55:25 INFO - PROCESS | 19436 | __end_tp_report 21:55:25 INFO - PROCESS | 19436 | __start_cc_report 21:55:25 INFO - PROCESS | 19436 | _x_x_mozilla_cycle_collect,1577 21:55:25 INFO - PROCESS | 19436 | __end_cc_report 21:55:25 INFO - PROCESS | 19436 | __startTimestamp1483336525915__endTimestamp 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | ------- Summary: start ------- 21:55:25 INFO - PROCESS | 19436 | Number of tests: 14 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 21:55:25 INFO - PROCESS | 19436 | Values: 110.0 109.0 110.0 110.0 111.0 110.0 111.0 110.0 111.0 110.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:119.50 stddev:16.91 (14.2%) stddev-sans-first:16.71 21:55:25 INFO - PROCESS | 19436 | Values: 145.0 115.0 118.0 162.0 118.0 118.0 117.0 115.0 146.0 121.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 21:55:25 INFO - PROCESS | 19436 | Values: 162.0 163.0 160.0 159.0 161.0 162.0 163.0 161.0 162.0 161.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:14.86 (19.8%) stddev-sans-first:15.51 21:55:25 INFO - PROCESS | 19436 | Values: 75.0 75.0 75.0 117.0 75.0 75.0 79.0 76.0 103.0 76.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:81.00 stddev:13.62 (16.8%) stddev-sans-first:14.12 21:55:25 INFO - PROCESS | 19436 | Values: 81.0 82.0 120.0 82.0 81.0 81.0 100.0 81.0 81.0 102.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 21:55:25 INFO - PROCESS | 19436 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 119.0 116.0 117.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 21:55:25 INFO - PROCESS | 19436 | Values: 147.0 145.0 146.0 145.0 146.0 145.0 146.0 147.0 146.0 144.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:55:25 INFO - PROCESS | 19436 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:1.73 (3.5%) stddev-sans-first:1.83 21:55:25 INFO - PROCESS | 19436 | Values: 50.0 52.0 49.0 50.0 54.0 50.0 49.0 50.0 49.0 48.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 21:55:25 INFO - PROCESS | 19436 | Values: 60.0 60.0 60.0 61.0 60.0 61.0 60.0 60.0 59.0 60.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.98 (4.0%) stddev-sans-first:3.05 21:55:25 INFO - PROCESS | 19436 | Values: 73.0 74.0 79.0 75.0 82.0 74.0 74.0 76.0 73.0 73.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:122.00 stddev:12.45 (10.2%) stddev-sans-first:13.16 21:55:25 INFO - PROCESS | 19436 | Values: 122.0 122.0 124.0 124.0 120.0 120.0 118.0 119.0 160.0 121.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 21:55:25 INFO - PROCESS | 19436 | Values: 157.0 159.0 154.0 157.0 157.0 155.0 157.0 159.0 154.0 157.0 21:55:25 INFO - PROCESS | 19436 | 21:55:25 INFO - PROCESS | 19436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.54 21:55:25 INFO - PROCESS | 19436 | Values: 66.0 63.0 64.0 63.0 63.0 61.0 66.0 62.0 63.0 61.0 21:55:25 INFO - PROCESS | 19436 | -------- Summary: end -------- 21:55:25 INFO - PROCESS | 19436 | 21:55:27 INFO - TEST-INFO | 19436: exit 0 21:55:27 INFO - TEST-OK | kraken | took 60000ms 21:55:27 INFO - SUITE-END | took 1173s 21:55:27 INFO - Completed test suite (00:19:33) 21:55:27 INFO - javascript benchmark 21:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.5688603595495, 3130.6869313068687, 3140.952885706716, 3161.320316132034, 3178.9046328610134, 5505.091659876116, 5565.165225216219, 5581.079121944885, 5584.972075139629, 5586.190002449643, 5502.295537315597, 5547.44525547445, 5561.860953476165, 5564.693941833208, 5572.875683536354, 5071.644984851062, 5076.23856421536, 5089.134847076006, 5108.335916330871, 5148.433672296044, 4996.300517927493, 5150.201718733602, 5171.896562068757, 5176.715280659562, 5177.559907407875, 4978.303037574742, 4996.975015124937, 5011.523905228997, 5024.773885175176, 5076.796928122871, 5059.924101138467, 5083.999999999982, 5150.0472412603785, 5154.5103215194495, 5190.896182076375, 4853.538913803183, 5058.696478211283, 5077.39071311445, 5118.38579370478, 5145.434002259748, 5348.197770334481, 5362.973185134088, 5366.597505187126, 5394.568434525228, 5491.176323551459, 5766.942330576682, 5779.913301300484, 5871.500922421599, 5876.647401155901, 5878.353381128072, 5765.538756899438, 5918.792842250544, 5924.081767326072, 5931.0, 5934.821955341346, 5452.40023597404, 5509.201165830972, 5595.992721310163, 5601.8599535011135, 5622.325320961429, 6087.634741915499, 6115.0, 6122.816315510542, 6126.479249263863, 6127.509799216052, 5607.327120745455, 5884.558658100659, 5890.3815099414805, 5892.793752218652, 5893.410658934073, 5729.427057294321, 5759.107338362561, 5824.650520968756, 5828.766849326064, 5894.469497745224, 5830.82507524775, 5832.096025116114, 5833.445822646841, 5833.67914764692, 5838.7080645967535, 5795.478406943395, 5859.912101318484, 5864.648121112747, 5865.0, 5879.5002424794375, 4457.665675074382, 4481.170983368087, 4498.640108791289, 4510.932336014962, 4568.543145685471, 4026.134381108076, 4047.9797601012397, 4052.452918855976, 4053.1691003344245, 4078.3678529827926, 5688.0, 5718.571107166979, 5719.685417302005, 5723.942760572341, 5742.942570574324, 5650.943490565124, 5705.087186050212, 5885.529157667376, 5922.851928701731, 5942.168096466498, 5587.552995760329, 5692.943070569324, 5696.458836410535, 5697.4587414195585, 5719.256496655408, 5190.714510701948, 5194.506521880416, 5200.817971370984, 5202.635815492879, 5226.947730522722, 5916.319623243382, 5967.492763115184, 6049.939500604937, 6096.664683442275, 6181.629102253879, 5957.255343082114, 5966.582339236212, 5973.522118230444, 5990.520758339409, 6008.759649614141, 6086.269647642134, 6105.9694701526205, 6159.969200153971, 6160.476359509492, 6163.3528479509005, 5664.405237450009, 5704.458076482728, 5735.512481438957, 5854.502367298827, 5861.9413805863105, 5843.357230704704, 5916.083007133901, 5936.22829032223, 5968.194293770285, 5971.104334349882, 5786.971065144648, 5786.971065144816, 5792.652440853562, 5793.246877905845, 5795.507381872588, 5639.238702775073, 5641.774329026793, 5787.826365209051, 5790.160426738184, 5793.478586927196, 5617.634853734494, 5682.516986056232, 5690.37405885344, 5698.487136157766, 5783.884322313615, 5777.422257774357, 5810.099434587646, 5814.098814683731, 5815.5929084963645, 5819.679917604403, 5469.589780766379, 5525.226468294361, 5623.8875222496135, 5673.461021202979, 5675.31896172462], "value": 5450.461248308602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1812140185841, 621.2079598511897, 629.5184184099163, 639.188230946698, 659.1661548141599, 34180.82909585452, 34770.65229347709, 46545.7672711636, 47869.52130478694, 47911.04177916448, 44569.108617827624, 48342.0, 48347.75826120865, 48351.51648483514, 48465.273020904715, 8438.367122465808, 9393.577289021994, 9526.09502097303, 9539.761505962337, 9551.474668893208, 8516.318694504425, 8807.0, 8818.0, 11100.167487438433, 11362.37506937118, 11482.425878706073, 11497.827532587018, 11540.307581545134, 11544.0, 11546.769064618702, 11398.886011139906, 11477.426128693533, 11489.0, 11491.023263022653, 11502.884971150264, 11208.327500350006, 11261.15541334395, 11267.436628168558, 11269.943650281779, 11283.943580282128, 44759.77620111879, 45004.0, 45048.09903801938, 45124.0, 45284.32073518867, 3830.898327719207, 3923.293807114718, 4120.546739858613, 4202.348635961431, 4639.443266807971, 33938.321233575436, 34057.82971085153, 34191.48712769311, 34219.486707699405, 34251.143721406916, 4752.263399173134, 4763.428388593391, 4830.879228019293, 4843.70937743733, 4891.046245981999, 348079.0, 348495.2575237133, 348936.0, 350185.0, 352515.0, 62534.37465625376, 62893.68553157296, 62916.370836291964, 62930.0, 62961.68519157375, 40487.392689109685, 41256.79371603123, 41456.0, 43729.56270437319, 65818.0, 19534.12096455663, 19750.802491974897, 19751.40745777629, 19757.110930008184, 19759.40721778349, 14724.55826325212, 14747.55757327282, 14788.92605536987, 14804.555863324118, 14805.111693298437, 18391.632167356576, 18828.341008064654, 18854.528636783914, 20214.797852021587, 20856.270030548858, 7284.49008569395, 7288.234735352818, 7394.408447324201, 7619.69521219145, 7780.766577002699, 987.7086259553305, 992.3549692699803, 1086.6468397770757, 1086.6685660873509, 1206.6018213989362, 33920.32159356799, 34077.82961085179, 34174.0, 34363.82818085943, 34753.478697819555, 1145.3585991844593, 1163.4473625028213, 1192.701824543864, 1203.6389083275158, 1243.4528807324748, 18172.182251798702, 18210.544736381697, 18271.54321141982, 18298.725519117223, 18303.81696183048, 521774.0, 529747.0, 530087.0, 531044.0, 531886.0, 63548.0, 64059.67970160119, 64145.0, 64168.67915660392, 64170.0, 1422.9217393043482, 1428.9071210371292, 1463.5024091808623, 1465.3625672832352, 1472.963175920589, 31138.532922005736, 33359.49960750542, 33479.49780753242, 33518.664813351555, 33974.49038264379, 55154.44845551493, 61060.69469652623, 62761.37238627555, 62764.68617656882, 68317.3168268311, 475333.0, 478086.0, 480924.0, 481732.0, 481950.0, 37271.25457490889, 40734.38898416585, 46683.53316466792, 46879.0, 47723.52276477191, 47439.0, 50997.0, 51058.234126488875, 51170.74414627903, 51441.485585143666, 43133.56866431421, 44335.11329773451, 44842.327365090205, 45085.77457112693, 46020.539794601624, 44093.77953110214, 44181.55818441774, 45786.31320530261, 45997.77001114973, 49150.75424622997, 44227.778861105486, 44336.334954976344, 44537.55462445334, 44927.775361122985, 45009.0, 36553.268934621694, 38963.415548767356, 39535.80232098821, 39834.0, 40120.79939600283, 29686.218826870456, 29756.10731678053, 29950.400991980474, 30253.243668908453, 30278.84860575683], "value": 21981.625030388885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.34478421036863, 421.9810108545115, 438.5548668101876, 439.27446338075003, 446.9307257375108, 16072.598185045379, 18855.774374665638, 21075.789242107556, 21132.89433552834, 21303.786962130373, 19885.3040143595, 20666.27668031619, 20696.689549656767, 20786.376408707725, 20982.05580748866, 5655.632383895034, 5711.657300561969, 5936.287645482548, 5943.791967281146, 5949.6727679977585, 5787.710614469281, 5826.747249341412, 5864.824055278327, 5878.970605146968, 5882.294124705041, 5794.449527294922, 5830.7084645767545, 5836.2996440427205, 5839.591228613998, 5843.2403787507565, 5939.910901336461, 6080.513558915321, 6089.117078023706, 6092.421219984094, 6092.939070609282, 5839.737211825478, 5860.062390017577, 5918.852028699274, 5940.465358117747, 5986.401359864022, 13503.66240843977, 13546.187228766306, 13625.795613065811, 13765.931170344184, 13767.0, 2157.52534442424, 2340.754220806825, 2429.137656132083, 2823.322402623376, 3030.1212648331957, 9698.224142068617, 10071.143952764023, 10263.332883362558, 10425.478726063666, 10559.0, 1818.6999145141035, 1850.1859181959894, 1966.8721533100302, 2005.5487515309085, 2017.5561376497146, 83472.58263708703, 86234.13765862324, 86544.56727716321, 88110.55944720235, 89744.0, 10752.623658172082, 11689.357085360387, 11834.349110798988, 11895.799277133758, 12276.263424194576, 14582.343794529059, 15482.458113965957, 15491.767623485657, 15498.84501154974, 16151.757723634155, 6750.257471678112, 8406.369522285853, 8880.378373513791, 8907.643694252158, 8952.68665596714, 8675.175858293453, 8771.561421928878, 8775.517346545874, 8916.465012099165, 8940.821183576421, 4743.739094349844, 4836.12949669063, 5262.684238945675, 5293.258943747878, 5308.708021058802, 1933.4296382567177, 1939.1177014458387, 1961.3135402608973, 1990.741203643517, 2038.1134206620168, 996.6113215845826, 996.6760802739138, 997.2072202598952, 1009.4195837393528, 1106.8948449897248, 19339.51651208703, 19935.501612459804, 19951.501212469804, 19983.900080499505, 20066.398008059783, 993.6621548673486, 1012.7366884610054, 1047.7904419116207, 1055.3562326980536, 1065.7815147894662, 10407.635732749317, 10788.514516846604, 10930.726731831768, 11318.886811131948, 11393.632764068365, 565084.0, 573461.0, 578472.0, 579539.0, 581292.0, 60022.39977600255, 98683.50658246662, 98830.0, 99447.50276248572, 99782.50108749409, 1055.883852776194, 1066.269605320358, 1102.393683474086, 1102.5424448853637, 1109.4175557832202, 17166.656666866344, 17318.31322899003, 17385.13074346303, 17515.3869614568, 17783.310585494357, 41777.58222417737, 42347.7882610585, 42996.14007719891, 43244.56755432405, 43538.782306088266, 59300.0, 60411.0, 62321.68839155775, 62544.0, 63655.3634463668, 8451.8732219018, 8537.957310213409, 8700.042995270642, 8716.520591367282, 8857.778555536162, 12275.815862761887, 13276.86723132795, 13277.535286264934, 13704.931475342959, 14061.226632535308, 10991.230613856953, 11910.642680719593, 12059.57791477294, 12102.152849300464, 12251.264924104582, 11164.0, 11166.106711463226, 11174.497147628213, 11410.543578256777, 11721.0, 11755.177137600285, 11813.822792657946, 11887.0, 11941.701457463285, 12405.565805196775, 7671.309582137635, 8108.9594552026865, 8144.75565733029, 8403.95798021006, 9184.908150918673, 8427.325813934993, 8508.149185081442, 8554.572271386281, 8985.326100542356, 9184.219341355792], "value": 9324.76145224193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.6180531256568, 1536.4852774320598, 1569.905805651661, 1741.43403393897, 1892.7255547945556, 8273.172682731723, 9228.584713687884, 9536.570854311556, 9552.61789528419, 9816.263780216477, 9586.856197157049, 9680.370775899562, 9685.128338449538, 9687.612495500189, 9694.709158725233, 2504.4114633061217, 2552.1960582416573, 2555.0418593027616, 2557.207265747615, 2557.360659835041, 2450.47314827313, 2515.3585835611893, 2526.1916186820226, 2528.216252961588, 2531.8227724059325, 2475.3687809608523, 2490.9377265568414, 2497.650328953948, 2499.6750422445057, 2502.8998840046374, 2387.3792813868345, 2406.590879550472, 2414.553307638084, 2466.4203912080648, 2469.444375015625, 2410.6384042393606, 2445.461998360358, 2454.8527088374753, 2455.2756936703713, 2460.188137914484, 9404.15362617361, 9477.336586438953, 9511.952440237823, 9564.330496865223, 9574.0, 5424.83725488236, 5607.831765047055, 5614.129809879434, 5702.714864256812, 5720.599558030939, 3602.9099272518133, 3621.94567081494, 3650.634936506328, 3652.853885844563, 3706.3513885070006, 1180.3803003423186, 1202.058675239482, 1235.975280494385, 1256.6167318967712, 1259.1815320041953, 12752.2986235757, 12766.61700148997, 12810.231386116862, 12818.871811281955, 12826.294553799537, 4628.652851036119, 4645.9303110453375, 4726.361941137971, 4776.259679749644, 4950.3069570260195, 10025.047620476043, 10042.895281519028, 10049.397036177706, 10057.346272492265, 10065.69802905914, 5534.529564987021, 5540.833774986757, 5541.251930989265, 5566.860828479321, 5587.580931430159, 4566.360709500673, 4699.483056863743, 5047.293378926953, 5160.40655324635, 5196.662216955886, 3995.400689896481, 3997.040710229582, 4032.052467670095, 4127.9174416512105, 4136.276151673445, 1210.0501106631427, 1221.3709939381226, 1227.2145826670937, 1234.919730217533, 1242.4781591731494, 949.3876449690049, 965.9468729219819, 978.6934442519316, 992.4194346307347, 1011.0445628880638, 6000.7899723510345, 6020.57855950088, 6023.066424704178, 6119.571629985859, 6194.81415557534, 493.56812788809793, 495.77690039482377, 506.65800584605245, 507.6345031577259, 507.70045673053073, 4208.784239108884, 4211.4525111735275, 4240.1519696060295, 4309.267424537836, 4374.825006999685, 11326.546938122548, 11781.469833857496, 11786.0, 11794.88205117955, 11807.940960295144, 11738.647840564796, 11744.530218791324, 11747.47136378865, 11760.764784704257, 11767.941160294144, 8260.421770476009, 8662.047174810767, 8747.0, 8828.735137945872, 8830.293576513863, 6156.815295541141, 6272.529560283088, 6373.7131829066875, 6393.1369265148605, 6459.418652321314, 10473.476326183812, 10709.410982396043, 10823.67528974132, 10834.241603088023, 10857.67426977192, 11014.1739369546, 11023.06303964172, 11099.0, 11120.555177792798, 11124.388158651353, 7706.614669266626, 7719.291291767384, 8212.384071194803, 8250.216229458192, 8346.666133354598, 9299.907000929905, 9327.347085703936, 9418.670346537838, 9422.670206542738, 9428.387154834914, 8016.679332826621, 8026.1171271158955, 8051.718189863327, 8258.25675689191, 8395.580220988804, 7921.287084162453, 7959.880601791094, 7973.561454120079, 8046.919530804851, 8280.378971577034, 7387.335139837441, 7398.778036658909, 7431.145418276968, 7531.284527969834, 7627.923720762721, 5218.765155568084, 5359.517643412111, 5363.704996225089, 5499.7250137492165, 5502.8349149525575, 5102.668326558762, 5113.335266415343, 5187.19598462239, 5276.15581506957, 5386.703731294817], "value": 4797.361111318596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.67291362809937, 339.1842618502501, 339.88274045454307, 348.21477568083975, 355.32842926868216, 5603.777827749041, 5631.18347839563, 5633.0, 5711.228984087147, 5726.942730572699, 5247.0, 5361.651492652974, 5407.161889907071, 5475.698836563987, 5529.25828364066, 4241.406203131564, 4262.339337402707, 4285.528591854893, 4302.311630139178, 4306.18182545317, 4277.593628605277, 4295.828166873322, 4300.720453170549, 4308.676849236304, 4335.718178318415, 4075.53131389891, 4269.765162916038, 4273.209456250588, 4297.35539669049, 4308.97845510772, 4278.679099067583, 4284.33592793116, 4285.500074973735, 4290.721103128287, 4293.914121717579, 3762.6989840812944, 3784.3944968805135, 3797.8290976906105, 3804.239152169577, 3811.9809400953095, 5275.762590683428, 5435.83692489226, 5467.840203119746, 5494.230807686927, 5536.2249285100115, 4892.853214403538, 4894.779734911902, 4914.311996320518, 4929.137400954819, 4933.28467372229, 5750.7412166452195, 5755.395683453219, 5785.27684039495, 5786.135862747967, 5817.709114544298, 4052.6352628263303, 4132.690048246363, 4149.232392007458, 4153.335466325373, 4180.268453020709, 6002.189704389895, 6020.247469066367, 6037.72830222641, 6044.244469441276, 6054.69726513677, 4240.427542281815, 4279.646194592961, 4290.721103128349, 4300.16146851361, 4306.763128027988, 4057.1885622875543, 4250.808713607895, 4250.85122020734, 4344.826206951687, 4346.630536404377, 4863.635227357962, 4874.7562621868765, 4877.463479017305, 4881.585065269421, 4895.657303988758, 5836.358000619928, 5851.853703657443, 5877.23595932526, 5879.853003674943, 5880.441358070976, 1472.2491529320123, 1487.2340744516582, 1500.932458039391, 1503.0831192972278, 1507.148461119464, 913.5706218077493, 929.5677509957767, 953.537534295866, 958.5686441101532, 965.0253244223245, 4998.9006815774455, 4999.375078115236, 5012.899742005139, 5035.173268316033, 5041.974790126099, 5223.634345595848, 5245.527902488718, 5267.657602255841, 5281.521174071267, 5288.624957511075, 4742.978402246541, 5007.749612519359, 5038.622103342191, 5049.949500505021, 5085.703145697823, 2804.6213761142394, 2808.4242730240253, 2816.957745633817, 2818.25316291183, 2829.2926768307925, 5388.649737767033, 5390.328998010629, 5410.864728381822, 5432.293801805819, 5450.182472629137, 5260.526552610283, 5301.867453313621, 5703.258576385127, 6162.476189523851, 6179.938200618026, 6218.787336469345, 6223.595466294676, 6227.532935029891, 6232.220972378453, 6263.959745963828, 5952.821415357546, 6021.187139736079, 6057.242844644419, 6064.363241859542, 6066.1507388966465, 5993.430624090704, 6004.819855404345, 6012.218411606463, 6016.5487588431915, 6021.066734656135, 6250.687465626609, 6262.405071518198, 6264.812055638338, 6266.373362663697, 6281.968590157203, 4037.656799172103, 4041.333180025263, 4199.370094485852, 4238.364245363096, 4286.528481867054, 5832.650040997553, 5855.121731740273, 5985.551083668655, 6025.548083893813, 6037.0, 5875.236219291465, 5876.206712093813, 5899.882002360015, 5901.970490147522, 5905.405540504125, 5755.769769209185, 5828.94171058284, 5866.096282340099, 5876.237128861239, 5899.292084949833, 5794.420557944172, 5809.564282678901, 5812.854678633068, 5815.331236907809, 5825.271841019872, 5800.622959507618, 5883.441073098049, 5926.614770039933, 5942.6731529766275, 5965.850853728692, 5753.280839895013, 5755.597108202385, 5766.711664416678, 5788.681622510802, 5829.183914252093], "value": 4357.883853345149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.2248879830962, 805.4764403137959, 848.1518481518477, 875.7504111328273, 884.7301573020229, 18347.44957651271, 19037.23851045958, 19188.328408505706, 19525.414237572895, 19731.704024439645, 17215.397461088865, 17566.912165439186, 17622.471325860213, 17716.557086072855, 17765.91117044416, 745.2473002267722, 875.829213303406, 901.9233365163936, 903.9141281578272, 904.4121321141278, 762.5805806806262, 842.616609442702, 857.3269983063296, 870.0255713600776, 874.9825003499926, 945.2721404518517, 946.7775072857872, 947.8578213267996, 947.9289053321029, 948.8434408322619, 937.7327461673425, 939.9154076133112, 941.0495399646338, 941.6092321686492, 942.9292803039765, 694.7950354645392, 696.1576492444149, 696.24109720405, 697.3514631392802, 697.4490152779298, 16526.173691315387, 16559.503214903572, 16576.17119144038, 16580.917095414567, 16612.335506579722, 14323.641908952255, 15326.540203793904, 15726.49572649575, 15911.443099491462, 16340.509784706477, 13105.0, 13211.735765284737, 13455.798163027563, 13587.660308492366, 13691.178529288174, 4055.878323650295, 4097.180563887235, 4123.0, 4194.454720886265, 4195.895102622429, 82453.58773206096, 85386.0, 88522.0, 90139.0, 90883.0, 12180.330081845406, 12257.570985015482, 12273.509059637692, 12299.139060265874, 12377.257364558156, 22956.426089347566, 23024.079036838673, 23162.3051308461, 23191.072357105862, 23690.526189476113, 9127.90872091284, 9285.907140928639, 9313.115254050854, 9363.4381937084, 9806.0, 5125.897482050338, 5217.817376391884, 5229.320188375563, 5273.288106105703, 5379.704116273642, 3637.5816781070516, 3750.3249415104997, 3753.0617345663586, 3753.5683396409217, 3754.4743735877, 581.2705055155837, 587.327510001055, 599.9070144127667, 600.5825950964038, 609.5245708347496, 731.9048523691886, 747.0885519665999, 748.8914107454498, 758.8478589295974, 766.7124828189429, 8989.775255618662, 9418.858717119248, 9476.194523465445, 9503.524823758922, 9576.952115239379, 636.0268788753215, 674.3795707948699, 747.8130467383154, 769.4306213402042, 792.6710415177637, 4340.891477713082, 4609.815607375667, 4625.722456652545, 4627.629789616823, 4712.5994290485005, 61480.385196147465, 61572.69213653903, 62785.0, 98425.50787246162, 102469.0, 96381.0, 96811.0, 97346.0, 98054.50972745233, 98266.5086674562, 80388.59805701052, 86631.56684216538, 89027.10972890317, 89349.0, 91044.08955910489, 9847.45838978863, 9909.405435673883, 10048.49757512136, 10151.0, 10156.0, 52206.738966304925, 52385.214221787464, 52768.472315276354, 53667.46332536625, 53936.73031634817, 71516.64241678758, 74235.0, 75872.62063689646, 77668.0, 77980.0, 12453.1905426147, 12598.748025039264, 13184.0, 13425.462981481021, 13578.25319607431, 14809.481668141563, 15029.248537573296, 15190.544283671508, 15212.619684507976, 16090.436834710728, 13894.930525347309, 14146.575602731935, 14538.41846326135, 14705.632359191106, 14780.33488492999, 13998.37007334652, 14040.297985100908, 14378.35297411598, 14398.568042958728, 14412.42350306018, 10713.732156696145, 13978.650533736738, 14001.229932353412, 14021.439142434188, 14290.714185716019, 10806.130829284653, 11267.323960562393, 11515.769684606428, 11842.82235766447, 12385.531592282725, 11252.66242012741, 11354.205205635857, 11495.436414711467, 11518.214676725122, 11939.582114625946], "value": 7920.686755601501, "unit": "score"}], "name": "dromaeo_css", "value": 7548.655112352121, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 118.0, 162.0, 118.0, 118.0, 117.0, 115.0, 146.0, 121.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 159.0, 161.0, 162.0, 163.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 75.0, 75.0, 79.0, 76.0, 103.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 120.0, 82.0, 81.0, 81.0, 100.0, 81.0, 81.0, 102.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 119.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 144.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 49.0, 50.0, 54.0, 50.0, 49.0, 50.0, 49.0, 48.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 79.0, 75.0, 82.0, 74.0, 74.0, 76.0, 73.0, 73.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 124.0, 124.0, 120.0, 120.0, 118.0, 119.0, 160.0, 121.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 154.0, 157.0, 157.0, 155.0, 157.0, 159.0, 154.0, 157.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 63.0, 63.0, 61.0, 66.0, 62.0, 63.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1458.3999999999999, "alertThreshold": 2.0}]} 21:55:27 INFO - Return code: 0 21:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:27 INFO - # TBPL SUCCESS # 21:55:27 INFO - Running post-action listener: _resource_record_post_action 21:55:27 INFO - [mozharness: 2017-01-02 05:55:27.740625Z] Finished run-tests step (success) 21:55:27 INFO - Running post-run listener: _resource_record_post_run 21:55:27 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 330235904; Read time: 56; Write time: 300684 21:55:27 INFO - TinderboxPrint: CPU usage
13.0% 21:55:27 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 56 21:55:27 INFO - TinderboxPrint: I/O write bytes / time
330,235,904 / 300,684 21:55:27 INFO - TinderboxPrint: CPU idle
8,248.4 (87.0%) 21:55:27 INFO - TinderboxPrint: CPU user
1,183.7 (12.5%) 21:55:27 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:27 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 111906816; Read time: 0; Write time: 88268 21:55:27 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218329088; Read time: 12; Write time: 212416 21:55:28 INFO - Running post-run listener: _upload_blobber_files 21:55:28 INFO - Blob upload gear active. 21:55:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:28 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 21:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:55:28 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:32 INFO - (blobuploader) - INFO - Done attempting. 21:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:32 INFO - (blobuploader) - INFO - Done attempting. 21:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:33 INFO - (blobuploader) - INFO - Done attempting. 21:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:33 INFO - Return code: 0 21:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1327397b6403ed45caea5a774fd3a112a63821eabb912546fe72b308573126a67f3d7e07e7dff1ec83449178afdc04e6f92f7d1b3558274408fd09813d31c34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0735302db4bcad9297b1a20b91cfccd7065553d37c28d76fe0b6f8ae440168522c9fa5e08a731e22643054ee70adf5747c3be41f95e3755e11c2af088295d2e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3ab6b8f9a295657ae93b79df038ba327027f353876648e776e1136848275787a2ee885c14887c603586986755f1394061c791e35478856635af0994c8b2829b"} 21:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:33 INFO - Contents: 21:55:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1327397b6403ed45caea5a774fd3a112a63821eabb912546fe72b308573126a67f3d7e07e7dff1ec83449178afdc04e6f92f7d1b3558274408fd09813d31c34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0735302db4bcad9297b1a20b91cfccd7065553d37c28d76fe0b6f8ae440168522c9fa5e08a731e22643054ee70adf5747c3be41f95e3755e11c2af088295d2e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3ab6b8f9a295657ae93b79df038ba327027f353876648e776e1136848275787a2ee885c14887c603586986755f1394061c791e35478856635af0994c8b2829b"} 21:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:33 INFO - Copying logs to upload dir... 21:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.452885 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-01 21:55:32.968092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 21:55:32.972452) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1327397b6403ed45caea5a774fd3a112a63821eabb912546fe72b308573126a67f3d7e07e7dff1ec83449178afdc04e6f92f7d1b3558274408fd09813d31c34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0735302db4bcad9297b1a20b91cfccd7065553d37c28d76fe0b6f8ae440168522c9fa5e08a731e22643054ee70adf5747c3be41f95e3755e11c2af088295d2e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3ab6b8f9a295657ae93b79df038ba327027f353876648e776e1136848275787a2ee885c14887c603586986755f1394061c791e35478856635af0994c8b2829b"} build_url:https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/CsWiaUIPRPK4km1EMNhWGA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1327397b6403ed45caea5a774fd3a112a63821eabb912546fe72b308573126a67f3d7e07e7dff1ec83449178afdc04e6f92f7d1b3558274408fd09813d31c34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0735302db4bcad9297b1a20b91cfccd7065553d37c28d76fe0b6f8ae440168522c9fa5e08a731e22643054ee70adf5747c3be41f95e3755e11c2af088295d2e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3ab6b8f9a295657ae93b79df038ba327027f353876648e776e1136848275787a2ee885c14887c603586986755f1394061c791e35478856635af0994c8b2829b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 21:55:33.000638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:55:33.000991) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483330585.932616-823044340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:55:33.081785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 21:55:33.085137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 21:55:33.085455) ========= ========= Total master_lag: 0.30 =========