builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1481137012.78 results: success (0) buildid: 20161207100538 builduid: 4ad56b52626b46bbacf5b489285c9b25 revision: 11ab9642165eab2b6e38e495d7d003347ef99ba0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.777563) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.778000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.778287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.797258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.797606) ========= 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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 10:56:53-- 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% 65.2M=0s 2016-12-07 10:56:53 (65.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.918766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.919127) ========= 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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:52.970793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 10:56:52.971234) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 11ab9642165eab2b6e38e495d7d003347ef99ba0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 11ab9642165eab2b6e38e495d7d003347ef99ba0 --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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 10:56:53,488 truncating revision to first 12 chars 2016-12-07 10:56:53,488 Setting DEBUG logging. 2016-12-07 10:56:53,488 attempt 1/10 2016-12-07 10:56:53,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/11ab9642165e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 10:56:54,703 unpacking tar archive at: graphics-11ab9642165e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 10:56:54.567618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:54.568025) ========= script_repo_revision: 11ab9642165eab2b6e38e495d7d003347ef99ba0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:54.568604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:54.569328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 10:56:54.578675) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-07 10:56:54.578986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:55 INFO - MultiFileLogger online at 20161207 10:56:55 in /builds/slave/test 10:56:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 10:56:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:55 INFO - {'append_to_log': False, 10:56:55 INFO - 'base_work_dir': '/builds/slave/test', 10:56:55 INFO - 'blob_upload_branch': 'Graphics', 10:56:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:55 INFO - 'branch': 'Graphics', 10:56:55 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:55 INFO - 'config_files': ('talos/linux_config.py',), 10:56:55 INFO - 'default_actions': ('clobber', 10:56:55 INFO - 'read-buildbot-config', 10:56:55 INFO - 'download-and-extract', 10:56:55 INFO - 'populate-webroot', 10:56:55 INFO - 'create-virtualenv', 10:56:55 INFO - 'install', 10:56:55 INFO - 'run-tests'), 10:56:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:55 INFO - 'download_minidump_stackwalk': True, 10:56:55 INFO - 'download_symbols': 'ondemand', 10:56:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:55 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:55 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:55 INFO - 'installer_path': 'installer.exe', 10:56:55 INFO - 'log_level': 'info', 10:56:55 INFO - 'log_name': 'talos', 10:56:55 INFO - 'log_to_console': True, 10:56:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:55 INFO - 'opt_config_files': (), 10:56:55 INFO - 'pip_index': False, 10:56:55 INFO - 'sps_profile': False, 10:56:55 INFO - 'sps_profile_interval': 0, 10:56:55 INFO - 'suite': 'dromaeojs', 10:56:55 INFO - 'system_bits': '32', 10:56:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:55 INFO - 'title': 'talos-linux64-ix-036', 10:56:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:55 INFO - 'use_talos_json': True, 10:56:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:55 INFO - 'work_dir': 'build'} 10:56:55 INFO - [mozharness: 2016-12-07 18:56:55.196600Z] Running clobber step. 10:56:55 INFO - Running pre-action listener: _resource_record_pre_action 10:56:55 INFO - Running main action method: clobber 10:56:55 INFO - rmtree: /builds/slave/test/build 10:56:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:55 INFO - Running post-action listener: _resource_record_post_action 10:56:55 INFO - [mozharness: 2016-12-07 18:56:55.662925Z] Finished clobber step (success) 10:56:55 INFO - [mozharness: 2016-12-07 18:56:55.663023Z] Running read-buildbot-config step. 10:56:55 INFO - Running pre-action listener: _resource_record_pre_action 10:56:55 INFO - Running main action method: read_buildbot_config 10:56:55 INFO - Using buildbot properties: 10:56:55 INFO - { 10:56:55 INFO - "project": "", 10:56:55 INFO - "product": "firefox", 10:56:55 INFO - "script_repo_revision": "default", 10:56:55 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 10:56:55 INFO - "repository": "", 10:56:55 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 10:56:55 INFO - "buildid": "20161207100538", 10:56:55 INFO - "pgo_build": "False", 10:56:55 INFO - "basedir": "/builds/slave/test", 10:56:55 INFO - "buildnumber": 23, 10:56:55 INFO - "slavename": "talos-linux64-ix-036", 10:56:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:56:55 INFO - "platform": "ubuntu64_hw", 10:56:55 INFO - "scheduler": "tests-graphics-linux64-talos", 10:56:55 INFO - "branch": "graphics", 10:56:55 INFO - "repo_path": "projects/graphics", 10:56:55 INFO - "revision": "11ab9642165eab2b6e38e495d7d003347ef99ba0", 10:56:55 INFO - "stage_platform": "linux64", 10:56:55 INFO - "builduid": "4ad56b52626b46bbacf5b489285c9b25", 10:56:55 INFO - "slavebuilddir": "test" 10:56:55 INFO - } 10:56:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:56:55 INFO - Running post-action listener: _resource_record_post_action 10:56:55 INFO - [mozharness: 2016-12-07 18:56:55.665440Z] Finished read-buildbot-config step (success) 10:56:55 INFO - [mozharness: 2016-12-07 18:56:55.665528Z] Running download-and-extract step. 10:56:55 INFO - Running pre-action listener: _resource_record_pre_action 10:56:55 INFO - Running main action method: download_and_extract 10:56:55 INFO - mkdir: /builds/slave/test/build/tests 10:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:55 INFO - trying https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:56:56 INFO - Downloaded 1361 bytes. 10:56:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:56:56 INFO - Using the following test package requirements: 10:56:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:56:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'jsshell-linux-x86_64.zip'], 10:56:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:56:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:56:57 INFO - Expected file size: 20218977 10:56:57 INFO - Obtained file size: 20218977 10:57:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:57:01 INFO - Expected file size: 20218977 10:57:01 INFO - Obtained file size: 20218977 10:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:57:07 INFO - Expected file size: 14409734 10:57:07 INFO - Obtained file size: 14409734 10:57:08 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')]} 10:57:08 INFO - trying https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:57:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:57:10 INFO - Downloaded 55718670 bytes. 10:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:57:10 INFO - mkdir: /builds/slave/test/properties 10:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:10 INFO - Contents: 10:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:57:11 INFO - Running post-action listener: _resource_record_post_action 10:57:11 INFO - Running post-action listener: set_extra_try_arguments 10:57:11 INFO - [mozharness: 2016-12-07 18:57:11.678181Z] Finished download-and-extract step (success) 10:57:11 INFO - [mozharness: 2016-12-07 18:57:11.678407Z] Running populate-webroot step. 10:57:11 INFO - Running pre-action listener: _resource_record_pre_action 10:57:11 INFO - Running main action method: populate_webroot 10:57:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:11 INFO - '--tppagecycles', 10:57:11 INFO - '7'], 10:57:11 INFO - 'tests': ['tsvgm']}}, 10:57:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:57:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:57:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['damp', 'tps']}, 10:57:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'tests': ['damp', 'tps']}, 10:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['dromaeo_dom']}, 10:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['basic_compositor_video']}, 10:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['a11yr', 10:57:11 INFO - 'ts_paint', 10:57:11 INFO - 'tpaint', 10:57:11 INFO - 'sessionrestore', 10:57:11 INFO - 'sessionrestore_no_auto_restore', 10:57:11 INFO - 'tabpaint']}, 10:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['tsvgx', 10:57:11 INFO - 'tsvgr_opacity', 10:57:11 INFO - 'tart', 10:57:11 INFO - 'tscrollx', 10:57:11 INFO - 'cart', 10:57:11 INFO - 'tsvg_static']}, 10:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:57:11 INFO - 'tsvgr_opacity', 10:57:11 INFO - 'tart', 10:57:11 INFO - 'tscrollx', 10:57:11 INFO - 'cart', 10:57:11 INFO - 'tsvg_static']}, 10:57:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'talos_options': ['--disable-e10s'], 10:57:11 INFO - 'tests': ['tp5o']}, 10:57:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:57:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'talos_options': ['--disable-e10s', 10:57:11 INFO - '--xperf_path', 10:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:11 INFO - 'tests': ['tp5n']}, 10:57:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:57:11 INFO - 'talos_options': ['--xperf_path', 10:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:11 INFO - 'tests': ['tp5n']}}, 10:57:11 INFO - 'talos.zip': {'path': '', 10:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:11 INFO - Running post-action listener: _resource_record_post_action 10:57:11 INFO - [mozharness: 2016-12-07 18:57:11.693537Z] Finished populate-webroot step (success) 10:57:11 INFO - [mozharness: 2016-12-07 18:57:11.693624Z] Running create-virtualenv step. 10:57:11 INFO - Running pre-action listener: _resource_record_pre_action 10:57:11 INFO - Running main action method: create_virtualenv 10:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:11 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 10:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:11 INFO - Using real prefix '/usr' 10:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:14 INFO - Installing pip.................done. 10:57:14 INFO - Return code: 0 10:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:57:14 INFO - Reading from file tmpfile_stdout 10:57:14 INFO - Output received: 10:57:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57:14 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')]} 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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')]} 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:14 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 10:57:14 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 10:57:14 INFO - Using env: {'DISPLAY': ':0', 10:57:14 INFO - 'HOME': '/home/cltbld', 10:57:14 INFO - 'LANG': 'en_US.UTF-8', 10:57:14 INFO - 'LANGUAGE': 'en_US:en', 10:57:14 INFO - 'LOGNAME': 'cltbld', 10:57:14 INFO - 'MAIL': '/var/mail/cltbld', 10:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:14 INFO - 'MOZ_NO_REMOTE': '1', 10:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:14 INFO - 'NO_EM_RESTART': '1', 10:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:14 INFO - 'PWD': '/builds/slave/test', 10:57:14 INFO - 'SHELL': '/bin/bash', 10:57:14 INFO - 'SHLVL': '1', 10:57:14 INFO - 'TERM': 'linux', 10:57:14 INFO - 'TMOUT': '86400', 10:57:14 INFO - 'USER': 'cltbld', 10:57:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:14 INFO - '_': '/tools/buildbot/bin/python'} 10:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:14 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 10:57:14 INFO - Cleaning up... 10:57:14 INFO - Return code: 0 10:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:57:14 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')]} 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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')]} 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:14 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 10:57:14 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 10:57:14 INFO - Using env: {'DISPLAY': ':0', 10:57:14 INFO - 'HOME': '/home/cltbld', 10:57:14 INFO - 'LANG': 'en_US.UTF-8', 10:57:14 INFO - 'LANGUAGE': 'en_US:en', 10:57:14 INFO - 'LOGNAME': 'cltbld', 10:57:14 INFO - 'MAIL': '/var/mail/cltbld', 10:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:14 INFO - 'MOZ_NO_REMOTE': '1', 10:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:14 INFO - 'NO_EM_RESTART': '1', 10:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:14 INFO - 'PWD': '/builds/slave/test', 10:57:14 INFO - 'SHELL': '/bin/bash', 10:57:14 INFO - 'SHLVL': '1', 10:57:14 INFO - 'TERM': 'linux', 10:57:14 INFO - 'TMOUT': '86400', 10:57:14 INFO - 'USER': 'cltbld', 10:57:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:14 INFO - '_': '/tools/buildbot/bin/python'} 10:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:14 INFO - Downloading/unpacking psutil>=3.1.1 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:16 INFO - Installing collected packages: psutil 10:57:16 INFO - Running setup.py install for psutil 10:57:17 INFO - building 'psutil._psutil_linux' extension 10:57:17 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 10:57:17 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 10:57:17 INFO - building 'psutil._psutil_posix' extension 10:57:17 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 10:57:17 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 10:57:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:17 INFO - Successfully installed psutil 10:57:17 INFO - Cleaning up... 10:57:17 INFO - Return code: 0 10:57:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:57:17 INFO - Using env: {'DISPLAY': ':0', 10:57:17 INFO - 'HOME': '/home/cltbld', 10:57:17 INFO - 'LANG': 'en_US.UTF-8', 10:57:17 INFO - 'LANGUAGE': 'en_US:en', 10:57:17 INFO - 'LOGNAME': 'cltbld', 10:57:17 INFO - 'MAIL': '/var/mail/cltbld', 10:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:17 INFO - 'MOZ_NO_REMOTE': '1', 10:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:17 INFO - 'NO_EM_RESTART': '1', 10:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:17 INFO - 'PWD': '/builds/slave/test', 10:57:17 INFO - 'SHELL': '/bin/bash', 10:57:17 INFO - 'SHLVL': '1', 10:57:17 INFO - 'TERM': 'linux', 10:57:17 INFO - 'TMOUT': '86400', 10:57:17 INFO - 'USER': 'cltbld', 10:57:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:17 INFO - '_': '/tools/buildbot/bin/python'} 10:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:57:19 INFO - Installing collected packages: mozsystemmonitor 10:57:19 INFO - Running setup.py install for mozsystemmonitor 10:57:19 INFO - Successfully installed mozsystemmonitor 10:57:19 INFO - Cleaning up... 10:57:19 INFO - Return code: 0 10:57:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:57:19 INFO - Using env: {'DISPLAY': ':0', 10:57:19 INFO - 'HOME': '/home/cltbld', 10:57:19 INFO - 'LANG': 'en_US.UTF-8', 10:57:19 INFO - 'LANGUAGE': 'en_US:en', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MAIL': '/var/mail/cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SHLVL': '1', 10:57:19 INFO - 'TERM': 'linux', 10:57:19 INFO - 'TMOUT': '86400', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - '_': '/tools/buildbot/bin/python'} 10:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:20 INFO - Downloading/unpacking jsonschema==2.5.1 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:22 INFO - warning: no files found matching '*.txt' 10:57:22 INFO - no previously-included directories found matching 'build' 10:57:22 INFO - no previously-included directories found matching 'dist' 10:57:22 INFO - no previously-included directories found matching '.git*' 10:57:22 INFO - Installing collected packages: jsonschema, functools32 10:57:22 INFO - Running setup.py install for functools32 10:57:22 INFO - warning: no files found matching '*.txt' 10:57:22 INFO - no previously-included directories found matching 'build' 10:57:22 INFO - no previously-included directories found matching 'dist' 10:57:22 INFO - no previously-included directories found matching '.git*' 10:57:22 INFO - Successfully installed jsonschema functools32 10:57:22 INFO - Cleaning up... 10:57:22 INFO - Return code: 0 10:57:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:57:22 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')]} 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 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')]} 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:22 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 10:57:22 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 10:57:22 INFO - Using env: {'DISPLAY': ':0', 10:57:22 INFO - 'HOME': '/home/cltbld', 10:57:22 INFO - 'LANG': 'en_US.UTF-8', 10:57:22 INFO - 'LANGUAGE': 'en_US:en', 10:57:22 INFO - 'LOGNAME': 'cltbld', 10:57:22 INFO - 'MAIL': '/var/mail/cltbld', 10:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:22 INFO - 'MOZ_NO_REMOTE': '1', 10:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:22 INFO - 'NO_EM_RESTART': '1', 10:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:22 INFO - 'PWD': '/builds/slave/test', 10:57:22 INFO - 'SHELL': '/bin/bash', 10:57:22 INFO - 'SHLVL': '1', 10:57:22 INFO - 'TERM': 'linux', 10:57:22 INFO - 'TMOUT': '86400', 10:57:22 INFO - 'USER': 'cltbld', 10:57:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:22 INFO - '_': '/tools/buildbot/bin/python'} 10:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:57:22 INFO - Cleaning up... 10:57:22 INFO - Return code: 0 10:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:22 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')]} 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 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')]} 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:22 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 10:57:22 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 10:57:22 INFO - Using env: {'DISPLAY': ':0', 10:57:22 INFO - 'HOME': '/home/cltbld', 10:57:22 INFO - 'LANG': 'en_US.UTF-8', 10:57:22 INFO - 'LANGUAGE': 'en_US:en', 10:57:22 INFO - 'LOGNAME': 'cltbld', 10:57:22 INFO - 'MAIL': '/var/mail/cltbld', 10:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:22 INFO - 'MOZ_NO_REMOTE': '1', 10:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:22 INFO - 'NO_EM_RESTART': '1', 10:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:22 INFO - 'PWD': '/builds/slave/test', 10:57:22 INFO - 'SHELL': '/bin/bash', 10:57:22 INFO - 'SHLVL': '1', 10:57:22 INFO - 'TERM': 'linux', 10:57:22 INFO - 'TMOUT': '86400', 10:57:22 INFO - 'USER': 'cltbld', 10:57:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:22 INFO - '_': '/tools/buildbot/bin/python'} 10:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:25 INFO - Downloading docopt-0.6.1.tar.gz 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:25 INFO - Running setup.py install for blobuploader 10:57:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:25 INFO - Running setup.py install for requests 10:57:26 INFO - Running setup.py install for docopt 10:57:26 INFO - Successfully installed blobuploader requests docopt 10:57:26 INFO - Cleaning up... 10:57:26 INFO - Return code: 0 10:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:26 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')]} 10:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 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')]} 10:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:26 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 10:57:26 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 10:57:26 INFO - Using env: {'DISPLAY': ':0', 10:57:26 INFO - 'HOME': '/home/cltbld', 10:57:26 INFO - 'LANG': 'en_US.UTF-8', 10:57:26 INFO - 'LANGUAGE': 'en_US:en', 10:57:26 INFO - 'LOGNAME': 'cltbld', 10:57:26 INFO - 'MAIL': '/var/mail/cltbld', 10:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:26 INFO - 'MOZ_NO_REMOTE': '1', 10:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:26 INFO - 'NO_EM_RESTART': '1', 10:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:26 INFO - 'PWD': '/builds/slave/test', 10:57:26 INFO - 'SHELL': '/bin/bash', 10:57:26 INFO - 'SHLVL': '1', 10:57:26 INFO - 'TERM': 'linux', 10:57:26 INFO - 'TMOUT': '86400', 10:57:26 INFO - 'USER': 'cltbld', 10:57:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:26 INFO - '_': '/tools/buildbot/bin/python'} 10:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:26 INFO - Running setup.py (path:/tmp/pip-1tjuaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:26 INFO - Running setup.py (path:/tmp/pip-et6xcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:26 INFO - Running setup.py (path:/tmp/pip-1cn5bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:26 INFO - Running setup.py (path:/tmp/pip-wrmPUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:26 INFO - Running setup.py (path:/tmp/pip-w6W4f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:26 INFO - Running setup.py (path:/tmp/pip-JhwRSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:27 INFO - Running setup.py (path:/tmp/pip-jBrx9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:27 INFO - Running setup.py (path:/tmp/pip-uGZxLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:27 INFO - Running setup.py (path:/tmp/pip-cxfaxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:27 INFO - Running setup.py (path:/tmp/pip-xLBDGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:27 INFO - Running setup.py (path:/tmp/pip-Z7LieQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:27 INFO - Running setup.py (path:/tmp/pip-vKpw4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:27 INFO - Running setup.py (path:/tmp/pip-nnjJ6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:27 INFO - Running setup.py (path:/tmp/pip-rk_iKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:27 INFO - Running setup.py (path:/tmp/pip-P2WvQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:27 INFO - Running setup.py (path:/tmp/pip-BIMfe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:27 INFO - Running setup.py (path:/tmp/pip-1eGGxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:27 INFO - Running setup.py install for manifestparser 10:57:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:27 INFO - Running setup.py install for mozcrash 10:57:28 INFO - Running setup.py install for mozdebug 10:57:28 INFO - Running setup.py install for mozdevice 10:57:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Running setup.py install for mozfile 10:57:28 INFO - Running setup.py install for mozhttpd 10:57:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Running setup.py install for mozinfo 10:57:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Running setup.py install for mozInstall 10:57:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Running setup.py install for mozleak 10:57:28 INFO - Running setup.py install for mozlog 10:57:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:28 INFO - Running setup.py install for moznetwork 10:57:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Running setup.py install for mozprocess 10:57:29 INFO - Running setup.py install for mozprofile 10:57:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Running setup.py install for mozrunner 10:57:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Running setup.py install for mozscreenshot 10:57:29 INFO - Running setup.py install for moztest 10:57:29 INFO - Running setup.py install for mozversion 10:57:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:29 INFO - Cleaning up... 10:57:29 INFO - Return code: 0 10:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:29 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')]} 10:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:29 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')]} 10:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:29 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:29 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 10:57:29 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 10:57:29 INFO - Using env: {'DISPLAY': ':0', 10:57:29 INFO - 'HOME': '/home/cltbld', 10:57:29 INFO - 'LANG': 'en_US.UTF-8', 10:57:29 INFO - 'LANGUAGE': 'en_US:en', 10:57:29 INFO - 'LOGNAME': 'cltbld', 10:57:29 INFO - 'MAIL': '/var/mail/cltbld', 10:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:29 INFO - 'MOZ_NO_REMOTE': '1', 10:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:29 INFO - 'NO_EM_RESTART': '1', 10:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:29 INFO - 'PWD': '/builds/slave/test', 10:57:29 INFO - 'SHELL': '/bin/bash', 10:57:29 INFO - 'SHLVL': '1', 10:57:29 INFO - 'TERM': 'linux', 10:57:29 INFO - 'TMOUT': '86400', 10:57:29 INFO - 'USER': 'cltbld', 10:57:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:29 INFO - '_': '/tools/buildbot/bin/python'} 10:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:29 INFO - Running setup.py (path:/tmp/pip-rvcQt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:29 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)) 10:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:29 INFO - Running setup.py (path:/tmp/pip-UckYAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:30 INFO - Running setup.py (path:/tmp/pip-vhVTuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:30 INFO - Running setup.py (path:/tmp/pip-1hhrv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:30 INFO - Running setup.py (path:/tmp/pip-a3VcCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:30 INFO - Running setup.py (path:/tmp/pip-8E0at5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:30 INFO - Running setup.py (path:/tmp/pip-B7sWfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:30 INFO - Running setup.py (path:/tmp/pip-OW1JtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:30 INFO - Running setup.py (path:/tmp/pip-PFmlmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:30 INFO - Running setup.py (path:/tmp/pip-EnHvZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:30 INFO - Running setup.py (path:/tmp/pip-Wtelqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:30 INFO - Running setup.py (path:/tmp/pip-bpiAD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:30 INFO - Running setup.py (path:/tmp/pip-z2uQlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:30 INFO - Running setup.py (path:/tmp/pip-4Vd4UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:30 INFO - Running setup.py (path:/tmp/pip-ewBFKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:30 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)) 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:31 INFO - Running setup.py (path:/tmp/pip-TRaxR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:31 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)) 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:31 INFO - Running setup.py (path:/tmp/pip-DGdIqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:31 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)) 10:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:31 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)) 10:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:33 INFO - Downloading blessings-1.6.tar.gz 10:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:33 INFO - Installing collected packages: blessings 10:57:33 INFO - Running setup.py install for blessings 10:57:33 INFO - Successfully installed blessings 10:57:33 INFO - Cleaning up... 10:57:33 INFO - Return code: 0 10:57:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:33 INFO - Reading from file tmpfile_stdout 10:57:33 INFO - Current package versions: 10:57:33 INFO - argparse == 1.2.1 10:57:33 INFO - blessings == 1.6 10:57:33 INFO - blobuploader == 1.2.4 10:57:33 INFO - docopt == 0.6.1 10:57:33 INFO - functools32 == 3.2.3-2 10:57:33 INFO - jsonschema == 2.5.1 10:57:33 INFO - manifestparser == 1.1 10:57:33 INFO - mozInstall == 1.12 10:57:33 INFO - mozcrash == 1.0 10:57:33 INFO - mozdebug == 0.1 10:57:33 INFO - mozdevice == 0.49 10:57:33 INFO - mozfile == 1.2 10:57:33 INFO - mozhttpd == 0.7 10:57:33 INFO - mozinfo == 0.9 10:57:33 INFO - mozleak == 0.1 10:57:33 INFO - mozlog == 3.4 10:57:33 INFO - moznetwork == 0.27 10:57:33 INFO - mozprocess == 0.23 10:57:33 INFO - mozprofile == 0.28 10:57:33 INFO - mozrunner == 6.13 10:57:33 INFO - mozscreenshot == 0.1 10:57:33 INFO - mozsystemmonitor == 0.3 10:57:33 INFO - moztest == 0.7 10:57:33 INFO - mozversion == 1.4 10:57:33 INFO - psutil == 3.1.1 10:57:33 INFO - requests == 1.2.3 10:57:33 INFO - wsgiref == 0.1.2 10:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:33 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')]} 10:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:33 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')]} 10:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:33 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:33 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 10:57:33 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 10:57:33 INFO - Using env: {'DISPLAY': ':0', 10:57:33 INFO - 'HOME': '/home/cltbld', 10:57:33 INFO - 'LANG': 'en_US.UTF-8', 10:57:33 INFO - 'LANGUAGE': 'en_US:en', 10:57:33 INFO - 'LOGNAME': 'cltbld', 10:57:33 INFO - 'MAIL': '/var/mail/cltbld', 10:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:33 INFO - 'MOZ_NO_REMOTE': '1', 10:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:33 INFO - 'NO_EM_RESTART': '1', 10:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:33 INFO - 'PWD': '/builds/slave/test', 10:57:33 INFO - 'SHELL': '/bin/bash', 10:57:33 INFO - 'SHLVL': '1', 10:57:33 INFO - 'TERM': 'linux', 10:57:33 INFO - 'TMOUT': '86400', 10:57:33 INFO - 'USER': 'cltbld', 10:57:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:33 INFO - '_': '/tools/buildbot/bin/python'} 10:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 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)) 10:57:33 INFO - Cleaning up... 10:57:33 INFO - Return code: 0 10:57:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:33 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')]} 10:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:33 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')]} 10:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:33 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 0x7fb7f6161e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', '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 10:57:33 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 10:57:33 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 10:57:33 INFO - Using env: {'DISPLAY': ':0', 10:57:33 INFO - 'HOME': '/home/cltbld', 10:57:33 INFO - 'LANG': 'en_US.UTF-8', 10:57:33 INFO - 'LANGUAGE': 'en_US:en', 10:57:33 INFO - 'LOGNAME': 'cltbld', 10:57:33 INFO - 'MAIL': '/var/mail/cltbld', 10:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:33 INFO - 'MOZ_NO_REMOTE': '1', 10:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:33 INFO - 'NO_EM_RESTART': '1', 10:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:33 INFO - 'PWD': '/builds/slave/test', 10:57:33 INFO - 'SHELL': '/bin/bash', 10:57:33 INFO - 'SHLVL': '1', 10:57:33 INFO - 'TERM': 'linux', 10:57:33 INFO - 'TMOUT': '86400', 10:57:33 INFO - 'USER': 'cltbld', 10:57:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:33 INFO - '_': '/tools/buildbot/bin/python'} 10:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:57:34 INFO - Cleaning up... 10:57:34 INFO - Return code: 0 10:57:34 INFO - Running post-action listener: _resource_record_post_action 10:57:34 INFO - Running post-action listener: _start_resource_monitoring 10:57:34 INFO - Starting resource monitoring. 10:57:34 INFO - [mozharness: 2016-12-07 18:57:34.115289Z] Finished create-virtualenv step (success) 10:57:34 INFO - [mozharness: 2016-12-07 18:57:34.115807Z] Running install step. 10:57:34 INFO - Running pre-action listener: _resource_record_pre_action 10:57:34 INFO - Running main action method: install 10:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:34 INFO - Reading from file tmpfile_stdout 10:57:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:34 INFO - Reading from file tmpfile_stdout 10:57:34 INFO - Output received: 10:57:34 INFO - Usage: mozinstall [options] installer 10:57:34 INFO - Options: 10:57:34 INFO - -h, --help show this help message and exit 10:57:34 INFO - -d DEST, --destination=DEST 10:57:34 INFO - Directory to install application into. [default: 10:57:34 INFO - "/builds/slave/test"] 10:57:34 INFO - --app=APP Application being installed. [default: firefox] 10:57:34 INFO - mkdir: /builds/slave/test/build/application 10:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:57:51 INFO - Reading from file tmpfile_stdout 10:57:51 INFO - Output received: 10:57:51 INFO - /builds/slave/test/build/application/firefox/firefox 10:57:51 INFO - Running post-action listener: _resource_record_post_action 10:57:51 INFO - [mozharness: 2016-12-07 18:57:51.034679Z] Finished install step (success) 10:57:51 INFO - [mozharness: 2016-12-07 18:57:51.034921Z] Running run-tests step. 10:57:51 INFO - Running pre-action listener: _resource_record_pre_action 10:57:51 INFO - Running main action method: run_tests 10:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:51 INFO - Python 2.7.3 10:57:51 INFO - Return code: 0 10:57:51 INFO - grabbing minidump binary from tooltool 10:57:51 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')]} 10:57:51 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 0x12baf20>, '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 0x1227c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:51 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 10:57:51 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 10:57:51 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 10:57:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:51 INFO - Return code: 0 10:57:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:57:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:57:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 10:57:51 INFO - Using env: {'DISPLAY': ':0', 10:57:51 INFO - 'HOME': '/home/cltbld', 10:57:51 INFO - 'LANG': 'en_US.UTF-8', 10:57:51 INFO - 'LANGUAGE': 'en_US:en', 10:57:51 INFO - 'LOGNAME': 'cltbld', 10:57:51 INFO - 'MAIL': '/var/mail/cltbld', 10:57:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:51 INFO - 'MOZ_NO_REMOTE': '1', 10:57:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:51 INFO - 'NO_EM_RESTART': '1', 10:57:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:51 INFO - 'PWD': '/builds/slave/test', 10:57:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:51 INFO - 'SHELL': '/bin/bash', 10:57:51 INFO - 'SHLVL': '1', 10:57:51 INFO - 'TERM': 'linux', 10:57:51 INFO - 'TMOUT': '86400', 10:57:51 INFO - 'USER': 'cltbld', 10:57:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689', 10:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:51 INFO - '_': '/tools/buildbot/bin/python'} 10:57:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:57:51 INFO - mozversion application_buildid: 20161207100538 10:57:51 INFO - mozversion application_changeset: 11ab9642165eab2b6e38e495d7d003347ef99ba0 10:57:51 INFO - mozversion application_display_name: Nightly 10:57:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:51 INFO - mozversion application_name: Firefox 10:57:51 INFO - mozversion application_remotingname: firefox 10:57:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:57:51 INFO - mozversion application_vendor: Mozilla 10:57:51 INFO - mozversion application_version: 53.0a1 10:57:51 INFO - mozversion platform_buildid: 20161207100538 10:57:51 INFO - mozversion platform_changeset: 11ab9642165eab2b6e38e495d7d003347ef99ba0 10:57:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:57:51 INFO - mozversion platform_version: 53.0a1 10:57:51 INFO - using testdate: 1481137071 10:57:51 INFO - actual date: 1481137071 10:57:51 INFO - starting webserver on 'localhost:49683' 10:57:51 INFO - SUITE-START | Running 2 tests 10:57:51 INFO - TEST-START | dromaeo_css 10:57:51 INFO - operating with platform_type : linux_ 10:57:51 INFO - Initialising browser for dromaeo_css test... 10:57:51 INFO - TEST-INFO | started process 22602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE3KHDg/profile http://localhost:49683/getInfo.html) 10:57:55 INFO - PROCESS | 22602 | __metrics Screen width/height:1600/1200 10:57:55 INFO - PROCESS | 22602 | colorDepth:24 10:57:55 INFO - PROCESS | 22602 | Browser inner width/height: 1024/697 10:57:55 INFO - PROCESS | 22602 | __metrics 10:57:56 INFO - PROCESS | 22602 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:57:56 INFO - PROCESS | 22602 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:57 INFO - PROCESS | 22602 | console.error: PushService: 10:57:57 INFO - PROCESS | 22602 | stateChangeProcessEnqueue: Error transitioning state 10:57:57 INFO - PROCESS | 22602 | UnknownError 10:57:57 INFO - TEST-INFO | 22602: exit 0 10:57:57 INFO - Browser initialized. 10:57:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:57 INFO - TEST-INFO | started process 22682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE3KHDg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:10 INFO - PROCESS | 22682 | RSS: Main: 173604864 10:58:10 INFO - PROCESS | 22682 | 10:59:00 INFO - PROCESS | 22682 | 1481137140958 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] 11:01:14 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49683/tests/dromaeo/cssquery-ext.html) 11:01:16 INFO - PROCESS | 22682 | RSS: Main: 379199488 11:01:16 INFO - PROCESS | 22682 | 11:04:19 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-ext.html (next: http://localhost:49683/tests/dromaeo/cssquery-jquery.html) 11:04:20 INFO - PROCESS | 22682 | RSS: Main: 276643840 11:04:20 INFO - PROCESS | 22682 | 11:07:23 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49683/tests/dromaeo/cssquery-mootools.html) 11:07:23 INFO - PROCESS | 22682 | RSS: Main: 260513792 11:07:23 INFO - PROCESS | 22682 | 11:10:25 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49683/tests/dromaeo/cssquery-prototype.html) 11:10:26 INFO - PROCESS | 22682 | RSS: Main: 241782784 11:10:26 INFO - PROCESS | 22682 | 11:13:29 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49683/tests/dromaeo/cssquery-yui.html) 11:13:30 INFO - PROCESS | 22682 | RSS: Main: 221630464 11:13:30 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-yui.html (next: http://localhost:49683/tests/dromaeo/cssquery-dojo.html) 11:16:33 INFO - PROCESS | 22682 | RSS: Main: 320991232 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | __start_tp_report 11:16:33 INFO - PROCESS | 22682 | _x_x_mozilla_page_load 11:16:33 INFO - PROCESS | 22682 | _x_x_mozilla_page_load_details 11:16:33 INFO - PROCESS | 22682 | |i|pagename|runs| 11:16:33 INFO - PROCESS | 22682 | |0;dojo.html;2554;2583.4962182374443;2602.1022747152233;2602.934926626834;2623.317937336292;4440.3561483584945;4499.3026080957425;4578.061497393031;4607.769611519423;4640.767961601919;4551.522090180533;4574.473935497419;4590.977045114778;4621.168189725848;4669.929951050728;4215.114825886568;4228.112096459748;4268.509121451042;4295.119500502389;4376.081022985177;4208.179405016008;4278;4335.0679603885155;4377.802998865059;4424.446944131983;4100.384942258685;4138.751674899486;4290.099079193373;4325.610695037431;4359.564043595647;4170.020045289354;4180.184863951531;4180.226658068267;4184.539700632928;4186.811593478301;4134.152498737782;4154.626083652486;4165.354370072643;4165.812538435777;4168.874933751992;4474.284114541658;4496.775161241958;4501.909961800779;4520.841770538015;4568.840090596813;4935.90128197434;4936.80252789888;4941.876453088666;4982.153033984231;4988.775505102279;4951.62862785289;4962.975185124087;4963.280324352949;4968.3292755477905;5013.924791128136;4484.506704262529;4543.54564543543;4578.748168850679;4633.49031606523;4684.391029166187;4962.578180854668;4970.254461830755;4992.825251116194;5000.724960127228;5045.142325804622;4754.02542478791;4789.449213340441;4791.47293797682;4804.495527969582;4839.879003024882;4752.952470475251;4793.448753393334;4880.389951256093;4880.6095512358925;4928.014397120519;4806.615470762331;4862.367892173995;4882.292067650171;4912.803487860446;4967.900641987212;4897.412310522689;4899.474913650294;4901.754912254373;4904.4605093439695;4942.20924652054;4273.316269396882;4282.250606143913;4290.399344091829;4296.0978194578865;4329.588689074533;3609.4585812127866;3630.7276954228537;3642.763220390666;3700.796456194935;3701.0932321581386;4286.292761694348;4296.570342965741;4318.762468064224;4322.956770432318;4337.652987760972;4990.675606085593;4992.975035124874;5010.974945125251;5011.799528018839;5034.521720436553;4080.8775736727944;4097.836086556564;4214.852480163241;4270.0392411707735;4276.5295817460055;4493.123840851003;4522;4522.4346956630425;4547.431571053618;4561.908761824745;4609.815607375667;4611.700239484423;4613.400257966443;4647.976760116246;4658;4764.49972752856;4816.686915350631;4987.675801072919;4988.850334489971;4995.300657907823;4510.413646225969;4533.455985281787;4555.40779698637;4556.157110934488;4630.536946305478;4883.536064073907;4885.560299572913;4891.9755401222765;4938;4941.357623508921;4897.2654101885;4949.777260023379;4950.108980383566;4953.455119936732;4956.430010548689;4650.4186976627925;4706.741129237925;4710.246360582428;4770.904581908412;4862.756862156807;4719.150552900511;4736.100140973204;4743.810247590058;4747.454042785124;4747.596454301423;4641.164590373765;4643.930341044819;4648.163330600389;4657.417822772153;4657.790399432101;4747.596454301423;4785.521447855187;4786.497417771223;4793.4247890252;4798.0403919217;4687.695299805502;4696.647751418725;4702.482726900107;4703.247480403119;4704.882377940579 11:16:33 INFO - PROCESS | 22682 | |1;ext.html;561.1274468201946;576.3429690153229;582.2401765695768;584.8713283077724;589.4665327878272;36585.99999999996;37620.81189594052;37646.62353376469;41703.165936681246;41703.79148104263;39125;39462.210755784865;39564;39603.40594891072;39626.8018659907;7345.1553071396675;7521.774346769578;7584.582847943375;7744.612769361509;7745.070591529025;9454.29092818038;9715.854262186072;9727.416355018686;9997.850032249522;9999.050090241451;9884.752881177956;9916.157126644244;9950.203983681287;9952;9953.75115622108;9869.457179855106;9887.555060022316;9900.851487227697;9977.850332244985;9982;9648.469334186617;9716.659916902945;9716.902830971741;9739.220862330996;9742;36893.262134757424;37039.629603704154;37066.814665926766;37186.62813371859;37195.62804371949;2717.728227177286;2721.2244510314663;2783.485055264762;2827.802053856231;3111.9066428007195;27164.32089197786;27285.590716139275;27321.590176147372;27704.168874933785;27936.58095128575;3334.333133373335;3336.466165413522;3408.522806807049;3545.574531056264;3574.4995700601935;249677;250510.99999999817;252569;253025;253516.1972570413;51755;52319;52396.47603523916;52410.21384679233;52464.47535524672;55912.440875591536;56178.43821561814;56191.71904140453;56200.43799562034;56243.15635265474;11384.373859437645;11489.597864074718;11490.138239631893;11501.309921404743;11514.76970460586;8032.598370081472;8194.09864914859;8199.098099209083;8311.085780564134;8389.45468544555;15777.368905243662;17679.38122165718;18043;18081.547961301072;18896.52758681044;6453.806385808433;6962.762315523306;6980.406665433495;7137.858642407257;7148.714051437988;764.6176911544228;876.6099085906837;902.0618556701089;917.9764562512751;963.4784861331843;26209.868950655124;26629.86685066562;27007.974401919935;27335.86332068327;27446.45107097847;869.426178722053;899.5457294066586;906.3021473465395;919.9448033118034;923.5197697197555;14076.436942522185;14214.644633884236;14368.312818525965;14430.134191948517;14633.12201267906;357084;360779;361219;361412;362495;48095;48293.517064829604;48504.75747621239;48557.757211214426;48676;1123.1913022623535;1144.959926402572;1150.7986102432042;1169.2984209474248;1175.7413369058793;25361.619575706747;26044;26534.336641584116;26662.867825313464;26789.8660506704;41299.52202867837;45048.324275136554;46312.53687463082;50120.49879501158;50338.49661503485;318484;321261;321720;321811;321850;31681.20796980094;31878;33791.3241735159;36807;37359.81320093382;38744.418833716954;39259.6074039256;39672.40491392574;40087.59912400955;40247.19505609813;33804.3239135211;34341;34487.137821554665;34505;34547;34705.82647086748;35316.47025294571;35346.293074138885;35429;35865.28269434544;34507.13732156716;34629.653703462645;34868.476972845936;35166;35412.46881296834;29744.702552975057;32364.676353237108;32449.351012979136;32457.51313730249;32486.18784530311;23938;24377.878110609334;24481.51036979286;24596.87434799433;24891.875540622183 11:16:33 INFO - PROCESS | 22682 | |2;jquery.html;348.13488481124415;363.46389076112735;367.8344744864811;370.2724147051045;380.7144641518861;12268.81596776048;13297.401616927238;13992.160470371771;16225.432109876157;16908.323667053304;15143;16306.347746090172;16754.246058927347;16838;16874.493765187035;4725.952740472603;5117.616178786588;5150.922736158961;5155.71643559604;5156.381234251895;3722.571904231021;3905;5034.798608055673;5140.228965655163;5142;3916.4516967624554;3936.7047471439755;3974.4237085622567;5913.438223368773;6041.9697901510435;6033.758649654009;6045.758169673208;6048.092786082079;6052.485538729169;6062.060380641008;5093.872653183663;5207.114790485589;5233.345831771028;5239.083160446945;5240.371155461369;20037.1985120595;20113.497162571053;20220.69668954967;20238.190472381088;20305;1886.462358227912;1938.9709154362695;1941.2817257614772;1991.6713742232514;2011.8289945354663;12564.183328083645;13150.736985260337;13202.801957970638;13309.467621295136;13659.385327660279;1673.1801417305555;1690.754840548126;1693.745938109281;1706.8037175724703;1767.531604124908;63987;64302;65368.3463165367;66381;66874.33125668729;9373.578188981512;9517.952410237904;9745.707628771148;9763.26775491841;9876.308658393988;13256.801147982787;13257.403416846266;13305;13311.73376532464;13312.134711243738;6345.428911397997;6500.317466666026;6536.934630653633;6735.057092007123;6738.561993470409;6020;6076.447891885418;6208.782692605828;6285.402886725754;6297.842553936188;5857.502112320415;6018.608790428608;6042.012271900525;6074.088886667036;6217.160683307786;1627.5686942960126;1698.388580111159;1700.2858799304074;1705.714342780655;1714.4342367018853;850.1540966738012;869.3479890082439;936.4100616611491;944.8677185194078;953.2897990996613;16250.837491624932;16314.184290785413;17374.565635859206;17409.129543522773;17757.289708411776;837.937154713399;849.3120572336304;858.206159302655;870.8127752533109;884.4030279561271;8957.462552246887;9731;9818.459984700767;9826.80346393068;9842.212622990144;343045;347935;348851;351458;356089;54649.72675136599;70193.01429235608;70952;78926.60536697395;79378.60310698525;882.148726478951;915.7847905742012;939.6100618243489;941.580996456584;944.5418971798672;15188.620284492976;15195.199096582863;15701.607459813597;16018.67962640764;16093.436729714404;35057.47413788744;35148.64851351556;35816.46275305925;36075.81962090278;37027;45782;49780;50749;53109.46890531045;53434.46565534295;7252.606639808956;7352.595607241653;7375.963120184365;7503.924960750541;7580.4693671444675;10117.645882394081;11470.139739519736;11513.942430287794;11806.173567850168;11835.467403967014;9959;10131.949340253252;10470.633527826489;10569.788604227719;10762.677119686421;9682.225421966084;10034.147097496794;10071.395716257048;10264;10264.281500294908;10181.33821301613;10300.278980471594;10413.895861041292;10524.789504210026;10803.297785643908;6952.582845029315;7094.716211351488;7135.607541585055;7391.889121663072;7407.62961851916;8481.745547633582;9442.669506567237;9774.706758796963;10161.847572286273;10503.789924201626 11:16:33 INFO - PROCESS | 22682 | |3;mootools.html;1274.2481935657963;1277.4826195390865;1308.888744456721;1601.1193843386134;1627.8941868778536;5902.288336382455;6104.481119104881;6605.933940660592;7003.7898863034125;7031.824204394893;6549.934500655004;6779;6791.252962174157;6951.2701166377565;6954.687039083241;2017.132632967827;2054.5274586845035;2054.8664336818133;2056.4036429435446;2057.711920331155;1758.551569349814;2023.6053969475959;2055.5169535159225;2059.979400206001;2069.668852983523;1739.9739003914888;1944.4361135270753;2007.42788305333;2009.0657844102489;2018.2330714328534;1935.1775495414392;1938.932137375192;1942.669746143152;1947.9707804382945;1951.5511432370633;2018.7779344272265;2024.7165396844307;2029.046348216336;2039.6328660841043;2041.9489512762152;6832.795016149524;6998.6500674966555;7000.544964577286;7007.929920700779;7013.649317534103;4013.478247827793;4130.401091841666;4130.504339479252;4133.731307465006;4134.875953721363;2597.59737240728;2757.241758516404;2827.9010234641687;2842.2325971987652;2845.260232339607;857.3569822633025;866.9783255418602;891.7948871759467;898.0211569389397;915.8259930613228;8937.285017198608;8973.730788076367;8997.640094396216;9002.504862232574;9018.819623607556;3604.2250916053176;3822.617738226211;3894.045958740127;3922.9019274518364;3953.683705303569;7913.920860791433;7923.247291507298;7925.484843485155;7927.445078844541;7928.643211055516;4214;4215.641670457984;4221.87334379963;4222.683298752606;4223.556526564728;3764.5858955514873;3871.070942973666;3872.4384964180035;3872.6901847852105;3875.9418608720894;3362.764606477523;3364.7139993100373;3406.744494162948;3474.7915125092577;3475.0443628002504;994.2543092680489;1147.1224513247373;1149.3793351590216;1168.4683469021575;1170.239344426113;649.7368565730792;732.1799584465433;735.8785800342883;740.2190688823343;762.0969151555424;4671.976640116845;4787.808487660454;4793.472718001017;4794.424669039738;4802.183628783116;844.1684940333889;857.7341024282492;878.2534845381375;879.4942907828024;882.0870399136862;3265.346930613887;3278.4426647469986;3319.751018673609;3331.4503106987077;3411;7912.129665736765;8379.413441059189;8386.412951093365;8387.874181887277;8392.03491598474;8157.5976743953825;8319.542425166674;8335.416520843604;8337.749867503984;8391.286740627114;6473.28793832678;6559.114519539801;6564.081028655992;6567.2447668518735;6568.339822371947;4545.159145558082;4575.17646823575;4625.722456652612;4652.371929789435;4680.7191568506;7582.582957937146;7590.127135379502;7595.772126836204;7658.2724641159;7661.693532258647;7598.658060387185;7778.416618753729;7829.099653539915;7846.686132554634;7872.527648341118;5643.689597072201;5661.150827375926;5678.0915053591225;5700.686462244616;5703.258576385209;6524.1518602583255;6557;6582.605043697394;6595.076689263603;6600.8349791255605;5755.683437410815;5766.481016708516;5901.527877769854;5939.376365481735;5994.6403215807195;5816.82549523515;5881.470667639933;5959;6009.338972713085;6024.759009639565;5528.4471552846;5644.153376993484;5645.661260324394;5647.689377084135;5650.180723795109;3924.3328634131694;4049.6152865477734;4116.835326586903;4149.854755083557;4180.979095104505;4189.581041895786;4191.790410479402;4228.175505776344;4230.746155230696;4248.107897341592 11:16:33 INFO - PROCESS | 22682 | |4;prototype.html;270.3134039539568;275.866204890628;277.956916677915;292.2547503865144;294.6876311110223;4691.882702932428;4802.055167657096;4834.178189707749;4857.587105096067;4891.633127515437;4656.906861862761;4735.597474214687;4745.596624286931;4747.76261186941;4792.3290739296435;3718.1819999600043;3736.30878287517;3736.841579110471;3742.251549690059;3755.9436608450897;3689.926201475969;3725.310817498758;3729.981350093259;3737.3459644562095;3751.5498140223212;3469.219425629226;3475.287566048954;3699.2971335446177;3733.2720119576693;3768.491253680759;3735.514383130203;3747.7819708594543;3748.418995055757;3749.6062913393976;3756.5492140943124;3318.634950155481;3323.6344002159744;3326.617438994522;3329.250918543333;3335.7331413486863;4549.704269222523;4647.326137710013;4665.930011049837;4669.365721997307;4681.508441613616;4291.442112525383;4303.160883627694;4314.331278651814;4356.607905288539;4357.128574285156;4989.975050124763;4992.700437973734;4997.375852847803;5020.523050310215;5023.296738456583;3659.1218107654236;3665.5784584772828;3665.725070619714;3671.834767435472;3683.7605555638797;5115.462876397999;5213.165893457104;5237.659552129099;5246.632735708502;5261.710605916673;3738.6261373862394;3745.382011968049;3755.4179102239195;3774.226283611853;3779.9244015120094;3788.484606157504;3799.7340186187253;3802.866899658499;3806.4861243731743;3844.4041173618134;4016.59834016596;4221.767802770815;4278.593533614302;4285.37862010013;4296.82812687489;5067.986402719471;5070.670406423571;5071.137906555894;5085.516875896784;5086.491350864958;1181.2381014245764;1222.541546919905;1223.3760782001243;1226.3500344817262;1231.1135982092878;803.5700900018462;833.8874251976027;835.9300095877287;841.9705310314232;843.6836186430089;4247.851325203665;4267.807948642257;4299.828006879689;4306.354046892991;4307.203167414038;5030.119729047402;5034.521720436553;5044.697318160849;5048.192289233779;5061.44324124346;4038.374052021941;4281.165172791276;4299.849505267301;4307.892302692458;4315.525292217853;2663.7735792457856;2676.8260063095836;2678.665166854143;2683.5035518429154;2685.2481305234564;4605.802491352206;4639.118567472237;4651.139539185261;4662.857599888049;4685.695429797052;4774.474807771142;5070.670406423645;5078.060558796635;5097.8725531862;5140.254663073833;4593.609543188866;4609.354690343354;4613.215753321876;4654.953450465519;4666.090112428112;4950.430700469348;4962.578180854523;5019.949800501949;5023.899522009612;5025.572826309804;4653.325267836212;4857.489963553918;4896.534829191221;4898.093852637274;4908.190148625579;4604.355390245435;4635.768211589474;4635.93046104302;4638.234691275901;4642.2340313847835;3493.5458390409085;3504.281622267378;3535.3282876254457;3539.5221645077586;3545.8936231913085;4781.402324709411;4867.685724854198;4956.900861982812;4979.900401992012;4998.700077995332;4836.274558816206;4857.465678775403;4861.246506791453;4874.2444921037295;4876.244182151772;4773.71357718538;4869;4898.142825005681;4909.803607855646;4928.940277840282;4673.719576825401;4759.3574867393845;4789.61683065347;4833.347498087714;4844.563989240985;5113.207452844815;5125.461826508163;5178.97410512945;5183.0670479314085;5191.195364718475;4998.575121114746;5017;5031.547160755549;5038.370203724535;5074.564209179688 11:16:33 INFO - PROCESS | 22682 | |5;yui.html;609.4301827791013;615.9291681456631;624.7938180400469;669.5112567825485;690.9965450172748;11670.708232294197;14652.560423187308;15041.172735499544;15089.547313580582;15801.920990395061;15532.534023979299;15628.218589070559;15689.686206275868;15786.921065394657;15798;627.6077451592755;745.9850802983937;751.9398448124165;754.7245255481737;756.5611945071872;588.2206076948039;594.8958932186872;606.4844881850436;632.0992585565574;645.8579112595221;821.6877586517115;823.6705317872838;824.3487644760631;824.3775949158377;826.2274773087182;650.4211251985737;816.4529765057425;816.5672193737329;817.8527864984301;818.423011776696;491.68777826080697;578.7974209026806;593.3769541980903;593.4006653280175;593.717983957621;13513;13523.188608683413;13566.525171618947;13568.321583920862;13577.728445431136;12314.753704925852;12479.812802807874;12634.13324316531;12675.17611355259;13017.934910325483;10226.23303252259;10489.370637761682;10716.678499645022;11125.499352529156;11187.384693841836;3285.852136653856;3286.1861607520923;3348.7488438366977;3354.194993201638;3414.0611331883683;66889.3311066888;67189;67866.66066669684;69220;69465.58016297595;9608;9665.90334096664;9682.322237443312;9913.256505762096;10043.748906277255;13727.245001525012;13846.723065538632;14439.92780036093;14534.401215866246;14551.345189466289;6411.935880641134;6480.935190648128;6542.672866356663;6717.664116794141;6814.114165158498;3555.235624340779;3638.381475149231;3679.2273622539033;3697.815109244527;3713.8514459421863;2633.947321053568;2666.5733482642686;2677.8794954227105;2720.591911213334;2736.835789852615;464.5633104881401;465.53446553446554;469.16488650202695;475.63613835415936;478.643046961867;533.5944682041676;561.1218443136478;562.6258538072218;564.5173376762891;565.5334349161958;7967.123616402191;8403.495790252604;8482.618282177316;8553.786155346166;8623.611937462703;492.4951924277644;507.79434329096773;531.9973400133052;543.4782608695697;552.1193696054786;3661.4690869823726;3971.900702482403;3989.4614227079555;4019.7789121598007;4125.628693417607;57339;60514.69742651258;71682.64158679174;73930.63034684792;73988;59218.703906480194;59835.70082149649;60074.09888851671;60778.39221607816;61672;56615.43384566184;56747;56824.715876420356;57728.711356442946;58512.707436462544;7126.786196414116;7282.817929551804;7491.475596708178;7640.3505702015955;7946.125926148004;39630.60369396384;39981.2017858303;40027.59972400355;40627.79686101551;40793.79603101966;45107;51368.48631513637;51441.485585143666;52934;55690.16464753113;9250.95374523123;9308.255339572954;9579.037800687207;9670.178034866834;9896.752581185528;11497.712557186138;11591.826122608;11976.341301228516;12073.517059317528;12117.757644846877;9766.121049105615;9992.950035250067;10511.316764410289;10527.526261318106;10542.367457952547;10419.114375278186;10912.181586381212;11074.723131921444;11125.944370278097;11169;9830;9866;9894.257930655085;10237.436940968319;10421.583136674448;8759.737207883774;8969.37214394986;9031.50326732036;9259.398064171079;9269.629214831331;8263.876041859257;8814.382993190415;9024.503652299187;9063.410878293154;9619.230461563198 11:16:33 INFO - PROCESS | 22682 | __end_tp_report 11:16:33 INFO - PROCESS | 22682 | __start_cc_report 11:16:33 INFO - PROCESS | 22682 | _x_x_mozilla_cycle_collect,2493 11:16:33 INFO - PROCESS | 22682 | __end_cc_report 11:16:33 INFO - PROCESS | 22682 | __startTimestamp1481138193473__endTimestamp 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | ------- Summary: start ------- 11:16:33 INFO - PROCESS | 22682 | Number of tests: 6 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#0] dojo.html Cycles:165 Average:4543.47 Median:4643.93 stddev:467.99 (10.1%) stddev-sans-first:442.64 11:16:33 INFO - PROCESS | 22682 | Values: 2554.0 2583.5 2602.1 2602.9 2623.3 4440.4 4499.3 4578.1 4607.8 4640.8 4551.5 4574.5 4591.0 4621.2 4669.9 4215.1 4228.1 4268.5 4295.1 4376.1 4208.2 4278.0 4335.1 4377.8 4424.4 4100.4 4138.8 4290.1 4325.6 4359.6 4170.0 4180.2 4180.2 4184.5 4186.8 4134.2 4154.6 4165.4 4165.8 4168.9 4474.3 4496.8 4501.9 4520.8 4568.8 4935.9 4936.8 4941.9 4982.2 4988.8 4951.6 4963.0 4963.3 4968.3 5013.9 4484.5 4543.5 4578.7 4633.5 4684.4 4962.6 4970.3 4992.8 5000.7 5045.1 4754.0 4789.4 4791.5 4804.5 4839.9 4753.0 4793.4 4880.4 4880.6 4928.0 4806.6 4862.4 4882.3 4912.8 4967.9 4897.4 4899.5 4901.8 4904.5 4942.2 4273.3 4282.3 4290.4 4296.1 4329.6 3609.5 3630.7 3642.8 3700.8 3701.1 4286.3 4296.6 4318.8 4323.0 4337.7 4990.7 4993.0 5011.0 5011.8 5034.5 4080.9 4097.8 4214.9 4270.0 4276.5 4493.1 4522.0 4522.4 4547.4 4561.9 4609.8 4611.7 4613.4 4648.0 4658.0 4764.5 4816.7 4987.7 4988.9 4995.3 4510.4 4533.5 4555.4 4556.2 4630.5 4883.5 4885.6 4892.0 4938.0 4941.4 4897.3 4949.8 4950.1 4953.5 4956.4 4650.4 4706.7 4710.2 4770.9 4862.8 4719.2 4736.1 4743.8 4747.5 4747.6 4641.2 4643.9 4648.2 4657.4 4657.8 4747.6 4785.5 4786.5 4793.4 4798.0 4687.7 4696.6 4702.5 4703.2 4704.9 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#1] ext.html Cycles:180 Average:46763.69 Median:36966.45 stddev:82574.12 (223.4%) stddev-sans-first:82732.89 11:16:33 INFO - PROCESS | 22682 | Values: 561.1 576.3 582.2 584.9 589.5 36586.0 37620.8 37646.6 41703.2 41703.8 39125.0 39462.2 39564.0 39603.4 39626.8 7345.2 7521.8 7584.6 7744.6 7745.1 9454.3 9715.9 9727.4 9997.9 9999.1 9884.8 9916.2 9950.2 9952.0 9953.8 9869.5 9887.6 9900.9 9977.9 9982.0 9648.5 9716.7 9716.9 9739.2 9742.0 36893.3 37039.6 37066.8 37186.6 37195.6 2717.7 2721.2 2783.5 2827.8 3111.9 27164.3 27285.6 27321.6 27704.2 27936.6 3334.3 3336.5 3408.5 3545.6 3574.5 249677.0 250511.0 252569.0 253025.0 253516.2 51755.0 52319.0 52396.5 52410.2 52464.5 55912.4 56178.4 56191.7 56200.4 56243.2 11384.4 11489.6 11490.1 11501.3 11514.8 8032.6 8194.1 8199.1 8311.1 8389.5 15777.4 17679.4 18043.0 18081.5 18896.5 6453.8 6962.8 6980.4 7137.9 7148.7 764.6 876.6 902.1 918.0 963.5 26209.9 26629.9 27008.0 27335.9 27446.5 869.4 899.5 906.3 919.9 923.5 14076.4 14214.6 14368.3 14430.1 14633.1 357084.0 360779.0 361219.0 361412.0 362495.0 48095.0 48293.5 48504.8 48557.8 48676.0 1123.2 1145.0 1150.8 1169.3 1175.7 25361.6 26044.0 26534.3 26662.9 26789.9 41299.5 45048.3 46312.5 50120.5 50338.5 318484.0 321261.0 321720.0 321811.0 321850.0 31681.2 31878.0 33791.3 36807.0 37359.8 38744.4 39259.6 39672.4 40087.6 40247.2 33804.3 34341.0 34487.1 34505.0 34547.0 34705.8 35316.5 35346.3 35429.0 35865.3 34507.1 34629.7 34868.5 35166.0 35412.5 29744.7 32364.7 32449.4 32457.5 32486.2 23938.0 24377.9 24481.5 24596.9 24891.9 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#2] jquery.html Cycles:180 Average:22804.84 Median:25253.98 stddev:57781.36 (228.8%) stddev-sans-first:57918.85 11:16:33 INFO - PROCESS | 22682 | Values: 348.1 363.5 367.8 370.3 380.7 12268.8 13297.4 13992.2 16225.4 16908.3 15143.0 16306.3 16754.2 16838.0 16874.5 4726.0 5117.6 5150.9 5155.7 5156.4 3722.6 3905.0 5034.8 5140.2 5142.0 3916.5 3936.7 3974.4 5913.4 6042.0 6033.8 6045.8 6048.1 6052.5 6062.1 5093.9 5207.1 5233.3 5239.1 5240.4 20037.2 20113.5 20220.7 20238.2 20305.0 1886.5 1939.0 1941.3 1991.7 2011.8 12564.2 13150.7 13202.8 13309.5 13659.4 1673.2 1690.8 1693.7 1706.8 1767.5 63987.0 64302.0 65368.3 66381.0 66874.3 9373.6 9518.0 9745.7 9763.3 9876.3 13256.8 13257.4 13305.0 13311.7 13312.1 6345.4 6500.3 6536.9 6735.1 6738.6 6020.0 6076.4 6208.8 6285.4 6297.8 5857.5 6018.6 6042.0 6074.1 6217.2 1627.6 1698.4 1700.3 1705.7 1714.4 850.2 869.3 936.4 944.9 953.3 16250.8 16314.2 17374.6 17409.1 17757.3 837.9 849.3 858.2 870.8 884.4 8957.5 9731.0 9818.5 9826.8 9842.2 343045.0 347935.0 348851.0 351458.0 356089.0 54649.7 70193.0 70952.0 78926.6 79378.6 882.1 915.8 939.6 941.6 944.5 15188.6 15195.2 15701.6 16018.7 16093.4 35057.5 35148.6 35816.5 36075.8 37027.0 45782.0 49780.0 50749.0 53109.5 53434.5 7252.6 7352.6 7376.0 7503.9 7580.5 10117.6 11470.1 11513.9 11806.2 11835.5 9959.0 10131.9 10470.6 10569.8 10762.7 9682.2 10034.1 10071.4 10264.0 10264.3 10181.3 10300.3 10413.9 10524.8 10803.3 6952.6 7094.7 7135.6 7391.9 7407.6 8481.7 9442.7 9774.7 10161.8 10503.8 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#3] mootools.html Cycles:180 Average:4545.76 Median:5643.92 stddev:2433.58 (43.1%) stddev-sans-first:2427.99 11:16:33 INFO - PROCESS | 22682 | Values: 1274.2 1277.5 1308.9 1601.1 1627.9 5902.3 6104.5 6605.9 7003.8 7031.8 6549.9 6779.0 6791.3 6951.3 6954.7 2017.1 2054.5 2054.9 2056.4 2057.7 1758.6 2023.6 2055.5 2060.0 2069.7 1740.0 1944.4 2007.4 2009.1 2018.2 1935.2 1938.9 1942.7 1948.0 1951.6 2018.8 2024.7 2029.0 2039.6 2041.9 6832.8 6998.7 7000.5 7007.9 7013.6 4013.5 4130.4 4130.5 4133.7 4134.9 2597.6 2757.2 2827.9 2842.2 2845.3 857.4 867.0 891.8 898.0 915.8 8937.3 8973.7 8997.6 9002.5 9018.8 3604.2 3822.6 3894.0 3922.9 3953.7 7913.9 7923.2 7925.5 7927.4 7928.6 4214.0 4215.6 4221.9 4222.7 4223.6 3764.6 3871.1 3872.4 3872.7 3875.9 3362.8 3364.7 3406.7 3474.8 3475.0 994.3 1147.1 1149.4 1168.5 1170.2 649.7 732.2 735.9 740.2 762.1 4672.0 4787.8 4793.5 4794.4 4802.2 844.2 857.7 878.3 879.5 882.1 3265.3 3278.4 3319.8 3331.5 3411.0 7912.1 8379.4 8386.4 8387.9 8392.0 8157.6 8319.5 8335.4 8337.7 8391.3 6473.3 6559.1 6564.1 6567.2 6568.3 4545.2 4575.2 4625.7 4652.4 4680.7 7582.6 7590.1 7595.8 7658.3 7661.7 7598.7 7778.4 7829.1 7846.7 7872.5 5643.7 5661.2 5678.1 5700.7 5703.3 6524.2 6557.0 6582.6 6595.1 6600.8 5755.7 5766.5 5901.5 5939.4 5994.6 5816.8 5881.5 5959.0 6009.3 6024.8 5528.4 5644.2 5645.7 5647.7 5650.2 3924.3 4049.6 4116.8 4149.9 4181.0 4189.6 4191.8 4228.2 4230.7 4248.1 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#4] prototype.html Cycles:180 Average:4109.80 Median:4644.78 stddev:1184.69 (25.5%) stddev-sans-first:1152.43 11:16:33 INFO - PROCESS | 22682 | Values: 270.3 275.9 278.0 292.3 294.7 4691.9 4802.1 4834.2 4857.6 4891.6 4656.9 4735.6 4745.6 4747.8 4792.3 3718.2 3736.3 3736.8 3742.3 3755.9 3689.9 3725.3 3730.0 3737.3 3751.5 3469.2 3475.3 3699.3 3733.3 3768.5 3735.5 3747.8 3748.4 3749.6 3756.5 3318.6 3323.6 3326.6 3329.3 3335.7 4549.7 4647.3 4665.9 4669.4 4681.5 4291.4 4303.2 4314.3 4356.6 4357.1 4990.0 4992.7 4997.4 5020.5 5023.3 3659.1 3665.6 3665.7 3671.8 3683.8 5115.5 5213.2 5237.7 5246.6 5261.7 3738.6 3745.4 3755.4 3774.2 3779.9 3788.5 3799.7 3802.9 3806.5 3844.4 4016.6 4221.8 4278.6 4285.4 4296.8 5068.0 5070.7 5071.1 5085.5 5086.5 1181.2 1222.5 1223.4 1226.4 1231.1 803.6 833.9 835.9 842.0 843.7 4247.9 4267.8 4299.8 4306.4 4307.2 5030.1 5034.5 5044.7 5048.2 5061.4 4038.4 4281.2 4299.8 4307.9 4315.5 2663.8 2676.8 2678.7 2683.5 2685.2 4605.8 4639.1 4651.1 4662.9 4685.7 4774.5 5070.7 5078.1 5097.9 5140.3 4593.6 4609.4 4613.2 4655.0 4666.1 4950.4 4962.6 5019.9 5023.9 5025.6 4653.3 4857.5 4896.5 4898.1 4908.2 4604.4 4635.8 4635.9 4638.2 4642.2 3493.5 3504.3 3535.3 3539.5 3545.9 4781.4 4867.7 4956.9 4979.9 4998.7 4836.3 4857.5 4861.2 4874.2 4876.2 4773.7 4869.0 4898.1 4909.8 4928.9 4673.7 4759.4 4789.6 4833.3 4844.6 5113.2 5125.5 5179.0 5183.1 5191.2 4998.6 5017.0 5031.5 5038.4 5074.6 11:16:33 INFO - PROCESS | 22682 | 11:16:33 INFO - PROCESS | 22682 | [#5] yui.html Cycles:180 Average:15231.01 Median:565.03 stddev:19940.61 (3529.2%) stddev-sans-first:19966.32 11:16:33 INFO - PROCESS | 22682 | Values: 609.4 615.9 624.8 669.5 691.0 11670.7 14652.6 15041.2 15089.5 15801.9 15532.5 15628.2 15689.7 15786.9 15798.0 627.6 746.0 751.9 754.7 756.6 588.2 594.9 606.5 632.1 645.9 821.7 823.7 824.3 824.4 826.2 650.4 816.5 816.6 817.9 818.4 491.7 578.8 593.4 593.4 593.7 13513.0 13523.2 13566.5 13568.3 13577.7 12314.8 12479.8 12634.1 12675.2 13017.9 10226.2 10489.4 10716.7 11125.5 11187.4 3285.9 3286.2 3348.7 3354.2 3414.1 66889.3 67189.0 67866.7 69220.0 69465.6 9608.0 9665.9 9682.3 9913.3 10043.7 13727.2 13846.7 14439.9 14534.4 14551.3 6411.9 6480.9 6542.7 6717.7 6814.1 3555.2 3638.4 3679.2 3697.8 3713.9 2633.9 2666.6 2677.9 2720.6 2736.8 464.6 465.5 469.2 475.6 478.6 533.6 561.1 562.6 564.5 565.5 7967.1 8403.5 8482.6 8553.8 8623.6 492.5 507.8 532.0 543.5 552.1 3661.5 3971.9 3989.5 4019.8 4125.6 57339.0 60514.7 71682.6 73930.6 73988.0 59218.7 59835.7 60074.1 60778.4 61672.0 56615.4 56747.0 56824.7 57728.7 58512.7 7126.8 7282.8 7491.5 7640.4 7946.1 39630.6 39981.2 40027.6 40627.8 40793.8 45107.0 51368.5 51441.5 52934.0 55690.2 9251.0 9308.3 9579.0 9670.2 9896.8 11497.7 11591.8 11976.3 12073.5 12117.8 9766.1 9993.0 10511.3 10527.5 10542.4 10419.1 10912.2 11074.7 11125.9 11169.0 9830.0 9866.0 9894.3 10237.4 10421.6 8759.7 8969.4 9031.5 9259.4 9269.6 8263.9 8814.4 9024.5 9063.4 9619.2 11:16:33 INFO - PROCESS | 22682 | -------- Summary: end -------- 11:16:33 INFO - PROCESS | 22682 | 11:16:34 INFO - TEST-INFO | 22682: exit 0 11:16:34 INFO - TEST-OK | dromaeo_css | took 1123148ms 11:16:34 INFO - TEST-START | kraken 11:16:34 INFO - operating with platform_type : linux_ 11:16:34 INFO - Initialising browser for kraken test... 11:16:34 INFO - TEST-INFO | started process 22987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj4U24S/profile http://localhost:49683/getInfo.html) 11:16:38 INFO - PROCESS | 22987 | __metrics Screen width/height:1600/1200 11:16:38 INFO - PROCESS | 22987 | colorDepth:24 11:16:38 INFO - PROCESS | 22987 | Browser inner width/height: 1024/697 11:16:38 INFO - PROCESS | 22987 | __metrics 11:16:39 INFO - PROCESS | 22987 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:16:39 INFO - PROCESS | 22987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:40 INFO - PROCESS | 22987 | console.error: PushService: 11:16:40 INFO - PROCESS | 22987 | stateChangeProcessEnqueue: Error transitioning state 11:16:40 INFO - PROCESS | 22987 | UnknownError 11:16:40 INFO - TEST-INFO | 22987: exit 0 11:16:40 INFO - Browser initialized. 11:16:40 INFO - Running cycle 1/1 for kraken test... 11:16:40 INFO - TEST-INFO | started process 23072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj4U24S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:53 INFO - PROCESS | 23072 | RSS: Main: 173555712 11:16:53 INFO - PROCESS | 23072 | 11:16:55 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:56 INFO - PROCESS | 23072 | RSS: Main: 240267264 11:16:56 INFO - PROCESS | 23072 | 11:16:59 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-dft) 11:17:00 INFO - PROCESS | 23072 | RSS: Main: 218173440 11:17:00 INFO - PROCESS | 23072 | 11:17:03 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-fft) 11:17:03 INFO - PROCESS | 23072 | RSS: Main: 299978752 11:17:03 INFO - PROCESS | 23072 | 11:17:06 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator) 11:17:06 INFO - PROCESS | 23072 | RSS: Main: 211574784 11:17:06 INFO - PROCESS | 23072 | 11:17:08 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:09 INFO - PROCESS | 23072 | RSS: Main: 214224896 11:17:09 INFO - PROCESS | 23072 | 11:17:12 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:13 INFO - PROCESS | 23072 | RSS: Main: 253648896 11:17:13 INFO - PROCESS | 23072 | 11:17:16 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:17 INFO - PROCESS | 23072 | RSS: Main: 248025088 11:17:17 INFO - PROCESS | 23072 | 11:17:20 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial) 11:17:20 INFO - PROCESS | 23072 | RSS: Main: 249847808 11:17:20 INFO - PROCESS | 23072 | 11:17:22 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:23 INFO - PROCESS | 23072 | RSS: Main: 213053440 11:17:23 INFO - PROCESS | 23072 | 11:17:25 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:25 INFO - PROCESS | 23072 | RSS: Main: 220565504 11:17:25 INFO - PROCESS | 23072 | 11:17:27 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:28 INFO - PROCESS | 23072 | RSS: Main: 229048320 11:17:28 INFO - PROCESS | 23072 | 11:17:31 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:32 INFO - PROCESS | 23072 | RSS: Main: 238444544 11:17:32 INFO - PROCESS | 23072 | 11:17:35 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:35 INFO - PROCESS | 23072 | RSS: Main: 235057152 11:17:35 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49683/tests/kraken/driver.html?testName=ai-astar) 11:17:37 INFO - PROCESS | 23072 | RSS: Main: 286179328 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | __start_tp_report 11:17:37 INFO - PROCESS | 23072 | _x_x_mozilla_page_load 11:17:37 INFO - PROCESS | 23072 | _x_x_mozilla_page_load_details 11:17:37 INFO - PROCESS | 23072 | |i|pagename|runs| 11:17:37 INFO - PROCESS | 23072 | |0;ai-astar;111;115;116;116;114;116;115;118;115;115 11:17:37 INFO - PROCESS | 23072 | |1;audio-beat-detection;150;133;131;167;133;134;136;130;150;128 11:17:37 INFO - PROCESS | 23072 | |2;audio-dft;161;164;167;163;163;162;162;161;160;161 11:17:37 INFO - PROCESS | 23072 | |3;audio-fft;78;78;78;111;78;77;78;76;94;76 11:17:37 INFO - PROCESS | 23072 | |4;audio-oscillator;85;84;105;84;85;84;105;84;83;106 11:17:37 INFO - PROCESS | 23072 | |5;imaging-gaussian-blur;118;116;117;117;116;117;117;117;118;117 11:17:37 INFO - PROCESS | 23072 | |6;imaging-darkroom;147;146;146;146;146;147;147;147;146;146 11:17:37 INFO - PROCESS | 23072 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 11:17:37 INFO - PROCESS | 23072 | |8;json-parse-financial;65;64;64;72;65;67;67;66;66;65 11:17:37 INFO - PROCESS | 23072 | |9;json-stringify-tinderbox;65;65;65;66;66;66;66;67;65;67 11:17:37 INFO - PROCESS | 23072 | |10;stanford-crypto-aes;85;85;89;96;85;84;86;86;85;86 11:17:37 INFO - PROCESS | 23072 | |11;stanford-crypto-ccm;141;144;137;139;138;153;140;141;181;142 11:17:37 INFO - PROCESS | 23072 | |12;stanford-crypto-pbkdf2;182;183;183;181;183;184;179;183;179;180 11:17:37 INFO - PROCESS | 23072 | |13;stanford-crypto-sha256-iterative;71;71;75;70;74;70;70;70;70;69 11:17:37 INFO - PROCESS | 23072 | __end_tp_report 11:17:37 INFO - PROCESS | 23072 | __start_cc_report 11:17:37 INFO - PROCESS | 23072 | _x_x_mozilla_cycle_collect,1932 11:17:37 INFO - PROCESS | 23072 | __end_cc_report 11:17:37 INFO - PROCESS | 23072 | __startTimestamp1481138257872__endTimestamp 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | ------- Summary: start ------- 11:17:37 INFO - PROCESS | 23072 | Number of tests: 14 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:1.79 (1.6%) stddev-sans-first:1.13 11:17:37 INFO - PROCESS | 23072 | Values: 111.0 115.0 116.0 116.0 114.0 116.0 115.0 118.0 115.0 115.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.00 stddev:12.46 (9.2%) stddev-sans-first:12.59 11:17:37 INFO - PROCESS | 23072 | Values: 150.0 133.0 131.0 167.0 133.0 134.0 136.0 130.0 150.0 128.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:2.01 (1.2%) stddev-sans-first:2.07 11:17:37 INFO - PROCESS | 23072 | Values: 161.0 164.0 167.0 163.0 163.0 162.0 162.0 161.0 160.0 161.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#3] audio-fft Cycles:10 Average:82.40 Median:78.00 stddev:11.35 (14.6%) stddev-sans-first:11.93 11:17:37 INFO - PROCESS | 23072 | Values: 78.0 78.0 78.0 111.0 78.0 77.0 78.0 76.0 94.0 76.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:10.26 (12.2%) stddev-sans-first:10.68 11:17:37 INFO - PROCESS | 23072 | Values: 85.0 84.0 105.0 84.0 85.0 84.0 105.0 84.0 83.0 106.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 11:17:37 INFO - PROCESS | 23072 | Values: 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:17:37 INFO - PROCESS | 23072 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:17:37 INFO - PROCESS | 23072 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:2.33 (3.5%) stddev-sans-first:2.44 11:17:37 INFO - PROCESS | 23072 | Values: 65.0 64.0 64.0 72.0 65.0 67.0 67.0 66.0 66.0 65.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 11:17:37 INFO - PROCESS | 23072 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 67.0 65.0 67.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:3.53 (4.1%) stddev-sans-first:3.69 11:17:37 INFO - PROCESS | 23072 | Values: 85.0 85.0 89.0 96.0 85.0 84.0 86.0 86.0 85.0 86.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:141.50 stddev:13.22 (9.3%) stddev-sans-first:13.91 11:17:37 INFO - PROCESS | 23072 | Values: 141.0 144.0 137.0 139.0 138.0 153.0 140.0 141.0 181.0 142.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:183.00 stddev:1.83 (1.0%) stddev-sans-first:1.94 11:17:37 INFO - PROCESS | 23072 | Values: 182.0 183.0 183.0 181.0 183.0 184.0 179.0 183.0 179.0 180.0 11:17:37 INFO - PROCESS | 23072 | 11:17:37 INFO - PROCESS | 23072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:1.94 (2.8%) stddev-sans-first:2.06 11:17:37 INFO - PROCESS | 23072 | Values: 71.0 71.0 75.0 70.0 74.0 70.0 70.0 70.0 70.0 69.0 11:17:37 INFO - PROCESS | 23072 | -------- Summary: end -------- 11:17:37 INFO - PROCESS | 23072 | 11:17:39 INFO - TEST-INFO | 23072: exit 0 11:17:39 INFO - TEST-OK | kraken | took 64832ms 11:17:39 INFO - SUITE-END | took 1187s 11:17:39 INFO - Completed test suite (00:19:48) 11:17:39 INFO - javascript benchmark 11:17:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.0, 2583.4962182374443, 2602.1022747152233, 2602.934926626834, 2623.317937336292, 4440.3561483584945, 4499.3026080957425, 4578.061497393031, 4607.769611519423, 4640.767961601919, 4551.522090180533, 4574.473935497419, 4590.977045114778, 4621.168189725848, 4669.929951050728, 4215.114825886568, 4228.112096459748, 4268.509121451042, 4295.119500502389, 4376.081022985177, 4208.179405016008, 4278.0, 4335.0679603885155, 4377.802998865059, 4424.446944131983, 4100.384942258685, 4138.751674899486, 4290.099079193373, 4325.610695037431, 4359.564043595647, 4170.020045289354, 4180.184863951531, 4180.226658068267, 4184.539700632928, 4186.811593478301, 4134.152498737782, 4154.626083652486, 4165.354370072643, 4165.812538435777, 4168.874933751992, 4474.284114541658, 4496.775161241958, 4501.909961800779, 4520.841770538015, 4568.840090596813, 4935.90128197434, 4936.80252789888, 4941.876453088666, 4982.153033984231, 4988.775505102279, 4951.62862785289, 4962.975185124087, 4963.280324352949, 4968.3292755477905, 5013.924791128136, 4484.506704262529, 4543.54564543543, 4578.748168850679, 4633.49031606523, 4684.391029166187, 4962.578180854668, 4970.254461830755, 4992.825251116194, 5000.724960127228, 5045.142325804622, 4754.02542478791, 4789.449213340441, 4791.47293797682, 4804.495527969582, 4839.879003024882, 4752.952470475251, 4793.448753393334, 4880.389951256093, 4880.6095512358925, 4928.014397120519, 4806.615470762331, 4862.367892173995, 4882.292067650171, 4912.803487860446, 4967.900641987212, 4897.412310522689, 4899.474913650294, 4901.754912254373, 4904.4605093439695, 4942.20924652054, 4273.316269396882, 4282.250606143913, 4290.399344091829, 4296.0978194578865, 4329.588689074533, 3609.4585812127866, 3630.7276954228537, 3642.763220390666, 3700.796456194935, 3701.0932321581386, 4286.292761694348, 4296.570342965741, 4318.762468064224, 4322.956770432318, 4337.652987760972, 4990.675606085593, 4992.975035124874, 5010.974945125251, 5011.799528018839, 5034.521720436553, 4080.8775736727944, 4097.836086556564, 4214.852480163241, 4270.0392411707735, 4276.5295817460055, 4493.123840851003, 4522.0, 4522.4346956630425, 4547.431571053618, 4561.908761824745, 4609.815607375667, 4611.700239484423, 4613.400257966443, 4647.976760116246, 4658.0, 4764.49972752856, 4816.686915350631, 4987.675801072919, 4988.850334489971, 4995.300657907823, 4510.413646225969, 4533.455985281787, 4555.40779698637, 4556.157110934488, 4630.536946305478, 4883.536064073907, 4885.560299572913, 4891.9755401222765, 4938.0, 4941.357623508921, 4897.2654101885, 4949.777260023379, 4950.108980383566, 4953.455119936732, 4956.430010548689, 4650.4186976627925, 4706.741129237925, 4710.246360582428, 4770.904581908412, 4862.756862156807, 4719.150552900511, 4736.100140973204, 4743.810247590058, 4747.454042785124, 4747.596454301423, 4641.164590373765, 4643.930341044819, 4648.163330600389, 4657.417822772153, 4657.790399432101, 4747.596454301423, 4785.521447855187, 4786.497417771223, 4793.4247890252, 4798.0403919217, 4687.695299805502, 4696.647751418725, 4702.482726900107, 4703.247480403119, 4704.882377940579], "value": 4514.211255064461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1274468201946, 576.3429690153229, 582.2401765695768, 584.8713283077724, 589.4665327878272, 36585.99999999996, 37620.81189594052, 37646.62353376469, 41703.165936681246, 41703.79148104263, 39125.0, 39462.210755784865, 39564.0, 39603.40594891072, 39626.8018659907, 7345.1553071396675, 7521.774346769578, 7584.582847943375, 7744.612769361509, 7745.070591529025, 9454.29092818038, 9715.854262186072, 9727.416355018686, 9997.850032249522, 9999.050090241451, 9884.752881177956, 9916.157126644244, 9950.203983681287, 9952.0, 9953.75115622108, 9869.457179855106, 9887.555060022316, 9900.851487227697, 9977.850332244985, 9982.0, 9648.469334186617, 9716.659916902945, 9716.902830971741, 9739.220862330996, 9742.0, 36893.262134757424, 37039.629603704154, 37066.814665926766, 37186.62813371859, 37195.62804371949, 2717.728227177286, 2721.2244510314663, 2783.485055264762, 2827.802053856231, 3111.9066428007195, 27164.32089197786, 27285.590716139275, 27321.590176147372, 27704.168874933785, 27936.58095128575, 3334.333133373335, 3336.466165413522, 3408.522806807049, 3545.574531056264, 3574.4995700601935, 249677.0, 250510.99999999817, 252569.0, 253025.0, 253516.1972570413, 51755.0, 52319.0, 52396.47603523916, 52410.21384679233, 52464.47535524672, 55912.440875591536, 56178.43821561814, 56191.71904140453, 56200.43799562034, 56243.15635265474, 11384.373859437645, 11489.597864074718, 11490.138239631893, 11501.309921404743, 11514.76970460586, 8032.598370081472, 8194.09864914859, 8199.098099209083, 8311.085780564134, 8389.45468544555, 15777.368905243662, 17679.38122165718, 18043.0, 18081.547961301072, 18896.52758681044, 6453.806385808433, 6962.762315523306, 6980.406665433495, 7137.858642407257, 7148.714051437988, 764.6176911544228, 876.6099085906837, 902.0618556701089, 917.9764562512751, 963.4784861331843, 26209.868950655124, 26629.86685066562, 27007.974401919935, 27335.86332068327, 27446.45107097847, 869.426178722053, 899.5457294066586, 906.3021473465395, 919.9448033118034, 923.5197697197555, 14076.436942522185, 14214.644633884236, 14368.312818525965, 14430.134191948517, 14633.12201267906, 357084.0, 360779.0, 361219.0, 361412.0, 362495.0, 48095.0, 48293.517064829604, 48504.75747621239, 48557.757211214426, 48676.0, 1123.1913022623535, 1144.959926402572, 1150.7986102432042, 1169.2984209474248, 1175.7413369058793, 25361.619575706747, 26044.0, 26534.336641584116, 26662.867825313464, 26789.8660506704, 41299.52202867837, 45048.324275136554, 46312.53687463082, 50120.49879501158, 50338.49661503485, 318484.0, 321261.0, 321720.0, 321811.0, 321850.0, 31681.20796980094, 31878.0, 33791.3241735159, 36807.0, 37359.81320093382, 38744.418833716954, 39259.6074039256, 39672.40491392574, 40087.59912400955, 40247.19505609813, 33804.3239135211, 34341.0, 34487.137821554665, 34505.0, 34547.0, 34705.82647086748, 35316.47025294571, 35346.293074138885, 35429.0, 35865.28269434544, 34507.13732156716, 34629.653703462645, 34868.476972845936, 35166.0, 35412.46881296834, 29744.702552975057, 32364.676353237108, 32449.351012979136, 32457.51313730249, 32486.18784530311, 23938.0, 24377.878110609334, 24481.51036979286, 24596.87434799433, 24891.875540622183], "value": 17527.911140188953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.13488481124415, 363.46389076112735, 367.8344744864811, 370.2724147051045, 380.7144641518861, 12268.81596776048, 13297.401616927238, 13992.160470371771, 16225.432109876157, 16908.323667053304, 15143.0, 16306.347746090172, 16754.246058927347, 16838.0, 16874.493765187035, 4725.952740472603, 5117.616178786588, 5150.922736158961, 5155.71643559604, 5156.381234251895, 3722.571904231021, 3905.0, 5034.798608055673, 5140.228965655163, 5142.0, 3916.4516967624554, 3936.7047471439755, 3974.4237085622567, 5913.438223368773, 6041.9697901510435, 6033.758649654009, 6045.758169673208, 6048.092786082079, 6052.485538729169, 6062.060380641008, 5093.872653183663, 5207.114790485589, 5233.345831771028, 5239.083160446945, 5240.371155461369, 20037.1985120595, 20113.497162571053, 20220.69668954967, 20238.190472381088, 20305.0, 1886.462358227912, 1938.9709154362695, 1941.2817257614772, 1991.6713742232514, 2011.8289945354663, 12564.183328083645, 13150.736985260337, 13202.801957970638, 13309.467621295136, 13659.385327660279, 1673.1801417305555, 1690.754840548126, 1693.745938109281, 1706.8037175724703, 1767.531604124908, 63987.0, 64302.0, 65368.3463165367, 66381.0, 66874.33125668729, 9373.578188981512, 9517.952410237904, 9745.707628771148, 9763.26775491841, 9876.308658393988, 13256.801147982787, 13257.403416846266, 13305.0, 13311.73376532464, 13312.134711243738, 6345.428911397997, 6500.317466666026, 6536.934630653633, 6735.057092007123, 6738.561993470409, 6020.0, 6076.447891885418, 6208.782692605828, 6285.402886725754, 6297.842553936188, 5857.502112320415, 6018.608790428608, 6042.012271900525, 6074.088886667036, 6217.160683307786, 1627.5686942960126, 1698.388580111159, 1700.2858799304074, 1705.714342780655, 1714.4342367018853, 850.1540966738012, 869.3479890082439, 936.4100616611491, 944.8677185194078, 953.2897990996613, 16250.837491624932, 16314.184290785413, 17374.565635859206, 17409.129543522773, 17757.289708411776, 837.937154713399, 849.3120572336304, 858.206159302655, 870.8127752533109, 884.4030279561271, 8957.462552246887, 9731.0, 9818.459984700767, 9826.80346393068, 9842.212622990144, 343045.0, 347935.0, 348851.0, 351458.0, 356089.0, 54649.72675136599, 70193.01429235608, 70952.0, 78926.60536697395, 79378.60310698525, 882.148726478951, 915.7847905742012, 939.6100618243489, 941.580996456584, 944.5418971798672, 15188.620284492976, 15195.199096582863, 15701.607459813597, 16018.67962640764, 16093.436729714404, 35057.47413788744, 35148.64851351556, 35816.46275305925, 36075.81962090278, 37027.0, 45782.0, 49780.0, 50749.0, 53109.46890531045, 53434.46565534295, 7252.606639808956, 7352.595607241653, 7375.963120184365, 7503.924960750541, 7580.4693671444675, 10117.645882394081, 11470.139739519736, 11513.942430287794, 11806.173567850168, 11835.467403967014, 9959.0, 10131.949340253252, 10470.633527826489, 10569.788604227719, 10762.677119686421, 9682.225421966084, 10034.147097496794, 10071.395716257048, 10264.0, 10264.281500294908, 10181.33821301613, 10300.278980471594, 10413.895861041292, 10524.789504210026, 10803.297785643908, 6952.582845029315, 7094.716211351488, 7135.607541585055, 7391.889121663072, 7407.62961851916, 8481.745547633582, 9442.669506567237, 9774.706758796963, 10161.847572286273, 10503.789924201626], "value": 8096.863689917746, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.2481935657963, 1277.4826195390865, 1308.888744456721, 1601.1193843386134, 1627.8941868778536, 5902.288336382455, 6104.481119104881, 6605.933940660592, 7003.7898863034125, 7031.824204394893, 6549.934500655004, 6779.0, 6791.252962174157, 6951.2701166377565, 6954.687039083241, 2017.132632967827, 2054.5274586845035, 2054.8664336818133, 2056.4036429435446, 2057.711920331155, 1758.551569349814, 2023.6053969475959, 2055.5169535159225, 2059.979400206001, 2069.668852983523, 1739.9739003914888, 1944.4361135270753, 2007.42788305333, 2009.0657844102489, 2018.2330714328534, 1935.1775495414392, 1938.932137375192, 1942.669746143152, 1947.9707804382945, 1951.5511432370633, 2018.7779344272265, 2024.7165396844307, 2029.046348216336, 2039.6328660841043, 2041.9489512762152, 6832.795016149524, 6998.6500674966555, 7000.544964577286, 7007.929920700779, 7013.649317534103, 4013.478247827793, 4130.401091841666, 4130.504339479252, 4133.731307465006, 4134.875953721363, 2597.59737240728, 2757.241758516404, 2827.9010234641687, 2842.2325971987652, 2845.260232339607, 857.3569822633025, 866.9783255418602, 891.7948871759467, 898.0211569389397, 915.8259930613228, 8937.285017198608, 8973.730788076367, 8997.640094396216, 9002.504862232574, 9018.819623607556, 3604.2250916053176, 3822.617738226211, 3894.045958740127, 3922.9019274518364, 3953.683705303569, 7913.920860791433, 7923.247291507298, 7925.484843485155, 7927.445078844541, 7928.643211055516, 4214.0, 4215.641670457984, 4221.87334379963, 4222.683298752606, 4223.556526564728, 3764.5858955514873, 3871.070942973666, 3872.4384964180035, 3872.6901847852105, 3875.9418608720894, 3362.764606477523, 3364.7139993100373, 3406.744494162948, 3474.7915125092577, 3475.0443628002504, 994.2543092680489, 1147.1224513247373, 1149.3793351590216, 1168.4683469021575, 1170.239344426113, 649.7368565730792, 732.1799584465433, 735.8785800342883, 740.2190688823343, 762.0969151555424, 4671.976640116845, 4787.808487660454, 4793.472718001017, 4794.424669039738, 4802.183628783116, 844.1684940333889, 857.7341024282492, 878.2534845381375, 879.4942907828024, 882.0870399136862, 3265.346930613887, 3278.4426647469986, 3319.751018673609, 3331.4503106987077, 3411.0, 7912.129665736765, 8379.413441059189, 8386.412951093365, 8387.874181887277, 8392.03491598474, 8157.5976743953825, 8319.542425166674, 8335.416520843604, 8337.749867503984, 8391.286740627114, 6473.28793832678, 6559.114519539801, 6564.081028655992, 6567.2447668518735, 6568.339822371947, 4545.159145558082, 4575.17646823575, 4625.722456652612, 4652.371929789435, 4680.7191568506, 7582.582957937146, 7590.127135379502, 7595.772126836204, 7658.2724641159, 7661.693532258647, 7598.658060387185, 7778.416618753729, 7829.099653539915, 7846.686132554634, 7872.527648341118, 5643.689597072201, 5661.150827375926, 5678.0915053591225, 5700.686462244616, 5703.258576385209, 6524.1518602583255, 6557.0, 6582.605043697394, 6595.076689263603, 6600.8349791255605, 5755.683437410815, 5766.481016708516, 5901.527877769854, 5939.376365481735, 5994.6403215807195, 5816.82549523515, 5881.470667639933, 5959.0, 6009.338972713085, 6024.759009639565, 5528.4471552846, 5644.153376993484, 5645.661260324394, 5647.689377084135, 5650.180723795109, 3924.3328634131694, 4049.6152865477734, 4116.835326586903, 4149.854755083557, 4180.979095104505, 4189.581041895786, 4191.790410479402, 4228.175505776344, 4230.746155230696, 4248.107897341592], "value": 3726.5481700358814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.3134039539568, 275.866204890628, 277.956916677915, 292.2547503865144, 294.6876311110223, 4691.882702932428, 4802.055167657096, 4834.178189707749, 4857.587105096067, 4891.633127515437, 4656.906861862761, 4735.597474214687, 4745.596624286931, 4747.76261186941, 4792.3290739296435, 3718.1819999600043, 3736.30878287517, 3736.841579110471, 3742.251549690059, 3755.9436608450897, 3689.926201475969, 3725.310817498758, 3729.981350093259, 3737.3459644562095, 3751.5498140223212, 3469.219425629226, 3475.287566048954, 3699.2971335446177, 3733.2720119576693, 3768.491253680759, 3735.514383130203, 3747.7819708594543, 3748.418995055757, 3749.6062913393976, 3756.5492140943124, 3318.634950155481, 3323.6344002159744, 3326.617438994522, 3329.250918543333, 3335.7331413486863, 4549.704269222523, 4647.326137710013, 4665.930011049837, 4669.365721997307, 4681.508441613616, 4291.442112525383, 4303.160883627694, 4314.331278651814, 4356.607905288539, 4357.128574285156, 4989.975050124763, 4992.700437973734, 4997.375852847803, 5020.523050310215, 5023.296738456583, 3659.1218107654236, 3665.5784584772828, 3665.725070619714, 3671.834767435472, 3683.7605555638797, 5115.462876397999, 5213.165893457104, 5237.659552129099, 5246.632735708502, 5261.710605916673, 3738.6261373862394, 3745.382011968049, 3755.4179102239195, 3774.226283611853, 3779.9244015120094, 3788.484606157504, 3799.7340186187253, 3802.866899658499, 3806.4861243731743, 3844.4041173618134, 4016.59834016596, 4221.767802770815, 4278.593533614302, 4285.37862010013, 4296.82812687489, 5067.986402719471, 5070.670406423571, 5071.137906555894, 5085.516875896784, 5086.491350864958, 1181.2381014245764, 1222.541546919905, 1223.3760782001243, 1226.3500344817262, 1231.1135982092878, 803.5700900018462, 833.8874251976027, 835.9300095877287, 841.9705310314232, 843.6836186430089, 4247.851325203665, 4267.807948642257, 4299.828006879689, 4306.354046892991, 4307.203167414038, 5030.119729047402, 5034.521720436553, 5044.697318160849, 5048.192289233779, 5061.44324124346, 4038.374052021941, 4281.165172791276, 4299.849505267301, 4307.892302692458, 4315.525292217853, 2663.7735792457856, 2676.8260063095836, 2678.665166854143, 2683.5035518429154, 2685.2481305234564, 4605.802491352206, 4639.118567472237, 4651.139539185261, 4662.857599888049, 4685.695429797052, 4774.474807771142, 5070.670406423645, 5078.060558796635, 5097.8725531862, 5140.254663073833, 4593.609543188866, 4609.354690343354, 4613.215753321876, 4654.953450465519, 4666.090112428112, 4950.430700469348, 4962.578180854523, 5019.949800501949, 5023.899522009612, 5025.572826309804, 4653.325267836212, 4857.489963553918, 4896.534829191221, 4898.093852637274, 4908.190148625579, 4604.355390245435, 4635.768211589474, 4635.93046104302, 4638.234691275901, 4642.2340313847835, 3493.5458390409085, 3504.281622267378, 3535.3282876254457, 3539.5221645077586, 3545.8936231913085, 4781.402324709411, 4867.685724854198, 4956.900861982812, 4979.900401992012, 4998.700077995332, 4836.274558816206, 4857.465678775403, 4861.246506791453, 4874.2444921037295, 4876.244182151772, 4773.71357718538, 4869.0, 4898.142825005681, 4909.803607855646, 4928.940277840282, 4673.719576825401, 4759.3574867393845, 4789.61683065347, 4833.347498087714, 4844.563989240985, 5113.207452844815, 5125.461826508163, 5178.97410512945, 5183.0670479314085, 5191.195364718475, 4998.575121114746, 5017.0, 5031.547160755549, 5038.370203724535, 5074.564209179688], "value": 3726.632320744187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4301827791013, 615.9291681456631, 624.7938180400469, 669.5112567825485, 690.9965450172748, 11670.708232294197, 14652.560423187308, 15041.172735499544, 15089.547313580582, 15801.920990395061, 15532.534023979299, 15628.218589070559, 15689.686206275868, 15786.921065394657, 15798.0, 627.6077451592755, 745.9850802983937, 751.9398448124165, 754.7245255481737, 756.5611945071872, 588.2206076948039, 594.8958932186872, 606.4844881850436, 632.0992585565574, 645.8579112595221, 821.6877586517115, 823.6705317872838, 824.3487644760631, 824.3775949158377, 826.2274773087182, 650.4211251985737, 816.4529765057425, 816.5672193737329, 817.8527864984301, 818.423011776696, 491.68777826080697, 578.7974209026806, 593.3769541980903, 593.4006653280175, 593.717983957621, 13513.0, 13523.188608683413, 13566.525171618947, 13568.321583920862, 13577.728445431136, 12314.753704925852, 12479.812802807874, 12634.13324316531, 12675.17611355259, 13017.934910325483, 10226.23303252259, 10489.370637761682, 10716.678499645022, 11125.499352529156, 11187.384693841836, 3285.852136653856, 3286.1861607520923, 3348.7488438366977, 3354.194993201638, 3414.0611331883683, 66889.3311066888, 67189.0, 67866.66066669684, 69220.0, 69465.58016297595, 9608.0, 9665.90334096664, 9682.322237443312, 9913.256505762096, 10043.748906277255, 13727.245001525012, 13846.723065538632, 14439.92780036093, 14534.401215866246, 14551.345189466289, 6411.935880641134, 6480.935190648128, 6542.672866356663, 6717.664116794141, 6814.114165158498, 3555.235624340779, 3638.381475149231, 3679.2273622539033, 3697.815109244527, 3713.8514459421863, 2633.947321053568, 2666.5733482642686, 2677.8794954227105, 2720.591911213334, 2736.835789852615, 464.5633104881401, 465.53446553446554, 469.16488650202695, 475.63613835415936, 478.643046961867, 533.5944682041676, 561.1218443136478, 562.6258538072218, 564.5173376762891, 565.5334349161958, 7967.123616402191, 8403.495790252604, 8482.618282177316, 8553.786155346166, 8623.611937462703, 492.4951924277644, 507.79434329096773, 531.9973400133052, 543.4782608695697, 552.1193696054786, 3661.4690869823726, 3971.900702482403, 3989.4614227079555, 4019.7789121598007, 4125.628693417607, 57339.0, 60514.69742651258, 71682.64158679174, 73930.63034684792, 73988.0, 59218.703906480194, 59835.70082149649, 60074.09888851671, 60778.39221607816, 61672.0, 56615.43384566184, 56747.0, 56824.715876420356, 57728.711356442946, 58512.707436462544, 7126.786196414116, 7282.817929551804, 7491.475596708178, 7640.3505702015955, 7946.125926148004, 39630.60369396384, 39981.2017858303, 40027.59972400355, 40627.79686101551, 40793.79603101966, 45107.0, 51368.48631513637, 51441.485585143666, 52934.0, 55690.16464753113, 9250.95374523123, 9308.255339572954, 9579.037800687207, 9670.178034866834, 9896.752581185528, 11497.712557186138, 11591.826122608, 11976.341301228516, 12073.517059317528, 12117.757644846877, 9766.121049105615, 9992.950035250067, 10511.316764410289, 10527.526261318106, 10542.367457952547, 10419.114375278186, 10912.181586381212, 11074.723131921444, 11125.944370278097, 11169.0, 9830.0, 9866.0, 9894.257930655085, 10237.436940968319, 10421.583136674448, 8759.737207883774, 8969.37214394986, 9031.50326732036, 9259.398064171079, 9269.629214831331, 8263.876041859257, 8814.382993190415, 9024.503652299187, 9063.410878293154, 9619.230461563198], "value": 6069.599241416661, "unit": "score"}], "name": "dromaeo_css", "value": 6148.152004542965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 116.0, 116.0, 114.0, 116.0, 115.0, 118.0, 115.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 131.0, 167.0, 133.0, 134.0, 136.0, 130.0, 150.0, 128.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 167.0, 163.0, 163.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 111.0, 78.0, 77.0, 78.0, 76.0, 94.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 84.0, 85.0, 84.0, 105.0, 84.0, 83.0, 106.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "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, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 72.0, 65.0, 67.0, 67.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 96.0, 85.0, 84.0, 86.0, 86.0, 85.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 137.0, 139.0, 138.0, 153.0, 140.0, 141.0, 181.0, 142.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 181.0, 183.0, 184.0, 179.0, 183.0, 179.0, 180.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 75.0, 70.0, 74.0, 70.0, 70.0, 70.0, 70.0, 69.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1565.0, "alertThreshold": 2.0}]} 11:17:39 INFO - Return code: 0 11:17:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:39 INFO - # TBPL SUCCESS # 11:17:39 INFO - Running post-action listener: _resource_record_post_action 11:17:39 INFO - [mozharness: 2016-12-07 19:17:39.695337Z] Finished run-tests step (success) 11:17:39 INFO - Running post-run listener: _resource_record_post_run 11:17:39 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390631424; Read time: 184; Write time: 257664 11:17:39 INFO - TinderboxPrint: CPU usage
13.1% 11:17:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 11:17:39 INFO - TinderboxPrint: I/O write bytes / time
390,631,424 / 257,664 11:17:39 INFO - TinderboxPrint: CPU idle
8,352.4 (86.9%) 11:17:39 INFO - TinderboxPrint: CPU user
1,210.9 (12.6%) 11:17:39 INFO - TinderboxPrint: Swap in / out
0 / 0 11:17:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99803136; Read time: 0; Write time: 65812 11:17:39 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290828288; Read time: 184; Write time: 191852 11:17:40 INFO - Running post-run listener: _upload_blobber_files 11:17:40 INFO - Blob upload gear active. 11:17:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:17:40 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:17:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:41 INFO - (blobuploader) - INFO - Done attempting. 11:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:42 INFO - (blobuploader) - INFO - Done attempting. 11:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:46 INFO - (blobuploader) - INFO - Done attempting. 11:17:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:46 INFO - Return code: 0 11:17:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7683b5be853b2ddd00c50f7e724a0c8b6260bf35af5806284dc4aab5af22ba9c8ef4ef570356c978421404598fb9bcce217acc19017939afe865e14db25a84cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8ecdc8a1fa3d5b2495e80365a914919d34b51efd76eaad4922eff2e60a8de912164483b255b104f1a2ff582429139ec479159688f14bd52aa3910b137aaf2e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/19f3d4f08bbe16d0b193d37b0605a956e344a031657d85b8edd577113cd9101f85c725293f6af4805e9d6407fe68297c0c3a8f3a6b1774e24b02e2184854ffa0"} 11:17:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:46 INFO - Contents: 11:17:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7683b5be853b2ddd00c50f7e724a0c8b6260bf35af5806284dc4aab5af22ba9c8ef4ef570356c978421404598fb9bcce217acc19017939afe865e14db25a84cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8ecdc8a1fa3d5b2495e80365a914919d34b51efd76eaad4922eff2e60a8de912164483b255b104f1a2ff582429139ec479159688f14bd52aa3910b137aaf2e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/19f3d4f08bbe16d0b193d37b0605a956e344a031657d85b8edd577113cd9101f85c725293f6af4805e9d6407fe68297c0c3a8f3a6b1774e24b02e2184854ffa0"} 11:17:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:46 INFO - Copying logs to upload dir... 11:17:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.999835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-07 11:17:45.596609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 11:17:45.599911) ========= 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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7683b5be853b2ddd00c50f7e724a0c8b6260bf35af5806284dc4aab5af22ba9c8ef4ef570356c978421404598fb9bcce217acc19017939afe865e14db25a84cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8ecdc8a1fa3d5b2495e80365a914919d34b51efd76eaad4922eff2e60a8de912164483b255b104f1a2ff582429139ec479159688f14bd52aa3910b137aaf2e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/19f3d4f08bbe16d0b193d37b0605a956e344a031657d85b8edd577113cd9101f85c725293f6af4805e9d6407fe68297c0c3a8f3a6b1774e24b02e2184854ffa0"} build_url:https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011643 build_url: 'https://queue.taskcluster.net/v1/task/Ro-eTrrMSzeXGvHojxowYQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7683b5be853b2ddd00c50f7e724a0c8b6260bf35af5806284dc4aab5af22ba9c8ef4ef570356c978421404598fb9bcce217acc19017939afe865e14db25a84cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8ecdc8a1fa3d5b2495e80365a914919d34b51efd76eaad4922eff2e60a8de912164483b255b104f1a2ff582429139ec479159688f14bd52aa3910b137aaf2e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/19f3d4f08bbe16d0b193d37b0605a956e344a031657d85b8edd577113cd9101f85c725293f6af4805e9d6407fe68297c0c3a8f3a6b1774e24b02e2184854ffa0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 11:17:45.627439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 11:17:45.628158) ========= 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=14ef55db36f7623abb31b9cf000001d5-1481131896.233089-1875086689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 11:17:45.709387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 11:17:45.709707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 11:17:45.709989) ========= ========= Total master_lag: 0.18 =========