builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1479955515.36 results: success (0) buildid: 20161123154536 builduid: 98ae40deb2de40bd82816c91a2a19527 revision: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.359244) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.359707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.360012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.374736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.375055) ========= 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=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 18:45:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-11-23 18:45:15 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.480747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.481074) ========= 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=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.530706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:15.531054) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 --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=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 18:45:15,686 truncating revision to first 12 chars 2016-11-23 18:45:15,686 Setting DEBUG logging. 2016-11-23 18:45:15,686 attempt 1/10 2016-11-23 18:45:15,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f8cd956e52d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 18:45:16,057 unpacking tar archive at: mozilla-beta-f8cd956e52d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:16.290564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:16.290880) ========= script_repo_revision: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:16.291259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:16.291521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:45:16.300536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-23 18:45:16.300828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:16 INFO - MultiFileLogger online at 20161123 18:45:16 in /builds/slave/test 18:45:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:45:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:16 INFO - {'append_to_log': False, 18:45:16 INFO - 'base_work_dir': '/builds/slave/test', 18:45:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:45:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:16 INFO - 'branch': 'Mozilla-Beta', 18:45:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:16 INFO - 'config_files': ('talos/linux_config.py',), 18:45:16 INFO - 'default_actions': ('clobber', 18:45:16 INFO - 'read-buildbot-config', 18:45:16 INFO - 'download-and-extract', 18:45:16 INFO - 'populate-webroot', 18:45:16 INFO - 'create-virtualenv', 18:45:16 INFO - 'install', 18:45:16 INFO - 'run-tests'), 18:45:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:16 INFO - 'download_minidump_stackwalk': True, 18:45:16 INFO - 'download_symbols': 'ondemand', 18:45:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:16 INFO - 'installer_path': 'installer.exe', 18:45:16 INFO - 'log_level': 'info', 18:45:16 INFO - 'log_name': 'talos', 18:45:16 INFO - 'log_to_console': True, 18:45:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:16 INFO - 'opt_config_files': (), 18:45:16 INFO - 'pip_index': False, 18:45:16 INFO - 'sps_profile': False, 18:45:16 INFO - 'sps_profile_interval': 0, 18:45:16 INFO - 'suite': 'dromaeojs', 18:45:16 INFO - 'system_bits': '32', 18:45:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:16 INFO - 'title': 'talos-linux64-ix-028', 18:45:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:16 INFO - 'use_talos_json': True, 18:45:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:16 INFO - 'work_dir': 'build'} 18:45:16 INFO - [mozharness: 2016-11-24 02:45:16.554500Z] Running clobber step. 18:45:16 INFO - Running pre-action listener: _resource_record_pre_action 18:45:16 INFO - Running main action method: clobber 18:45:16 INFO - rmtree: /builds/slave/test/build 18:45:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:45:17 INFO - Running post-action listener: _resource_record_post_action 18:45:17 INFO - [mozharness: 2016-11-24 02:45:17.012194Z] Finished clobber step (success) 18:45:17 INFO - [mozharness: 2016-11-24 02:45:17.012295Z] Running read-buildbot-config step. 18:45:17 INFO - Running pre-action listener: _resource_record_pre_action 18:45:17 INFO - Running main action method: read_buildbot_config 18:45:17 INFO - Using buildbot properties: 18:45:17 INFO - { 18:45:17 INFO - "project": "", 18:45:17 INFO - "product": "firefox", 18:45:17 INFO - "script_repo_revision": "production", 18:45:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:45:17 INFO - "repository": "", 18:45:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:45:17 INFO - "buildid": "20161123154536", 18:45:17 INFO - "pgo_build": "True", 18:45:17 INFO - "basedir": "/builds/slave/test", 18:45:17 INFO - "buildnumber": 475, 18:45:17 INFO - "slavename": "talos-linux64-ix-028", 18:45:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:45:17 INFO - "platform": "ubuntu64_hw", 18:45:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:45:17 INFO - "branch": "mozilla-beta", 18:45:17 INFO - "repo_path": "releases/mozilla-beta", 18:45:17 INFO - "revision": "f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32", 18:45:17 INFO - "stage_platform": "linux64-pgo", 18:45:17 INFO - "builduid": "98ae40deb2de40bd82816c91a2a19527", 18:45:17 INFO - "slavebuilddir": "test" 18:45:17 INFO - } 18:45:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 18:45:17 INFO - Running post-action listener: _resource_record_post_action 18:45:17 INFO - [mozharness: 2016-11-24 02:45:17.014750Z] Finished read-buildbot-config step (success) 18:45:17 INFO - [mozharness: 2016-11-24 02:45:17.014839Z] Running download-and-extract step. 18:45:17 INFO - Running pre-action listener: _resource_record_pre_action 18:45:17 INFO - Running main action method: download_and_extract 18:45:17 INFO - mkdir: /builds/slave/test/build/tests 18:45: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')]} 18:45:17 INFO - trying https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:45:17 INFO - Downloading https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:45:17 INFO - Downloaded 1327 bytes. 18:45:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:45:17 INFO - Using the following test package requirements: 18:45:17 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:45:17 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:45:17 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 18:45:17 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'jsshell-linux-x86_64.zip'], 18:45:17 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:45:17 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:45:17 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 18:45:17 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 18:45:17 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:45:17 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:45:17 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:45:17 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:45:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:45:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:45:17 INFO - Fetch https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:45:18 INFO - Expected file size: 21963761 18:45:22 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:45:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:45:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:45:22 INFO - Fetch https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:45:22 INFO - Expected file size: 21963761 18:45:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 18:45:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:45:27 INFO - Fetch https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 18:45:28 INFO - Expected file size: 14414089 18:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:28 INFO - trying https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:45:28 INFO - Downloading https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:45:29 INFO - Downloaded 56974260 bytes. 18:45:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:45:29 INFO - mkdir: /builds/slave/test/properties 18:45:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:45:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:45:29 INFO - Contents: 18:45:29 INFO - build_url:https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:45:30 INFO - Running post-action listener: _resource_record_post_action 18:45:30 INFO - Running post-action listener: set_extra_try_arguments 18:45:30 INFO - [mozharness: 2016-11-24 02:45:30.309716Z] Finished download-and-extract step (success) 18:45:30 INFO - [mozharness: 2016-11-24 02:45:30.309945Z] Running populate-webroot step. 18:45:30 INFO - Running pre-action listener: _resource_record_pre_action 18:45:30 INFO - Running main action method: populate_webroot 18:45:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:45:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:45:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:45:30 INFO - '--tppagecycles', 18:45:30 INFO - '7'], 18:45:30 INFO - 'tests': ['tsvgm']}}, 18:45:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:45:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:45:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:45:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:45:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['damp', 'tps']}, 18:45:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'tests': ['damp', 'tps']}, 18:45:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['dromaeo_dom']}, 18:45:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:45:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['basic_compositor_video']}, 18:45:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:45:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'other-e10s': {'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['a11yr', 18:45:30 INFO - 'ts_paint', 18:45:30 INFO - 'tpaint', 18:45:30 INFO - 'sessionrestore', 18:45:30 INFO - 'sessionrestore_no_auto_restore', 18:45:30 INFO - 'tabpaint']}, 18:45:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['tsvgx', 18:45:30 INFO - 'tsvgr_opacity', 18:45:30 INFO - 'tart', 18:45:30 INFO - 'tscrollx', 18:45:30 INFO - 'cart']}, 18:45:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:45:30 INFO - 'tsvgr_opacity', 18:45:30 INFO - 'tart', 18:45:30 INFO - 'tscrollx', 18:45:30 INFO - 'cart']}, 18:45:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'talos_options': ['--disable-e10s'], 18:45:30 INFO - 'tests': ['tp5o']}, 18:45:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'tests': ['tp5o']}, 18:45:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'talos_options': ['--disable-e10s', 18:45:30 INFO - '--xperf_path', 18:45:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:30 INFO - 'tests': ['tp5n']}, 18:45:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:30 INFO - 'talos_options': ['--xperf_path', 18:45:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:30 INFO - 'tests': ['tp5n']}}, 18:45:30 INFO - 'talos.zip': {'path': '', 18:45:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:45:30 INFO - Running post-action listener: _resource_record_post_action 18:45:30 INFO - [mozharness: 2016-11-24 02:45:30.327944Z] Finished populate-webroot step (success) 18:45:30 INFO - [mozharness: 2016-11-24 02:45:30.328039Z] Running create-virtualenv step. 18:45:30 INFO - Running pre-action listener: _resource_record_pre_action 18:45:30 INFO - Running main action method: create_virtualenv 18:45:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:45:30 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 18:45:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:45:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:45:30 INFO - Using real prefix '/usr' 18:45:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 18:45:32 INFO - Installing pip.................done. 18:45:32 INFO - Return code: 0 18:45:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:32 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:32 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 18:45:32 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 18:45:32 INFO - Using env: {'DISPLAY': ':0', 18:45:32 INFO - 'HOME': '/home/cltbld', 18:45:32 INFO - 'LANG': 'en_US.UTF-8', 18:45:32 INFO - 'LANGUAGE': 'en_US:en', 18:45:32 INFO - 'LOGNAME': 'cltbld', 18:45:32 INFO - 'MAIL': '/var/mail/cltbld', 18:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:32 INFO - 'MOZ_NO_REMOTE': '1', 18:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:32 INFO - 'NO_EM_RESTART': '1', 18:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:32 INFO - 'PWD': '/builds/slave/test', 18:45:32 INFO - 'SHELL': '/bin/bash', 18:45:32 INFO - 'SHLVL': '1', 18:45:32 INFO - 'TERM': 'linux', 18:45:32 INFO - 'TMOUT': '86400', 18:45:32 INFO - 'USER': 'cltbld', 18:45:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:32 INFO - '_': '/tools/buildbot/bin/python'} 18:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:33 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 18:45:33 INFO - Cleaning up... 18:45:33 INFO - Return code: 0 18:45:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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', '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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:45: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 psutil>=3.1.1 18:45:33 INFO - Using env: {'DISPLAY': ':0', 18:45:33 INFO - 'HOME': '/home/cltbld', 18:45:33 INFO - 'LANG': 'en_US.UTF-8', 18:45:33 INFO - 'LANGUAGE': 'en_US:en', 18:45:33 INFO - 'LOGNAME': 'cltbld', 18:45:33 INFO - 'MAIL': '/var/mail/cltbld', 18:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:33 INFO - 'MOZ_NO_REMOTE': '1', 18:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:33 INFO - 'NO_EM_RESTART': '1', 18:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:33 INFO - 'PWD': '/builds/slave/test', 18:45:33 INFO - 'SHELL': '/bin/bash', 18:45:33 INFO - 'SHLVL': '1', 18:45:33 INFO - 'TERM': 'linux', 18:45:33 INFO - 'TMOUT': '86400', 18:45:33 INFO - 'USER': 'cltbld', 18:45:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:33 INFO - '_': '/tools/buildbot/bin/python'} 18:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:33 INFO - Downloading/unpacking psutil>=3.1.1 18:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:35 INFO - Installing collected packages: psutil 18:45:35 INFO - Running setup.py install for psutil 18:45:35 INFO - building 'psutil._psutil_linux' extension 18:45:35 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 18:45:35 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 18:45:35 INFO - building 'psutil._psutil_posix' extension 18:45:35 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 18:45:35 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 18:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:35 INFO - Successfully installed psutil 18:45:35 INFO - Cleaning up... 18:45:35 INFO - Return code: 0 18:45:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:45:35 INFO - Using env: {'DISPLAY': ':0', 18:45:35 INFO - 'HOME': '/home/cltbld', 18:45:35 INFO - 'LANG': 'en_US.UTF-8', 18:45:35 INFO - 'LANGUAGE': 'en_US:en', 18:45:35 INFO - 'LOGNAME': 'cltbld', 18:45:35 INFO - 'MAIL': '/var/mail/cltbld', 18:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:35 INFO - 'MOZ_NO_REMOTE': '1', 18:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:35 INFO - 'NO_EM_RESTART': '1', 18:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:35 INFO - 'PWD': '/builds/slave/test', 18:45:35 INFO - 'SHELL': '/bin/bash', 18:45:35 INFO - 'SHLVL': '1', 18:45:35 INFO - 'TERM': 'linux', 18:45:35 INFO - 'TMOUT': '86400', 18:45:35 INFO - 'USER': 'cltbld', 18:45:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:35 INFO - '_': '/tools/buildbot/bin/python'} 18:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:45:38 INFO - Installing collected packages: mozsystemmonitor 18:45:38 INFO - Running setup.py install for mozsystemmonitor 18:45:38 INFO - Successfully installed mozsystemmonitor 18:45:38 INFO - Cleaning up... 18:45:38 INFO - Return code: 0 18:45:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:38 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:38 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 18:45:38 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 18:45:38 INFO - Using env: {'DISPLAY': ':0', 18:45:38 INFO - 'HOME': '/home/cltbld', 18:45:38 INFO - 'LANG': 'en_US.UTF-8', 18:45:38 INFO - 'LANGUAGE': 'en_US:en', 18:45:38 INFO - 'LOGNAME': 'cltbld', 18:45:38 INFO - 'MAIL': '/var/mail/cltbld', 18:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:38 INFO - 'MOZ_NO_REMOTE': '1', 18:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:38 INFO - 'NO_EM_RESTART': '1', 18:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:38 INFO - 'PWD': '/builds/slave/test', 18:45:38 INFO - 'SHELL': '/bin/bash', 18:45:38 INFO - 'SHLVL': '1', 18:45:38 INFO - 'TERM': 'linux', 18:45:38 INFO - 'TMOUT': '86400', 18:45:38 INFO - 'USER': 'cltbld', 18:45:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:38 INFO - '_': '/tools/buildbot/bin/python'} 18:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:38 INFO - Downloading/unpacking jsonschema==2.5.1 18:45:38 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 18:45:38 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 18:45:38 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 18:45:38 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 18:45:38 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 18:45:38 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 18:45:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:45:40 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 18:45:40 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 18:45:40 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 18:45:40 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 18:45:40 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 18:45:40 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 18:45:40 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:40 INFO - warning: no files found matching '*.txt' 18:45:40 INFO - no previously-included directories found matching 'build' 18:45:40 INFO - no previously-included directories found matching 'dist' 18:45:40 INFO - no previously-included directories found matching '.git*' 18:45:40 INFO - Installing collected packages: jsonschema, functools32 18:45:40 INFO - Running setup.py install for functools32 18:45:40 INFO - warning: no files found matching '*.txt' 18:45:40 INFO - no previously-included directories found matching 'build' 18:45:40 INFO - no previously-included directories found matching 'dist' 18:45:40 INFO - no previously-included directories found matching '.git*' 18:45:40 INFO - Successfully installed jsonschema functools32 18:45:40 INFO - Cleaning up... 18:45:40 INFO - Return code: 0 18:45:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:45:40 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')]} 18:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:40 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')]} 18:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:40 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:40 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 18:45:40 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 18:45:40 INFO - Using env: {'DISPLAY': ':0', 18:45:40 INFO - 'HOME': '/home/cltbld', 18:45:40 INFO - 'LANG': 'en_US.UTF-8', 18:45:40 INFO - 'LANGUAGE': 'en_US:en', 18:45:40 INFO - 'LOGNAME': 'cltbld', 18:45:40 INFO - 'MAIL': '/var/mail/cltbld', 18:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:40 INFO - 'MOZ_NO_REMOTE': '1', 18:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:40 INFO - 'NO_EM_RESTART': '1', 18:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:40 INFO - 'PWD': '/builds/slave/test', 18:45:40 INFO - 'SHELL': '/bin/bash', 18:45:40 INFO - 'SHLVL': '1', 18:45:40 INFO - 'TERM': 'linux', 18:45:40 INFO - 'TMOUT': '86400', 18:45:40 INFO - 'USER': 'cltbld', 18:45:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:40 INFO - '_': '/tools/buildbot/bin/python'} 18:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:45:41 INFO - Cleaning up... 18:45:41 INFO - Return code: 0 18:45:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:45:41 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')]} 18:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:41 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')]} 18:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:41 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:41 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 18:45:41 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 18:45:41 INFO - Using env: {'DISPLAY': ':0', 18:45:41 INFO - 'HOME': '/home/cltbld', 18:45:41 INFO - 'LANG': 'en_US.UTF-8', 18:45:41 INFO - 'LANGUAGE': 'en_US:en', 18:45:41 INFO - 'LOGNAME': 'cltbld', 18:45:41 INFO - 'MAIL': '/var/mail/cltbld', 18:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:41 INFO - 'MOZ_NO_REMOTE': '1', 18:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:41 INFO - 'NO_EM_RESTART': '1', 18:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:41 INFO - 'PWD': '/builds/slave/test', 18:45:41 INFO - 'SHELL': '/bin/bash', 18:45:41 INFO - 'SHLVL': '1', 18:45:41 INFO - 'TERM': 'linux', 18:45:41 INFO - 'TMOUT': '86400', 18:45:41 INFO - 'USER': 'cltbld', 18:45:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:41 INFO - '_': '/tools/buildbot/bin/python'} 18:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:41 INFO - Downloading/unpacking blobuploader==1.2.4 18:45:41 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 18:45:41 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 18:45:41 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 18:45:41 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 18:45:41 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 18:45:41 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 18:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:43 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 18:45:44 INFO - Downloading docopt-0.6.1.tar.gz 18:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:44 INFO - Running setup.py install for blobuploader 18:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:44 INFO - Running setup.py install for requests 18:45:44 INFO - Running setup.py install for docopt 18:45:44 INFO - Successfully installed blobuploader requests docopt 18:45:44 INFO - Cleaning up... 18:45:44 INFO - Return code: 0 18:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:44 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')]} 18:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:44 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')]} 18:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:44 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:44 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 18:45:44 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 18:45:44 INFO - Using env: {'DISPLAY': ':0', 18:45:44 INFO - 'HOME': '/home/cltbld', 18:45:44 INFO - 'LANG': 'en_US.UTF-8', 18:45:44 INFO - 'LANGUAGE': 'en_US:en', 18:45:44 INFO - 'LOGNAME': 'cltbld', 18:45:44 INFO - 'MAIL': '/var/mail/cltbld', 18:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:44 INFO - 'MOZ_NO_REMOTE': '1', 18:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:44 INFO - 'NO_EM_RESTART': '1', 18:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:44 INFO - 'PWD': '/builds/slave/test', 18:45:44 INFO - 'SHELL': '/bin/bash', 18:45:44 INFO - 'SHLVL': '1', 18:45:44 INFO - 'TERM': 'linux', 18:45:44 INFO - 'TMOUT': '86400', 18:45:44 INFO - 'USER': 'cltbld', 18:45:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:44 INFO - '_': '/tools/buildbot/bin/python'} 18:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:44 INFO - Running setup.py (path:/tmp/pip-yTuwVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:44 INFO - Running setup.py (path:/tmp/pip-wMmvW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:45 INFO - Running setup.py (path:/tmp/pip-irh2d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:45 INFO - Running setup.py (path:/tmp/pip-A7rKa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:45 INFO - Running setup.py (path:/tmp/pip-EYmBjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:45 INFO - Running setup.py (path:/tmp/pip-NV_PnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:45 INFO - Running setup.py (path:/tmp/pip-xwp6rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:45 INFO - Running setup.py (path:/tmp/pip-GW_bu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:45 INFO - Running setup.py (path:/tmp/pip-9lWLuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:45 INFO - Running setup.py (path:/tmp/pip-XOy8pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:45 INFO - Running setup.py (path:/tmp/pip-FrIj6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:45 INFO - Running setup.py (path:/tmp/pip-TBPWvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:45 INFO - Running setup.py (path:/tmp/pip-FnM5Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:45 INFO - Running setup.py (path:/tmp/pip-6Dg7zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:45 INFO - Running setup.py (path:/tmp/pip-vJdMEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:45 INFO - Running setup.py (path:/tmp/pip-IwSWyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:46 INFO - Running setup.py (path:/tmp/pip-Bsv0_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:46 INFO - Running setup.py install for manifestparser 18:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Running setup.py install for mozcrash 18:45:46 INFO - Running setup.py install for mozdebug 18:45:46 INFO - Running setup.py install for mozdevice 18:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Running setup.py install for mozfile 18:45:46 INFO - Running setup.py install for mozhttpd 18:45:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Running setup.py install for mozinfo 18:45:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Running setup.py install for mozInstall 18:45:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:46 INFO - Running setup.py install for mozleak 18:45:47 INFO - Running setup.py install for mozlog 18:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Running setup.py install for moznetwork 18:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Running setup.py install for mozprocess 18:45:47 INFO - Running setup.py install for mozprofile 18:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Running setup.py install for mozrunner 18:45:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Running setup.py install for mozscreenshot 18:45:47 INFO - Running setup.py install for moztest 18:45:47 INFO - Running setup.py install for mozversion 18:45:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:47 INFO - Cleaning up... 18:45:47 INFO - Return code: 0 18:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:47 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')]} 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 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')]} 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:47 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 18:45:47 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 18:45:47 INFO - Using env: {'DISPLAY': ':0', 18:45:47 INFO - 'HOME': '/home/cltbld', 18:45:47 INFO - 'LANG': 'en_US.UTF-8', 18:45:47 INFO - 'LANGUAGE': 'en_US:en', 18:45:47 INFO - 'LOGNAME': 'cltbld', 18:45:47 INFO - 'MAIL': '/var/mail/cltbld', 18:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:47 INFO - 'MOZ_NO_REMOTE': '1', 18:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:47 INFO - 'NO_EM_RESTART': '1', 18:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:47 INFO - 'PWD': '/builds/slave/test', 18:45:47 INFO - 'SHELL': '/bin/bash', 18:45:47 INFO - 'SHLVL': '1', 18:45:47 INFO - 'TERM': 'linux', 18:45:47 INFO - 'TMOUT': '86400', 18:45:47 INFO - 'USER': 'cltbld', 18:45:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:47 INFO - '_': '/tools/buildbot/bin/python'} 18:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:48 INFO - Running setup.py (path:/tmp/pip-q5aDGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:48 INFO - Running setup.py (path:/tmp/pip-YOYBCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:48 INFO - Running setup.py (path:/tmp/pip-15U01O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:48 INFO - Running setup.py (path:/tmp/pip-Yktkgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:48 INFO - Running setup.py (path:/tmp/pip-MdkhZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:48 INFO - Running setup.py (path:/tmp/pip-7XpCjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:48 INFO - Running setup.py (path:/tmp/pip-mPF9NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:48 INFO - Running setup.py (path:/tmp/pip-qa23ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:48 INFO - Running setup.py (path:/tmp/pip-P2Tt6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:48 INFO - Running setup.py (path:/tmp/pip-OQgE_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:48 INFO - Running setup.py (path:/tmp/pip-yLl4EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:48 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)) 18:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:48 INFO - Running setup.py (path:/tmp/pip-FeiFi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:49 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)) 18:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:49 INFO - Running setup.py (path:/tmp/pip-qA_Aqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:49 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)) 18:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:49 INFO - Running setup.py (path:/tmp/pip-whJ0i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:49 INFO - Running setup.py (path:/tmp/pip-2ugem5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:49 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)) 18:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:49 INFO - Running setup.py (path:/tmp/pip-lZZNwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:49 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)) 18:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:49 INFO - Running setup.py (path:/tmp/pip-HBj6eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:49 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)) 18:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:49 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)) 18:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:49 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 18:45:49 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 18:45:49 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 18:45:49 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 18:45:49 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 18:45:49 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 18:45:51 INFO - Downloading blessings-1.6.tar.gz 18:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:51 INFO - Installing collected packages: blessings 18:45:51 INFO - Running setup.py install for blessings 18:45:51 INFO - Successfully installed blessings 18:45:51 INFO - Cleaning up... 18:45:51 INFO - Return code: 0 18:45:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:51 INFO - Reading from file tmpfile_stdout 18:45:51 INFO - Current package versions: 18:45:51 INFO - argparse == 1.2.1 18:45:51 INFO - blessings == 1.6 18:45:51 INFO - blobuploader == 1.2.4 18:45:51 INFO - docopt == 0.6.1 18:45:51 INFO - functools32 == 3.2.3-2 18:45:51 INFO - jsonschema == 2.5.1 18:45:51 INFO - manifestparser == 1.1 18:45:51 INFO - mozInstall == 1.12 18:45:51 INFO - mozcrash == 0.17 18:45:51 INFO - mozdebug == 0.1 18:45:51 INFO - mozdevice == 0.48 18:45:51 INFO - mozfile == 1.2 18:45:51 INFO - mozhttpd == 0.7 18:45:51 INFO - mozinfo == 0.9 18:45:51 INFO - mozleak == 0.1 18:45:51 INFO - mozlog == 3.4 18:45:51 INFO - moznetwork == 0.27 18:45:51 INFO - mozprocess == 0.23 18:45:51 INFO - mozprofile == 0.28 18:45:51 INFO - mozrunner == 6.12 18:45:51 INFO - mozscreenshot == 0.1 18:45:51 INFO - mozsystemmonitor == 0.3 18:45:51 INFO - moztest == 0.7 18:45:51 INFO - mozversion == 1.4 18:45:51 INFO - psutil == 3.1.1 18:45:51 INFO - requests == 1.2.3 18:45:51 INFO - wsgiref == 0.1.2 18:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:51 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:51 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 18:45:51 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 18:45:51 INFO - Using env: {'DISPLAY': ':0', 18:45:51 INFO - 'HOME': '/home/cltbld', 18:45:51 INFO - 'LANG': 'en_US.UTF-8', 18:45:51 INFO - 'LANGUAGE': 'en_US:en', 18:45:51 INFO - 'LOGNAME': 'cltbld', 18:45:51 INFO - 'MAIL': '/var/mail/cltbld', 18:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:51 INFO - 'MOZ_NO_REMOTE': '1', 18:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:51 INFO - 'NO_EM_RESTART': '1', 18:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:51 INFO - 'PWD': '/builds/slave/test', 18:45:51 INFO - 'SHELL': '/bin/bash', 18:45:51 INFO - 'SHLVL': '1', 18:45:51 INFO - 'TERM': 'linux', 18:45:51 INFO - 'TMOUT': '86400', 18:45:51 INFO - 'USER': 'cltbld', 18:45:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:51 INFO - '_': '/tools/buildbot/bin/python'} 18:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 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)) 18:45:52 INFO - Cleaning up... 18:45:52 INFO - Return code: 0 18:45:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:52 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 0x7f5fb86eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aedca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, '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': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', '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 18:45:52 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 18:45:52 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 18:45:52 INFO - Using env: {'DISPLAY': ':0', 18:45:52 INFO - 'HOME': '/home/cltbld', 18:45:52 INFO - 'LANG': 'en_US.UTF-8', 18:45:52 INFO - 'LANGUAGE': 'en_US:en', 18:45:52 INFO - 'LOGNAME': 'cltbld', 18:45:52 INFO - 'MAIL': '/var/mail/cltbld', 18:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:52 INFO - 'MOZ_NO_REMOTE': '1', 18:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:52 INFO - 'NO_EM_RESTART': '1', 18:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:52 INFO - 'PWD': '/builds/slave/test', 18:45:52 INFO - 'SHELL': '/bin/bash', 18:45:52 INFO - 'SHLVL': '1', 18:45:52 INFO - 'TERM': 'linux', 18:45:52 INFO - 'TMOUT': '86400', 18:45:52 INFO - 'USER': 'cltbld', 18:45:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:52 INFO - '_': '/tools/buildbot/bin/python'} 18:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:45:52 INFO - Cleaning up... 18:45:52 INFO - Return code: 0 18:45:52 INFO - Running post-action listener: _resource_record_post_action 18:45:52 INFO - Running post-action listener: _start_resource_monitoring 18:45:52 INFO - Starting resource monitoring. 18:45:52 INFO - [mozharness: 2016-11-24 02:45:52.291016Z] Finished create-virtualenv step (success) 18:45:52 INFO - [mozharness: 2016-11-24 02:45:52.291515Z] Running install step. 18:45:52 INFO - Running pre-action listener: _resource_record_pre_action 18:45:52 INFO - Running main action method: install 18:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:52 INFO - Reading from file tmpfile_stdout 18:45:52 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:52 INFO - Reading from file tmpfile_stdout 18:45:52 INFO - Output received: 18:45:52 INFO - Usage: mozinstall [options] installer 18:45:52 INFO - Options: 18:45:52 INFO - -h, --help show this help message and exit 18:45:52 INFO - -d DEST, --destination=DEST 18:45:52 INFO - Directory to install application into. [default: 18:45:52 INFO - "/builds/slave/test"] 18:45:52 INFO - --app=APP Application being installed. [default: firefox] 18:45:52 INFO - mkdir: /builds/slave/test/build/application 18:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:46:06 INFO - Reading from file tmpfile_stdout 18:46:06 INFO - Output received: 18:46:06 INFO - /builds/slave/test/build/application/firefox/firefox 18:46:06 INFO - Running post-action listener: _resource_record_post_action 18:46:06 INFO - [mozharness: 2016-11-24 02:46:06.109211Z] Finished install step (success) 18:46:06 INFO - [mozharness: 2016-11-24 02:46:06.109463Z] Running run-tests step. 18:46:06 INFO - Running pre-action listener: _resource_record_pre_action 18:46:06 INFO - Running main action method: run_tests 18:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:46:06 INFO - Python 2.7.3 18:46:06 INFO - Return code: 0 18:46:06 INFO - grabbing minidump binary from tooltool 18:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:06 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 0x1aeaf60>, '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 0x1aebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:46:06 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 18:46:06 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 18:46:06 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 18:46:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:46:06 INFO - Return code: 0 18:46:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:46:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:46:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:46:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:46:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 18:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 18:46:06 INFO - Using env: {'DISPLAY': ':0', 18:46:06 INFO - 'HOME': '/home/cltbld', 18:46:06 INFO - 'LANG': 'en_US.UTF-8', 18:46:06 INFO - 'LANGUAGE': 'en_US:en', 18:46:06 INFO - 'LOGNAME': 'cltbld', 18:46:06 INFO - 'MAIL': '/var/mail/cltbld', 18:46:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:46:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:06 INFO - 'MOZ_NO_REMOTE': '1', 18:46:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:06 INFO - 'NO_EM_RESTART': '1', 18:46:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:06 INFO - 'PWD': '/builds/slave/test', 18:46:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:46:06 INFO - 'SHELL': '/bin/bash', 18:46:06 INFO - 'SHLVL': '1', 18:46:06 INFO - 'TERM': 'linux', 18:46:06 INFO - 'TMOUT': '86400', 18:46:06 INFO - 'USER': 'cltbld', 18:46:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144', 18:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:06 INFO - '_': '/tools/buildbot/bin/python'} 18:46:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 18:46:06 INFO - mozversion application_buildid: 20161123154536 18:46:06 INFO - mozversion application_changeset: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 18:46:06 INFO - mozversion application_display_name: Firefox 18:46:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:46:06 INFO - mozversion application_name: Firefox 18:46:06 INFO - mozversion application_remotingname: firefox 18:46:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:46:06 INFO - mozversion application_vendor: Mozilla 18:46:06 INFO - mozversion application_version: 51.0 18:46:06 INFO - mozversion platform_buildid: 20161123154536 18:46:06 INFO - mozversion platform_changeset: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 18:46:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:46:06 INFO - mozversion platform_version: 51.0 18:46:06 INFO - using testdate: 1479955566 18:46:06 INFO - actual date: 1479955566 18:46:06 INFO - starting webserver on 'localhost:46437' 18:46:06 INFO - SUITE-START | Running 2 tests 18:46:06 INFO - TEST-START | dromaeo_css 18:46:06 INFO - operating with platform_type : linux_ 18:46:06 INFO - Initialising browser for dromaeo_css test... 18:46:06 INFO - TEST-INFO | started process 12302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEs38y/profile http://localhost:46437/getInfo.html) 18:46:10 INFO - PROCESS | 12302 | __metrics Screen width/height:1600/1200 18:46:10 INFO - PROCESS | 12302 | colorDepth:24 18:46:10 INFO - PROCESS | 12302 | Browser inner width/height: 1024/697 18:46:10 INFO - PROCESS | 12302 | __metrics 18:46:11 INFO - PROCESS | 12302 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:46:11 INFO - PROCESS | 12302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:46:11 INFO - PROCESS | 12302 | console.error: PushService: 18:46:11 INFO - PROCESS | 12302 | stateChangeProcessEnqueue: Error transitioning state 18:46:11 INFO - PROCESS | 12302 | UnknownError 18:46:12 INFO - TEST-INFO | 12302: exit 0 18:46:12 INFO - Browser initialized. 18:46:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:46:12 INFO - TEST-INFO | started process 12391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEs38y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:24 INFO - PROCESS | 12391 | RSS: Main: 142802944 18:46:24 INFO - PROCESS | 12391 | 18:47:15 INFO - PROCESS | 12391 | 1479955635212 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] 18:49:24 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46437/tests/dromaeo/cssquery-ext.html) 18:49:25 INFO - PROCESS | 12391 | RSS: Main: 235597824 18:49:25 INFO - PROCESS | 12391 | 18:52:27 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-ext.html (next: http://localhost:46437/tests/dromaeo/cssquery-jquery.html) 18:52:28 INFO - PROCESS | 12391 | RSS: Main: 230682624 18:52:28 INFO - PROCESS | 12391 | 18:55:30 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46437/tests/dromaeo/cssquery-mootools.html) 18:55:30 INFO - PROCESS | 12391 | RSS: Main: 176562176 18:55:30 INFO - PROCESS | 12391 | 18:58:32 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46437/tests/dromaeo/cssquery-prototype.html) 18:58:33 INFO - PROCESS | 12391 | RSS: Main: 225947648 18:58:33 INFO - PROCESS | 12391 | 19:01:35 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46437/tests/dromaeo/cssquery-yui.html) 19:01:36 INFO - PROCESS | 12391 | RSS: Main: 172580864 19:01:36 INFO - PROCESS | 12391 | 19:04:38 INFO - PROCESS | 12391 | Cycle 1(1): loaded http://localhost:46437/tests/dromaeo/cssquery-yui.html (next: http://localhost:46437/tests/dromaeo/cssquery-dojo.html) 19:04:39 INFO - PROCESS | 12391 | RSS: Main: 263118848 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | __start_tp_report 19:04:39 INFO - PROCESS | 12391 | _x_x_mozilla_page_load 19:04:39 INFO - PROCESS | 12391 | _x_x_mozilla_page_load_details 19:04:39 INFO - PROCESS | 12391 | |i|pagename|runs| 19:04:39 INFO - PROCESS | 12391 | |0;dojo.html;3137.058882335299;3178.1736748445405;3184.379046086014;3194.089684439932;3212.469942459494;5562.777488900444;5615.045442274813;5661.348944871341;5673.744681489333;5680.715964201789;5503.669779813214;5531.751071201806;5559.972200138994;5562.610617256793;5593.776248950047;5030.346055012843;5055.368078990126;5061.215511595699;5114.539691427771;5125.154349532323;4916.434610019858;5075.4163271223915;5134.306868572751;5138.58891288696;5168.922466162991;4893.04585605807;4984.725840078794;4999.8000079996755;5005.374328208974;5095.9745201273945;5147.48525147486;5180.430152683201;5181.870453238662;5249.107651699221;5253.6322457428;5044.243363495469;5136.666116702402;5159.948400515985;5184.585233181337;5235.58115350771;5244.449332820037;5282.313299271109;5350.57195424369;5393;5474.91787623186;5880.382559831199;5897.439743224387;5902.940970590325;6009.819705408845;6016.8194954151;6039.184710064129;6052.1526986221525;6053.364396738367;6067.059605761114;6068.33248342682;5383.16560933056;5435.728213589305;5535.861603459945;5539.307586551641;5597.832065038056;6143;6175.876482470415;6186.1648677428875;6187.381261873777;6210.689465526705;5934.732937017845;5946.286445626552;5949.196858424144;5955.13650520672;5986.042233242661;5787.421257874263;5827.155062515912;5862.443067908542;5900.616459930091;5920.200772895604;5941.881162376728;5955.583109182316;5960.791372301948;5964.7315870785915;5990.520758339322;5925.911111333334;5963.463288303987;5972.462478376967;5977.22296101504;6004.489618382399;4434.157510073076;4472.485664148665;4534.183846907588;4604.861854144381;4609.654275929319;4068.2677118119022;4104.630583247522;4122.299209134454;4127.380892866094;4145.854895078658;5758.712064396847;5769.653820770767;5771.88456230873;5775.191473193756;5775.451332123442;5836.182934389189;5844.970775146097;5893.764249430061;6079.422454866781;6086.208792856989;5563.610547261653;5646.181303711021;5667.206591077253;5668.26312579362;5676.858078547987;5135.768890399941;5136.794528218904;5146.794128234904;5147.6654017488745;5149.794008239628;5900.970495147497;6066.241719785027;6111.786087486917;6128.3565225651555;6131.110988906584;5774.855628609151;5844.795432159854;5910.7931222407005;5920.940790592212;6022.277326720821;6158.076288556752;6160.10678451631;6165.445109940127;6170.7223174958135;6175.3515880831865;5834.27071616048;5839.153322768259;5847.210626565359;5849.502792262705;5852.356240813422;5585.972070139624;5695.857603559944;5866.120081987736;5898.616589921641;5913.58604897653;5796.94203057964;5848.707564621837;5853.151293062397;5861;5881.794137205177;5809.970950145223;5837.241158649348;5843.707814609337;5846.853828654318;5847.152162936435;5659.462351076641;5665.291838520185;5669.489745922887;5689;5814.854628634318;5815.3603103657715;5827.679477628772;5842.065269556851;5846.35690074083;5853.560982926383;5682.715864206691;5690.37405885344;5693.5445164387575;5695.45893140151;5700.743466544099 19:04:39 INFO - PROCESS | 12391 | |1;ext.html;590.7932223721698;615.5444970721666;627.6391075131801;634.8476365672234;646.5635695905265;35290.470642940374;39055;39091.41362879559;39126.60873391265;46199.30701039487;44730;49917.75041124798;49980;50016.74991625046;50098.74950625251;9281.164695177433;9432.339736218468;9436.528173591327;9437.433753974748;9446.338756287063;8498.702545410912;8690.608922598498;9180.8622870657;9289.303302252325;10924.235303528756;10913.181511386638;11313.208075434723;11323.603673871416;11333.0366918812;11335.37655428951;11070.28043177191;11111.055560277386;11136.387498687569;11142.49858756358;11159.442027898654;10904.61833835812;11088.057515111144;11109.388983605979;11113.611023614134;11117.499712512876;45440.3183952241;45601.771991140165;45661.315080273824;45743.31385029194;45746.542534574895;3696.630336966282;3816.141368192162;3853.8265778040054;4029.4761680981283;4366.279563871989;34242.14394640154;34603.4809477858;34741.47887781685;34854.12864678378;35839.10402239939;4569.223232050559;4676.321933319649;4682.6253899687945;4718.575328220477;4782.832600858953;272343.999999998;272632;273890;274335;274720;38886.22227555433;39962.80018599946;39976.600233997866;66002;66363.66818165878;43199.35200971988;43301;43352.78323608425;43389.783051084545;43390;16548.33806647745;16694.83305166957;16697;16714.498565043068;16730.16349182536;13547.661308467366;13586;13618;13634.727305453835;13635.318234088256;8961.59672814725;9182.63269469227;9324.067593240621;9638.373505722106;9650.75873103164;3620.7827530347736;3637.563492380931;3670.871519496858;3691.778493290411;3712.9443058354145;1041.5261056219401;1070.8500809886623;1119.2445099557765;1155.8555180602425;1230.034422977958;35456.46815297772;35577.28845423077;35768.10579735475;36124.27751445009;36539.49919063135;1116.5143162724241;1128.103157989384;1139.9772004559863;1167.8773728758529;1183.3905538647602;18436.170372333276;18852.34016809405;18861.81138188628;18879.339223127125;18896.62206755885;520292;529068;530824;534071;535587;63166.36833631697;63645.68177159085;63787;63797.68101159464;63939.68030159819;1358.1579420759192;1397.1198145168682;1426.1942002768403;1436.432609119392;1438.676297833;33216.83391583027;34819.82590087033;34829.825850870584;35355.82322088373;35410.64589354177;58263.70868145632;60725;62740;62997;68249.65875170792;533097;537157;538375;540927;541430;36873.44689829709;47362.91470193033;48390.516094838604;48572.27141592808;49045.50954490552;51380.74309628428;52591;53392.46607533875;53611;54186.45813541814;41107;41425.37861932013;42112;42132.368014479194;42397.364039538814;43208.82431642275;44745;44981.775091125644;46032;46647.533524664315;46097.30854037259;46139;47476;47537.7623111896;47548.7622561885;37748.62251377451;39958.400623990085;40059.19881602293;40525.594744052185;40640.79679601583;30343.544846826873;30660.84669576727;30759.2310192247;31270.374592508477;32839.40768808971 19:04:39 INFO - PROCESS | 12391 | |2;jquery.html;391.2488022995851;428.1020487050637;430.7157276197709;435.3817579037767;444.8131784650445;16155.676886462265;19030.333938312146;21293.787062129373;21301.615394999313;21488.677669834964;19991.90004049978;20033.19867205314;20524.486887827774;20604.793952060474;20756.584868302663;5718.256626638531;5738.470840433124;5968.67172305523;5969.761209551612;5971.940280597182;4334.5882141196535;4538;5891.440313170242;5930.229070220887;6151.661658608775;6360.936390636104;6483.059956306332;6485.70814313357;6488.156539649839;6496.740130394778;6362.809115726535;6420.4542613877875;6449.451796597295;6491.318411566788;6534.967325163391;5339.145736682151;5846.883062338772;5850.6782126983;5857.179994800731;5857.970710146465;13914.860851391457;14679.412823487048;14692.26538673062;14719.55841324762;20738.585228295502;2393.3179043972386;2396.5805983952737;2417.8065754739755;2824.6045553622303;3079.245584831708;11028.944855275673;11096.61161859331;11183.552657893755;14582.708345833023;14704.15174876087;1891.990540047291;1919.683252263375;1946.4452631000097;1973.4079776067265;2027.9860069965018;85697;87411.99999999936;87659;88543.67184492173;89033.55483222607;11747.295162290118;11846.703832404086;11958.40207989597;11960.700982475508;12069.189621556661;17047.23287452043;17079.914600426917;17086.572835679206;17087.829121708623;17101.14494275306;8150.551719655476;8604.31165506758;8713.695020674246;8721.563921803885;8818;8388.496690198608;8429.452085614415;8439.282660973886;8478.406511544134;8635.179657932485;5120.359955005624;5135.35808023997;5188.45521220274;5191.610629202825;5285.207218917193;1836.775416541975;1967.1344608372272;2087.1338394566387;2102.3903068110076;2150.4838838678606;905.4883990545321;962.9662961796304;976.5507866381544;1039.9808187975675;1098.3794156301665;20197.798022019884;20301;20370.898145509473;20473.692894606593;20712.067956941974;986.9753256168653;1024.073213741565;1052.4211683574003;1060.157175045825;1094.179365475893;10755.516001779783;11527.365994870363;11537.88462115368;11626.1861669684;11627.1860969733;448577;456399;461363;467931;485015;90340;92590.53704731568;94672;96117;101272;1027.3784360461962;1046.8220402531435;1052.0321304399818;1070.796548655753;1072.126217133034;17524.211410486303;17656.646867062842;17937.461876143738;18196.636067278847;18317.725234121765;41624;42238;42809.1438171241;42931.570684292754;44488;54898.451015489336;59367.40632593792;59519;61072;61783;9015.729528114167;9131.863022054542;9156.359054866096;9179.862302065609;9434.85847712271;10611.469426528796;13885.930570347084;13999.580012599637;14272.286385680882;14325.856741432452;11369.658910232707;11452.30854848637;11723.765524689288;12198.939005304917;12373.62879113628;11989.160758746804;12042.638720838038;12106.75786484283;12351.69120771988;12593;12319.815202771786;12473.93763031179;12506.499740010298;12626.747465050832;12734.872651273368;8928.598213080297;9194.17252447283;9233.861492077489;9371.531423428665;9472.57373418184;9470.526473676151;12033.45849436795;12165.026797855973;12185.329806860707;12219.26684398939 19:04:39 INFO - PROCESS | 12391 | |3;mootools.html;1508.8642022217998;1549.1634517360626;1710.2303963216548;1802.41421538;1819.0995457248664;8427.578621068953;9090.50002249876;9094.590743416546;9095.863562046574;9105.0894910509;7790.45466817323;8075.959620201906;8458.534780587066;8675.652973881037;8712.564371781416;2402.531506356261;2428.453597940467;2429.8056155507606;2433.85396876188;2438.6220135878966;2439.597466418039;2445.29086564896;2459.655648209252;2459.7909177719825;2463.273334366357;2420.261820144855;2430.44099857033;2430.647556104364;2430.6597076409316;2431.4286142756437;2357.092519380034;2359.587072262347;2371.0397289097855;2389.4862604539935;2426.4419183587875;2342.2270650685405;2342.695449591542;2348.8825558721996;2349.1777877742825;2374.8693821839793;8839.337049721296;8978.23684986777;8978.371513994023;8983;9030.683926062622;5348.197770334442;5506.724663766836;5522.641028333145;5523.364813046511;5527.309086364205;3195.3130077033316;3383.7800542964874;3394.932101357959;3435.158386195398;3437.914052148691;1038.7558923652934;1064.5050051725984;1071.1430855315716;1105.850710154135;1108.51225460797;12243.081768867281;12295.139340246187;12375.814362784566;12382.318972456602;12402.069844761589;4707.270373092176;4720.12677654635;4797.673855100533;4821.035792841376;4920.3603531541385;10462.738431539121;10496.317739346918;10505.789884202273;10516.789664206673;10521.210909181842;5499.037668408013;5500.724963751796;5501.119820828728;5508.669479831223;5509.063459211943;4364.71629344098;4504.436945381827;4802.447718512346;4916.754162291871;5071.518205770446;4102.548719640837;4118.629323360912;4205.789710514462;4225.852095176716;4245.681573881971;1308.6793735534854;1315.046591221357;1323.3383308345826;1330.973380532384;1341.5698250902258;954.117441366733;956.268454632207;983.9606415743433;1017.2472370445817;1043.6868939318174;6000;6109.450149486567;6126.540509461719;6143.662098584531;6159.538034647419;995.6316163019584;995.9053889880449;1013.8225810483136;1050.8896565860628;1073.736934451049;4197.349410841324;4429.712068715523;4431.512533621299;4448.755318457451;4515.593596576324;10823.512941917475;11054.834177487344;11129.33224006546;11163.386013769159;11164.330140191452;11009.61466348674;11044.723881903017;11049.33703977764;11050.447477626087;11056.226064175591;7659.119201291923;8058.798530036679;8293.585320733939;8347.081820999685;8426.831463370698;6153.8307721532765;6229.190205273467;6300.432961033529;6356.141920840627;6401.775937842153;10072.143867771028;10112.241581881535;10131.79736405253;10137.138343240907;10137.341072830242;9660.468674222986;9995.150412214753;10031.29780915329;10247.077763001067;10315.020073093045;7178.676959536729;7391.113066432063;7395.926040739524;7922.841543169219;8057.798555036171;7998.48009879356;8100.837983240184;8453.112423195476;8481.618327175416;8587.871181932402;7765.844683106419;7895.131535531202;7931.762047138595;8062.113167551682;8097.2712455879255;7705.345045670956;7751.186125456746;7756.728514501965;7757;7857.607119643881;6930.27232140618;7086.539374940612;7096.858062838611;7100.254473280231;7102.14774227096;5256.316678831728;5341.813036543857;5439.537639300704;5455.1544510600925;5509.889802204014;5403.702796346239;5463.235147079333;5480.479354461319;5513.9448605513435;5618.04493236159 19:04:39 INFO - PROCESS | 12391 | |4;prototype.html;340.50456585667854;352.8782570013345;359.7266077780886;374.6459595682078;378.77462909568817;5575.609707320489;5578.581606379523;5600.971995140024;5604.299462567179;5626.409227031164;5236.476352364771;5333.866653333668;5407.891842163154;5476.91784623231;5543.029969755296;4361.629261512775;4375.4311939447825;4379.496357918841;4381.9561804381865;4383.9342409863875;4376.409184760048;4382.496012958519;4384.298512238042;4386.1008493258805;4394.450693663292;4115.54728979812;4329.242382583051;4348.478182618091;4348.804303806336;4350.673699472536;4317.827286908519;4320.265554855682;4327.870163895088;4334.523202447728;4340.045190058182;3843.903902402434;3844.308024555579;3848.4034974578985;3855.1711382052995;3867.1878905429894;5223.294855194538;5367.718719544178;5422.240886275925;5429.457054294539;5439.782408703647;4974.950250497521;4978.178600530908;4980.252962055721;5008.348914641073;5023.547880690755;5803.680797556132;5813.593048486608;5823.737931793079;5829.708514574254;5830.562707796932;4150.796269081962;4205.432266643995;4241.830326786925;4257.510386305584;4261.446012018418;6014.578979471439;6020.5785595008365;6026;6046.909296360602;6049.909251361233;4252.829886804493;4258.42511260982;4275.722078064916;4278.850240241577;4285.314349704033;4199.475065616798;4351;4393.692441529062;4415.271480205794;4432.202203603318;4989.501049894981;4990.925136122961;4998.5751211146735;5002.673222307198;5008.549230569266;5848.912266316009;5854.736536855767;5859.267591551056;5860.150278209636;5884.617499862496;1479.9926000369928;1483.9686417939429;1497.1615895098562;1525.6262215756988;1563.3199558191995;1055.9598795186735;1066.2323127348297;1082.2316155529504;1082.77646259726;1089.5260561655705;5610.943890561124;5654.5193658538665;5662.37713851476;5672.128197694751;5673.716314184274;5938.940610593839;5958.046712525975;5972.910406343908;5991.5206783457215;5997.8200653979575;5461.890762184734;5606.467385598362;5640.266765320564;5652.519535839418;5659.915101273484;3136.3654530194744;3163.7785355024926;3166.461701510703;3179.395914776231;3185.792923459968;5882.823515294548;6108.602940808833;6124.326324104345;6135.478484328793;6154.353792851775;6014.218151640259;6052.878942421215;6066.393360663898;6067.7876274331065;6089.725962331617;6116.633002019893;6128.771147907929;6131.294901086432;6140.530600210866;6148.723307451175;5705.172749951317;5909.674967876808;5924.52603791687;5940.762369505172;5972.611780234271;5839.562032847638;5868.589198756217;5871.7651293947765;5875.354900627831;5886.734352114316;5952.345242023461;6083.9695801522475;6125.601835880653;6134.509239260759;6164.568480206342;4371.51368534687;4426.5130835607415;4445.1998640245065;4457.576530229623;4464.464264288306;5864.912026319524;5872.500837428866;5893.675847828239;5894.823155305347;5942.168096466585;5579.2746942897165;5740.885182296414;5780.5953583248765;5859.296884373903;5886.23478947734;5813;5838.153467747238;5857.414258574108;5868.618539794899;5868.882622347614;5587.888242235052;5784.334801497882;5798.304203495608;5850.2102216200265;5855.707214639337;5794.217780599565;5799.884002320015;5846.766129354948;5877.617954832922;5897.970510147422;5701.688611619434;5706.80288089097;5718.885622287614;5722.484976352148;5746.310442746897 19:04:39 INFO - PROCESS | 12391 | |5;yui.html;830.2195935820329;856.5674334461096;874.2918236228654;899.6761165980242;924.0713083351233;16471.505854824358;17694;17741.201645925932;17765.64468710625;17785.110744462756;16071.437499687514;16438.589035274123;16448.342066317364;16453.67092658146;16460.259288332025;709.0994437064925;724.384273367636;847.9448835825667;869.5999840073542;871.9564021798884;827.3918669777738;841.9368547358972;845.4039901869168;849.2144766091371;851.1360968616827;898.0346127912487;902.1609902790402;902.9051949545302;903.0202230579829;903.3811838890381;881.8280435315116;886.2201262888681;890.3767362846002;891.7191084808297;893.053363434758;658.7101675262869;659.6635715784936;659.7525927777084;663.1975309875008;664.1498881431775;15985.280662370222;16037.679246415122;16088.436904708278;16090.75863862043;16121.27454264561;14628.488002919847;14693.926530367387;14740.778888316683;15143.167125808077;16199.595010124842;14458.349374278183;14653.926730366387;14852.628684282872;14899.478518251917;15261.542153735405;4826.638002149853;4838.975805120987;4880.341153944208;5038.899222015576;5057.8229761958155;69729;72322.63838680772;73247.63376183138;90769;92071;11903.047756179485;12067.57763478274;12388.194767340274;12456.439460224312;12830.55093071738;22451.663225051638;22688.65967010496;22692.773072269065;22742.431439213822;22766;9439.575219115019;9534.380265282734;9592.95203523992;9655.951720241354;9734;4956.975215123974;5126.974365128225;5222;5247.02929957959;5304.310439642822;3688.207035487383;3850.6919446444217;3853.3641949078647;3858.7684738915755;3864.381698928158;666.6500087454125;676.6075676107846;686.5914780705472;699.4369532526264;712.7540998355558;693.9236683964759;786.9134395216522;806.5967016491754;808.1998821167119;808.8463191993502;10475.319104258198;10535.367877927349;10621.666451465544;10726.302790318605;11086.944565277123;729.1833146875427;790.6205021589554;805.4683908620283;812.9471584346999;833.3832963607008;5092;5100.464451232567;5113.846584602468;5150.253213284052;5166.974165129225;72525.2747472529;121614.39192804156;124728.37635811763;125257.37371313268;133385;107145.4642726797;108479.45760271148;109694;112760;113976;88650.55674721586;90042.29873103686;94099.52950235204;94185.5290723542;94713;9530.714078577654;9786.85319720219;9875.950620246853;10046.799064018825;10136.391816491034;56196.438035620755;57055.42944570501;57398.42601573931;58381.12428313664;58824.64701412067;79368.60315698385;82022.58988705018;82756;83622.16377836144;87533;12472.688182795502;12502.124851260689;12628.558000469939;12711.61865144047;13127;13684.589462316146;13689.315534223448;13910.026298159437;14289.928550357597;15051.473198438001;12354.444050017592;13215.471381145031;13314.267715275366;13924.16455012662;14524.636884077983;13150.145240559334;13268.93365533166;13654;13817;14756.188409637572;12352.505899764268;14264.643383915485;14334.569962901129;14510.201938893462;15060.924695376452;11752.706182345168;12357.93821030925;12415.875841241472;12531.310777907303;12730.68173295675;12422.503099875903;12505.124641275388;12640.620781376574;12661.430235639602;12836.358182091044 19:04:39 INFO - PROCESS | 12391 | __end_tp_report 19:04:39 INFO - PROCESS | 12391 | __start_cc_report 19:04:39 INFO - PROCESS | 12391 | _x_x_mozilla_cycle_collect,843 19:04:39 INFO - PROCESS | 12391 | __end_cc_report 19:04:39 INFO - PROCESS | 12391 | __startTimestamp1479956679195__endTimestamp 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | ------- Summary: start ------- 19:04:39 INFO - PROCESS | 12391 | Number of tests: 6 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#0] dojo.html Cycles:165 Average:5529.88 Median:5769.65 stddev:626.50 (10.9%) stddev-sans-first:599.64 19:04:39 INFO - PROCESS | 12391 | Values: 3137.1 3178.2 3184.4 3194.1 3212.5 5562.8 5615.0 5661.3 5673.7 5680.7 5503.7 5531.8 5560.0 5562.6 5593.8 5030.3 5055.4 5061.2 5114.5 5125.2 4916.4 5075.4 5134.3 5138.6 5168.9 4893.0 4984.7 4999.8 5005.4 5096.0 5147.5 5180.4 5181.9 5249.1 5253.6 5044.2 5136.7 5159.9 5184.6 5235.6 5244.4 5282.3 5350.6 5393.0 5474.9 5880.4 5897.4 5902.9 6009.8 6016.8 6039.2 6052.2 6053.4 6067.1 6068.3 5383.2 5435.7 5535.9 5539.3 5597.8 6143.0 6175.9 6186.2 6187.4 6210.7 5934.7 5946.3 5949.2 5955.1 5986.0 5787.4 5827.2 5862.4 5900.6 5920.2 5941.9 5955.6 5960.8 5964.7 5990.5 5925.9 5963.5 5972.5 5977.2 6004.5 4434.2 4472.5 4534.2 4604.9 4609.7 4068.3 4104.6 4122.3 4127.4 4145.9 5758.7 5769.7 5771.9 5775.2 5775.5 5836.2 5845.0 5893.8 6079.4 6086.2 5563.6 5646.2 5667.2 5668.3 5676.9 5135.8 5136.8 5146.8 5147.7 5149.8 5901.0 6066.2 6111.8 6128.4 6131.1 5774.9 5844.8 5910.8 5920.9 6022.3 6158.1 6160.1 6165.4 6170.7 6175.4 5834.3 5839.2 5847.2 5849.5 5852.4 5586.0 5695.9 5866.1 5898.6 5913.6 5796.9 5848.7 5853.2 5861.0 5881.8 5810.0 5837.2 5843.7 5846.9 5847.2 5659.5 5665.3 5669.5 5689.0 5814.9 5815.4 5827.7 5842.1 5846.4 5853.6 5682.7 5690.4 5693.5 5695.5 5700.7 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#1] ext.html Cycles:180 Average:62014.97 Median:22277.54 stddev:123305.55 (553.5%) stddev-sans-first:123565.21 19:04:39 INFO - PROCESS | 12391 | Values: 590.8 615.5 627.6 634.8 646.6 35290.5 39055.0 39091.4 39126.6 46199.3 44730.0 49917.8 49980.0 50016.7 50098.7 9281.2 9432.3 9436.5 9437.4 9446.3 8498.7 8690.6 9180.9 9289.3 10924.2 10913.2 11313.2 11323.6 11333.0 11335.4 11070.3 11111.1 11136.4 11142.5 11159.4 10904.6 11088.1 11109.4 11113.6 11117.5 45440.3 45601.8 45661.3 45743.3 45746.5 3696.6 3816.1 3853.8 4029.5 4366.3 34242.1 34603.5 34741.5 34854.1 35839.1 4569.2 4676.3 4682.6 4718.6 4782.8 272344.0 272632.0 273890.0 274335.0 274720.0 38886.2 39962.8 39976.6 66002.0 66363.7 43199.4 43301.0 43352.8 43389.8 43390.0 16548.3 16694.8 16697.0 16714.5 16730.2 13547.7 13586.0 13618.0 13634.7 13635.3 8961.6 9182.6 9324.1 9638.4 9650.8 3620.8 3637.6 3670.9 3691.8 3712.9 1041.5 1070.9 1119.2 1155.9 1230.0 35456.5 35577.3 35768.1 36124.3 36539.5 1116.5 1128.1 1140.0 1167.9 1183.4 18436.2 18852.3 18861.8 18879.3 18896.6 520292.0 529068.0 530824.0 534071.0 535587.0 63166.4 63645.7 63787.0 63797.7 63939.7 1358.2 1397.1 1426.2 1436.4 1438.7 33216.8 34819.8 34829.8 35355.8 35410.6 58263.7 60725.0 62740.0 62997.0 68249.7 533097.0 537157.0 538375.0 540927.0 541430.0 36873.4 47362.9 48390.5 48572.3 49045.5 51380.7 52591.0 53392.5 53611.0 54186.5 41107.0 41425.4 42112.0 42132.4 42397.4 43208.8 44745.0 44981.8 46032.0 46647.5 46097.3 46139.0 47476.0 47537.8 47548.8 37748.6 39958.4 40059.2 40525.6 40640.8 30343.5 30660.8 30759.2 31270.4 32839.4 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#2] jquery.html Cycles:180 Average:28840.15 Median:2271.90 stddev:76824.81 (3381.5%) stddev-sans-first:77010.63 19:04:39 INFO - PROCESS | 12391 | Values: 391.2 428.1 430.7 435.4 444.8 16155.7 19030.3 21293.8 21301.6 21488.7 19991.9 20033.2 20524.5 20604.8 20756.6 5718.3 5738.5 5968.7 5969.8 5971.9 4334.6 4538.0 5891.4 5930.2 6151.7 6360.9 6483.1 6485.7 6488.2 6496.7 6362.8 6420.5 6449.5 6491.3 6535.0 5339.1 5846.9 5850.7 5857.2 5858.0 13914.9 14679.4 14692.3 14719.6 20738.6 2393.3 2396.6 2417.8 2824.6 3079.2 11028.9 11096.6 11183.6 14582.7 14704.2 1892.0 1919.7 1946.4 1973.4 2028.0 85697.0 87412.0 87659.0 88543.7 89033.6 11747.3 11846.7 11958.4 11960.7 12069.2 17047.2 17079.9 17086.6 17087.8 17101.1 8150.6 8604.3 8713.7 8721.6 8818.0 8388.5 8429.5 8439.3 8478.4 8635.2 5120.4 5135.4 5188.5 5191.6 5285.2 1836.8 1967.1 2087.1 2102.4 2150.5 905.5 963.0 976.6 1040.0 1098.4 20197.8 20301.0 20370.9 20473.7 20712.1 987.0 1024.1 1052.4 1060.2 1094.2 10755.5 11527.4 11537.9 11626.2 11627.2 448577.0 456399.0 461363.0 467931.0 485015.0 90340.0 92590.5 94672.0 96117.0 101272.0 1027.4 1046.8 1052.0 1070.8 1072.1 17524.2 17656.6 17937.5 18196.6 18317.7 41624.0 42238.0 42809.1 42931.6 44488.0 54898.5 59367.4 59519.0 61072.0 61783.0 9015.7 9131.9 9156.4 9179.9 9434.9 10611.5 13885.9 13999.6 14272.3 14325.9 11369.7 11452.3 11723.8 12198.9 12373.6 11989.2 12042.6 12106.8 12351.7 12593.0 12319.8 12473.9 12506.5 12626.7 12734.9 8928.6 9194.2 9233.9 9371.5 9472.6 9470.5 12033.5 12165.0 12185.3 12219.3 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#3] mootools.html Cycles:180 Average:5892.59 Median:4713.70 stddev:3279.48 (69.6%) stddev-sans-first:3272.13 19:04:39 INFO - PROCESS | 12391 | Values: 1508.9 1549.2 1710.2 1802.4 1819.1 8427.6 9090.5 9094.6 9095.9 9105.1 7790.5 8076.0 8458.5 8675.7 8712.6 2402.5 2428.5 2429.8 2433.9 2438.6 2439.6 2445.3 2459.7 2459.8 2463.3 2420.3 2430.4 2430.6 2430.7 2431.4 2357.1 2359.6 2371.0 2389.5 2426.4 2342.2 2342.7 2348.9 2349.2 2374.9 8839.3 8978.2 8978.4 8983.0 9030.7 5348.2 5506.7 5522.6 5523.4 5527.3 3195.3 3383.8 3394.9 3435.2 3437.9 1038.8 1064.5 1071.1 1105.9 1108.5 12243.1 12295.1 12375.8 12382.3 12402.1 4707.3 4720.1 4797.7 4821.0 4920.4 10462.7 10496.3 10505.8 10516.8 10521.2 5499.0 5500.7 5501.1 5508.7 5509.1 4364.7 4504.4 4802.4 4916.8 5071.5 4102.5 4118.6 4205.8 4225.9 4245.7 1308.7 1315.0 1323.3 1331.0 1341.6 954.1 956.3 984.0 1017.2 1043.7 6000.0 6109.5 6126.5 6143.7 6159.5 995.6 995.9 1013.8 1050.9 1073.7 4197.3 4429.7 4431.5 4448.8 4515.6 10823.5 11054.8 11129.3 11163.4 11164.3 11009.6 11044.7 11049.3 11050.4 11056.2 7659.1 8058.8 8293.6 8347.1 8426.8 6153.8 6229.2 6300.4 6356.1 6401.8 10072.1 10112.2 10131.8 10137.1 10137.3 9660.5 9995.2 10031.3 10247.1 10315.0 7178.7 7391.1 7395.9 7922.8 8057.8 7998.5 8100.8 8453.1 8481.6 8587.9 7765.8 7895.1 7931.8 8062.1 8097.3 7705.3 7751.2 7756.7 7757.0 7857.6 6930.3 7086.5 7096.9 7100.3 7102.1 5256.3 5341.8 5439.5 5455.2 5509.9 5403.7 5463.2 5480.5 5513.9 5618.0 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#4] prototype.html Cycles:180 Average:4914.44 Median:5602.64 stddev:1421.33 (25.4%) stddev-sans-first:1383.24 19:04:39 INFO - PROCESS | 12391 | Values: 340.5 352.9 359.7 374.6 378.8 5575.6 5578.6 5601.0 5604.3 5626.4 5236.5 5333.9 5407.9 5476.9 5543.0 4361.6 4375.4 4379.5 4382.0 4383.9 4376.4 4382.5 4384.3 4386.1 4394.5 4115.5 4329.2 4348.5 4348.8 4350.7 4317.8 4320.3 4327.9 4334.5 4340.0 3843.9 3844.3 3848.4 3855.2 3867.2 5223.3 5367.7 5422.2 5429.5 5439.8 4975.0 4978.2 4980.3 5008.3 5023.5 5803.7 5813.6 5823.7 5829.7 5830.6 4150.8 4205.4 4241.8 4257.5 4261.4 6014.6 6020.6 6026.0 6046.9 6049.9 4252.8 4258.4 4275.7 4278.9 4285.3 4199.5 4351.0 4393.7 4415.3 4432.2 4989.5 4990.9 4998.6 5002.7 5008.5 5848.9 5854.7 5859.3 5860.2 5884.6 1480.0 1484.0 1497.2 1525.6 1563.3 1056.0 1066.2 1082.2 1082.8 1089.5 5610.9 5654.5 5662.4 5672.1 5673.7 5938.9 5958.0 5972.9 5991.5 5997.8 5461.9 5606.5 5640.3 5652.5 5659.9 3136.4 3163.8 3166.5 3179.4 3185.8 5882.8 6108.6 6124.3 6135.5 6154.4 6014.2 6052.9 6066.4 6067.8 6089.7 6116.6 6128.8 6131.3 6140.5 6148.7 5705.2 5909.7 5924.5 5940.8 5972.6 5839.6 5868.6 5871.8 5875.4 5886.7 5952.3 6084.0 6125.6 6134.5 6164.6 4371.5 4426.5 4445.2 4457.6 4464.5 5864.9 5872.5 5893.7 5894.8 5942.2 5579.3 5740.9 5780.6 5859.3 5886.2 5813.0 5838.2 5857.4 5868.6 5868.9 5587.9 5784.3 5798.3 5850.2 5855.7 5794.2 5799.9 5846.8 5877.6 5898.0 5701.7 5706.8 5718.9 5722.5 5746.3 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - PROCESS | 12391 | [#5] yui.html Cycles:180 Average:22302.04 Median:4345.51 stddev:32100.08 (738.7%) stddev-sans-first:32149.64 19:04:39 INFO - PROCESS | 12391 | Values: 830.2 856.6 874.3 899.7 924.1 16471.5 17694.0 17741.2 17765.6 17785.1 16071.4 16438.6 16448.3 16453.7 16460.3 709.1 724.4 847.9 869.6 872.0 827.4 841.9 845.4 849.2 851.1 898.0 902.2 902.9 903.0 903.4 881.8 886.2 890.4 891.7 893.1 658.7 659.7 659.8 663.2 664.1 15985.3 16037.7 16088.4 16090.8 16121.3 14628.5 14693.9 14740.8 15143.2 16199.6 14458.3 14653.9 14852.6 14899.5 15261.5 4826.6 4839.0 4880.3 5038.9 5057.8 69729.0 72322.6 73247.6 90769.0 92071.0 11903.0 12067.6 12388.2 12456.4 12830.6 22451.7 22688.7 22692.8 22742.4 22766.0 9439.6 9534.4 9593.0 9656.0 9734.0 4957.0 5127.0 5222.0 5247.0 5304.3 3688.2 3850.7 3853.4 3858.8 3864.4 666.7 676.6 686.6 699.4 712.8 693.9 786.9 806.6 808.2 808.8 10475.3 10535.4 10621.7 10726.3 11086.9 729.2 790.6 805.5 812.9 833.4 5092.0 5100.5 5113.8 5150.3 5167.0 72525.3 121614.4 124728.4 125257.4 133385.0 107145.5 108479.5 109694.0 112760.0 113976.0 88650.6 90042.3 94099.5 94185.5 94713.0 9530.7 9786.9 9876.0 10046.8 10136.4 56196.4 57055.4 57398.4 58381.1 58824.6 79368.6 82022.6 82756.0 83622.2 87533.0 12472.7 12502.1 12628.6 12711.6 13127.0 13684.6 13689.3 13910.0 14289.9 15051.5 12354.4 13215.5 13314.3 13924.2 14524.6 13150.1 13268.9 13654.0 13817.0 14756.2 12352.5 14264.6 14334.6 14510.2 15060.9 11752.7 12357.9 12415.9 12531.3 12730.7 12422.5 12505.1 12640.6 12661.4 12836.4 19:04:39 INFO - PROCESS | 12391 | -------- Summary: end -------- 19:04:39 INFO - PROCESS | 12391 | 19:04:39 INFO - TEST-INFO | 12391: exit 0 19:04:39 INFO - TEST-OK | dromaeo_css | took 1113546ms 19:04:39 INFO - TEST-START | kraken 19:04:39 INFO - operating with platform_type : linux_ 19:04:39 INFO - Initialising browser for kraken test... 19:04:39 INFO - TEST-INFO | started process 12696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFVkzo/profile http://localhost:46437/getInfo.html) 19:04:43 INFO - PROCESS | 12696 | __metrics Screen width/height:1600/1200 19:04:43 INFO - PROCESS | 12696 | colorDepth:24 19:04:43 INFO - PROCESS | 12696 | Browser inner width/height: 1024/697 19:04:43 INFO - PROCESS | 12696 | __metrics 19:04:44 INFO - PROCESS | 12696 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:04:44 INFO - PROCESS | 12696 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:45 INFO - PROCESS | 12696 | console.error: PushService: 19:04:45 INFO - PROCESS | 12696 | stateChangeProcessEnqueue: Error transitioning state 19:04:45 INFO - PROCESS | 12696 | UnknownError 19:04:45 INFO - TEST-INFO | 12696: exit 0 19:04:45 INFO - Browser initialized. 19:04:45 INFO - Running cycle 1/1 for kraken test... 19:04:45 INFO - TEST-INFO | started process 12787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFVkzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:57 INFO - PROCESS | 12787 | RSS: Main: 143339520 19:04:57 INFO - PROCESS | 12787 | 19:04:59 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46437/tests/kraken/driver.html?testName=audio-beat-detection) 19:05:00 INFO - PROCESS | 12787 | RSS: Main: 186748928 19:05:00 INFO - PROCESS | 12787 | 19:05:03 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46437/tests/kraken/driver.html?testName=audio-dft) 19:05:03 INFO - PROCESS | 12787 | RSS: Main: 174374912 19:05:03 INFO - PROCESS | 12787 | 19:05:06 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46437/tests/kraken/driver.html?testName=audio-fft) 19:05:07 INFO - PROCESS | 12787 | RSS: Main: 265596928 19:05:07 INFO - PROCESS | 12787 | 19:05:09 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46437/tests/kraken/driver.html?testName=audio-oscillator) 19:05:09 INFO - PROCESS | 12787 | RSS: Main: 171896832 19:05:09 INFO - PROCESS | 12787 | 19:05:12 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:05:12 INFO - PROCESS | 12787 | RSS: Main: 173203456 19:05:12 INFO - PROCESS | 12787 | 19:05:15 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46437/tests/kraken/driver.html?testName=imaging-darkroom) 19:05:16 INFO - PROCESS | 12787 | RSS: Main: 209039360 19:05:16 INFO - PROCESS | 12787 | 19:05:19 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46437/tests/kraken/driver.html?testName=imaging-desaturate) 19:05:20 INFO - PROCESS | 12787 | RSS: Main: 208732160 19:05:20 INFO - PROCESS | 12787 | 19:05:22 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46437/tests/kraken/driver.html?testName=json-parse-financial) 19:05:23 INFO - PROCESS | 12787 | RSS: Main: 208048128 19:05:23 INFO - PROCESS | 12787 | 19:05:25 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:05:25 INFO - PROCESS | 12787 | RSS: Main: 170373120 19:05:25 INFO - PROCESS | 12787 | 19:05:27 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:05:27 INFO - PROCESS | 12787 | RSS: Main: 177287168 19:05:27 INFO - PROCESS | 12787 | 19:05:29 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:05:30 INFO - PROCESS | 12787 | RSS: Main: 187043840 19:05:30 INFO - PROCESS | 12787 | 19:05:33 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:05:33 INFO - PROCESS | 12787 | RSS: Main: 195624960 19:05:33 INFO - PROCESS | 12787 | 19:05:36 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:36 INFO - PROCESS | 12787 | RSS: Main: 192217088 19:05:36 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:46437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46437/tests/kraken/driver.html?testName=ai-astar) 19:05:38 INFO - PROCESS | 12787 | RSS: Main: 242655232 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | __start_tp_report 19:05:38 INFO - PROCESS | 12787 | _x_x_mozilla_page_load 19:05:38 INFO - PROCESS | 12787 | _x_x_mozilla_page_load_details 19:05:38 INFO - PROCESS | 12787 | |i|pagename|runs| 19:05:38 INFO - PROCESS | 12787 | |0;ai-astar;113;112;112;113;114;113;114;114;112;113 19:05:38 INFO - PROCESS | 12787 | |1;audio-beat-detection;147;127;122;163;123;119;120;122;144;118 19:05:38 INFO - PROCESS | 12787 | |2;audio-dft;161;162;164;164;160;160;160;162;168;161 19:05:38 INFO - PROCESS | 12787 | |3;audio-fft;74;76;76;116;75;77;76;76;97;75 19:05:38 INFO - PROCESS | 12787 | |4;audio-oscillator;83;82;115;82;82;81;115;81;82;118 19:05:38 INFO - PROCESS | 12787 | |5;imaging-gaussian-blur;118;116;116;117;116;116;117;117;117;117 19:05:38 INFO - PROCESS | 12787 | |6;imaging-darkroom;147;146;146;146;147;145;146;146;146;146 19:05:38 INFO - PROCESS | 12787 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;95;95 19:05:38 INFO - PROCESS | 12787 | |8;json-parse-financial;50;49;49;49;50;55;50;50;50;51 19:05:38 INFO - PROCESS | 12787 | |9;json-stringify-tinderbox;60;58;59;58;59;58;59;59;59;58 19:05:38 INFO - PROCESS | 12787 | |10;stanford-crypto-aes;74;73;74;74;81;75;80;72;74;76 19:05:38 INFO - PROCESS | 12787 | |11;stanford-crypto-ccm;123;131;121;121;122;132;129;122;163;121 19:05:38 INFO - PROCESS | 12787 | |12;stanford-crypto-pbkdf2;154;156;152;158;154;153;153;155;153;152 19:05:38 INFO - PROCESS | 12787 | |13;stanford-crypto-sha256-iterative;64;64;63;66;62;66;62;62;60;61 19:05:38 INFO - PROCESS | 12787 | __end_tp_report 19:05:38 INFO - PROCESS | 12787 | __start_cc_report 19:05:38 INFO - PROCESS | 12787 | _x_x_mozilla_cycle_collect,1622 19:05:38 INFO - PROCESS | 12787 | __end_cc_report 19:05:38 INFO - PROCESS | 12787 | __startTimestamp1479956738876__endTimestamp 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | ------- Summary: start ------- 19:05:38 INFO - PROCESS | 12787 | Number of tests: 14 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 19:05:38 INFO - PROCESS | 12787 | Values: 113.0 112.0 112.0 113.0 114.0 113.0 114.0 114.0 112.0 113.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:125.00 stddev:15.36 (12.3%) stddev-sans-first:15.08 19:05:38 INFO - PROCESS | 12787 | Values: 147.0 127.0 122.0 163.0 123.0 119.0 120.0 122.0 144.0 118.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.53 (1.6%) stddev-sans-first:2.65 19:05:38 INFO - PROCESS | 12787 | Values: 161.0 162.0 164.0 164.0 160.0 160.0 160.0 162.0 168.0 161.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:13.79 (18.1%) stddev-sans-first:14.34 19:05:38 INFO - PROCESS | 12787 | Values: 74.0 76.0 76.0 116.0 75.0 77.0 76.0 76.0 97.0 75.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:16.52 (20.1%) stddev-sans-first:17.19 19:05:38 INFO - PROCESS | 12787 | Values: 83.0 82.0 115.0 82.0 82.0 81.0 115.0 81.0 82.0 118.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 19:05:38 INFO - PROCESS | 12787 | Values: 118.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 19:05:38 INFO - PROCESS | 12787 | Values: 147.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 146.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:05:38 INFO - PROCESS | 12787 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.77 (3.5%) stddev-sans-first:1.87 19:05:38 INFO - PROCESS | 12787 | Values: 50.0 49.0 49.0 49.0 50.0 55.0 50.0 50.0 50.0 51.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 19:05:38 INFO - PROCESS | 12787 | Values: 60.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 59.0 58.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.95 (4.0%) stddev-sans-first:3.09 19:05:38 INFO - PROCESS | 12787 | Values: 74.0 73.0 74.0 74.0 81.0 75.0 80.0 72.0 74.0 76.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.00 stddev:12.88 (10.2%) stddev-sans-first:13.50 19:05:38 INFO - PROCESS | 12787 | Values: 123.0 131.0 121.0 121.0 122.0 132.0 129.0 122.0 163.0 121.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:1.89 (1.2%) stddev-sans-first:2.00 19:05:38 INFO - PROCESS | 12787 | Values: 154.0 156.0 152.0 158.0 154.0 153.0 153.0 155.0 153.0 152.0 19:05:38 INFO - PROCESS | 12787 | 19:05:38 INFO - PROCESS | 12787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.00 (3.1%) stddev-sans-first:2.09 19:05:38 INFO - PROCESS | 12787 | Values: 64.0 64.0 63.0 66.0 62.0 66.0 62.0 62.0 60.0 61.0 19:05:38 INFO - PROCESS | 12787 | -------- Summary: end -------- 19:05:38 INFO - PROCESS | 12787 | 19:05:39 INFO - TEST-INFO | 12787: exit 0 19:05:39 INFO - TEST-OK | kraken | took 59854ms 19:05:39 INFO - SUITE-END | took 1173s 19:05:40 INFO - Completed test suite (00:19:33) 19:05:40 INFO - javascript benchmark 19:05:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.058882335299, 3178.1736748445405, 3184.379046086014, 3194.089684439932, 3212.469942459494, 5562.777488900444, 5615.045442274813, 5661.348944871341, 5673.744681489333, 5680.715964201789, 5503.669779813214, 5531.751071201806, 5559.972200138994, 5562.610617256793, 5593.776248950047, 5030.346055012843, 5055.368078990126, 5061.215511595699, 5114.539691427771, 5125.154349532323, 4916.434610019858, 5075.4163271223915, 5134.306868572751, 5138.58891288696, 5168.922466162991, 4893.04585605807, 4984.725840078794, 4999.8000079996755, 5005.374328208974, 5095.9745201273945, 5147.48525147486, 5180.430152683201, 5181.870453238662, 5249.107651699221, 5253.6322457428, 5044.243363495469, 5136.666116702402, 5159.948400515985, 5184.585233181337, 5235.58115350771, 5244.449332820037, 5282.313299271109, 5350.57195424369, 5393.0, 5474.91787623186, 5880.382559831199, 5897.439743224387, 5902.940970590325, 6009.819705408845, 6016.8194954151, 6039.184710064129, 6052.1526986221525, 6053.364396738367, 6067.059605761114, 6068.33248342682, 5383.16560933056, 5435.728213589305, 5535.861603459945, 5539.307586551641, 5597.832065038056, 6143.0, 6175.876482470415, 6186.1648677428875, 6187.381261873777, 6210.689465526705, 5934.732937017845, 5946.286445626552, 5949.196858424144, 5955.13650520672, 5986.042233242661, 5787.421257874263, 5827.155062515912, 5862.443067908542, 5900.616459930091, 5920.200772895604, 5941.881162376728, 5955.583109182316, 5960.791372301948, 5964.7315870785915, 5990.520758339322, 5925.911111333334, 5963.463288303987, 5972.462478376967, 5977.22296101504, 6004.489618382399, 4434.157510073076, 4472.485664148665, 4534.183846907588, 4604.861854144381, 4609.654275929319, 4068.2677118119022, 4104.630583247522, 4122.299209134454, 4127.380892866094, 4145.854895078658, 5758.712064396847, 5769.653820770767, 5771.88456230873, 5775.191473193756, 5775.451332123442, 5836.182934389189, 5844.970775146097, 5893.764249430061, 6079.422454866781, 6086.208792856989, 5563.610547261653, 5646.181303711021, 5667.206591077253, 5668.26312579362, 5676.858078547987, 5135.768890399941, 5136.794528218904, 5146.794128234904, 5147.6654017488745, 5149.794008239628, 5900.970495147497, 6066.241719785027, 6111.786087486917, 6128.3565225651555, 6131.110988906584, 5774.855628609151, 5844.795432159854, 5910.7931222407005, 5920.940790592212, 6022.277326720821, 6158.076288556752, 6160.10678451631, 6165.445109940127, 6170.7223174958135, 6175.3515880831865, 5834.27071616048, 5839.153322768259, 5847.210626565359, 5849.502792262705, 5852.356240813422, 5585.972070139624, 5695.857603559944, 5866.120081987736, 5898.616589921641, 5913.58604897653, 5796.94203057964, 5848.707564621837, 5853.151293062397, 5861.0, 5881.794137205177, 5809.970950145223, 5837.241158649348, 5843.707814609337, 5846.853828654318, 5847.152162936435, 5659.462351076641, 5665.291838520185, 5669.489745922887, 5689.0, 5814.854628634318, 5815.3603103657715, 5827.679477628772, 5842.065269556851, 5846.35690074083, 5853.560982926383, 5682.715864206691, 5690.37405885344, 5693.5445164387575, 5695.45893140151, 5700.743466544099], "value": 5487.418020100487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7932223721698, 615.5444970721666, 627.6391075131801, 634.8476365672234, 646.5635695905265, 35290.470642940374, 39055.0, 39091.41362879559, 39126.60873391265, 46199.30701039487, 44730.0, 49917.75041124798, 49980.0, 50016.74991625046, 50098.74950625251, 9281.164695177433, 9432.339736218468, 9436.528173591327, 9437.433753974748, 9446.338756287063, 8498.702545410912, 8690.608922598498, 9180.8622870657, 9289.303302252325, 10924.235303528756, 10913.181511386638, 11313.208075434723, 11323.603673871416, 11333.0366918812, 11335.37655428951, 11070.28043177191, 11111.055560277386, 11136.387498687569, 11142.49858756358, 11159.442027898654, 10904.61833835812, 11088.057515111144, 11109.388983605979, 11113.611023614134, 11117.499712512876, 45440.3183952241, 45601.771991140165, 45661.315080273824, 45743.31385029194, 45746.542534574895, 3696.630336966282, 3816.141368192162, 3853.8265778040054, 4029.4761680981283, 4366.279563871989, 34242.14394640154, 34603.4809477858, 34741.47887781685, 34854.12864678378, 35839.10402239939, 4569.223232050559, 4676.321933319649, 4682.6253899687945, 4718.575328220477, 4782.832600858953, 272343.999999998, 272632.0, 273890.0, 274335.0, 274720.0, 38886.22227555433, 39962.80018599946, 39976.600233997866, 66002.0, 66363.66818165878, 43199.35200971988, 43301.0, 43352.78323608425, 43389.783051084545, 43390.0, 16548.33806647745, 16694.83305166957, 16697.0, 16714.498565043068, 16730.16349182536, 13547.661308467366, 13586.0, 13618.0, 13634.727305453835, 13635.318234088256, 8961.59672814725, 9182.63269469227, 9324.067593240621, 9638.373505722106, 9650.75873103164, 3620.7827530347736, 3637.563492380931, 3670.871519496858, 3691.778493290411, 3712.9443058354145, 1041.5261056219401, 1070.8500809886623, 1119.2445099557765, 1155.8555180602425, 1230.034422977958, 35456.46815297772, 35577.28845423077, 35768.10579735475, 36124.27751445009, 36539.49919063135, 1116.5143162724241, 1128.103157989384, 1139.9772004559863, 1167.8773728758529, 1183.3905538647602, 18436.170372333276, 18852.34016809405, 18861.81138188628, 18879.339223127125, 18896.62206755885, 520292.0, 529068.0, 530824.0, 534071.0, 535587.0, 63166.36833631697, 63645.68177159085, 63787.0, 63797.68101159464, 63939.68030159819, 1358.1579420759192, 1397.1198145168682, 1426.1942002768403, 1436.432609119392, 1438.676297833, 33216.83391583027, 34819.82590087033, 34829.825850870584, 35355.82322088373, 35410.64589354177, 58263.70868145632, 60725.0, 62740.0, 62997.0, 68249.65875170792, 533097.0, 537157.0, 538375.0, 540927.0, 541430.0, 36873.44689829709, 47362.91470193033, 48390.516094838604, 48572.27141592808, 49045.50954490552, 51380.74309628428, 52591.0, 53392.46607533875, 53611.0, 54186.45813541814, 41107.0, 41425.37861932013, 42112.0, 42132.368014479194, 42397.364039538814, 43208.82431642275, 44745.0, 44981.775091125644, 46032.0, 46647.533524664315, 46097.30854037259, 46139.0, 47476.0, 47537.7623111896, 47548.7622561885, 37748.62251377451, 39958.400623990085, 40059.19881602293, 40525.594744052185, 40640.79679601583, 30343.544846826873, 30660.84669576727, 30759.2310192247, 31270.374592508477, 32839.40768808971], "value": 20757.66162308916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2488022995851, 428.1020487050637, 430.7157276197709, 435.3817579037767, 444.8131784650445, 16155.676886462265, 19030.333938312146, 21293.787062129373, 21301.615394999313, 21488.677669834964, 19991.90004049978, 20033.19867205314, 20524.486887827774, 20604.793952060474, 20756.584868302663, 5718.256626638531, 5738.470840433124, 5968.67172305523, 5969.761209551612, 5971.940280597182, 4334.5882141196535, 4538.0, 5891.440313170242, 5930.229070220887, 6151.661658608775, 6360.936390636104, 6483.059956306332, 6485.70814313357, 6488.156539649839, 6496.740130394778, 6362.809115726535, 6420.4542613877875, 6449.451796597295, 6491.318411566788, 6534.967325163391, 5339.145736682151, 5846.883062338772, 5850.6782126983, 5857.179994800731, 5857.970710146465, 13914.860851391457, 14679.412823487048, 14692.26538673062, 14719.55841324762, 20738.585228295502, 2393.3179043972386, 2396.5805983952737, 2417.8065754739755, 2824.6045553622303, 3079.245584831708, 11028.944855275673, 11096.61161859331, 11183.552657893755, 14582.708345833023, 14704.15174876087, 1891.990540047291, 1919.683252263375, 1946.4452631000097, 1973.4079776067265, 2027.9860069965018, 85697.0, 87411.99999999936, 87659.0, 88543.67184492173, 89033.55483222607, 11747.295162290118, 11846.703832404086, 11958.40207989597, 11960.700982475508, 12069.189621556661, 17047.23287452043, 17079.914600426917, 17086.572835679206, 17087.829121708623, 17101.14494275306, 8150.551719655476, 8604.31165506758, 8713.695020674246, 8721.563921803885, 8818.0, 8388.496690198608, 8429.452085614415, 8439.282660973886, 8478.406511544134, 8635.179657932485, 5120.359955005624, 5135.35808023997, 5188.45521220274, 5191.610629202825, 5285.207218917193, 1836.775416541975, 1967.1344608372272, 2087.1338394566387, 2102.3903068110076, 2150.4838838678606, 905.4883990545321, 962.9662961796304, 976.5507866381544, 1039.9808187975675, 1098.3794156301665, 20197.798022019884, 20301.0, 20370.898145509473, 20473.692894606593, 20712.067956941974, 986.9753256168653, 1024.073213741565, 1052.4211683574003, 1060.157175045825, 1094.179365475893, 10755.516001779783, 11527.365994870363, 11537.88462115368, 11626.1861669684, 11627.1860969733, 448577.0, 456399.0, 461363.0, 467931.0, 485015.0, 90340.0, 92590.53704731568, 94672.0, 96117.0, 101272.0, 1027.3784360461962, 1046.8220402531435, 1052.0321304399818, 1070.796548655753, 1072.126217133034, 17524.211410486303, 17656.646867062842, 17937.461876143738, 18196.636067278847, 18317.725234121765, 41624.0, 42238.0, 42809.1438171241, 42931.570684292754, 44488.0, 54898.451015489336, 59367.40632593792, 59519.0, 61072.0, 61783.0, 9015.729528114167, 9131.863022054542, 9156.359054866096, 9179.862302065609, 9434.85847712271, 10611.469426528796, 13885.930570347084, 13999.580012599637, 14272.286385680882, 14325.856741432452, 11369.658910232707, 11452.30854848637, 11723.765524689288, 12198.939005304917, 12373.62879113628, 11989.160758746804, 12042.638720838038, 12106.75786484283, 12351.69120771988, 12593.0, 12319.815202771786, 12473.93763031179, 12506.499740010298, 12626.747465050832, 12734.872651273368, 8928.598213080297, 9194.17252447283, 9233.861492077489, 9371.531423428665, 9472.57373418184, 9470.526473676151, 12033.45849436795, 12165.026797855973, 12185.329806860707, 12219.26684398939], "value": 9590.574704811139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.8642022217998, 1549.1634517360626, 1710.2303963216548, 1802.41421538, 1819.0995457248664, 8427.578621068953, 9090.50002249876, 9094.590743416546, 9095.863562046574, 9105.0894910509, 7790.45466817323, 8075.959620201906, 8458.534780587066, 8675.652973881037, 8712.564371781416, 2402.531506356261, 2428.453597940467, 2429.8056155507606, 2433.85396876188, 2438.6220135878966, 2439.597466418039, 2445.29086564896, 2459.655648209252, 2459.7909177719825, 2463.273334366357, 2420.261820144855, 2430.44099857033, 2430.647556104364, 2430.6597076409316, 2431.4286142756437, 2357.092519380034, 2359.587072262347, 2371.0397289097855, 2389.4862604539935, 2426.4419183587875, 2342.2270650685405, 2342.695449591542, 2348.8825558721996, 2349.1777877742825, 2374.8693821839793, 8839.337049721296, 8978.23684986777, 8978.371513994023, 8983.0, 9030.683926062622, 5348.197770334442, 5506.724663766836, 5522.641028333145, 5523.364813046511, 5527.309086364205, 3195.3130077033316, 3383.7800542964874, 3394.932101357959, 3435.158386195398, 3437.914052148691, 1038.7558923652934, 1064.5050051725984, 1071.1430855315716, 1105.850710154135, 1108.51225460797, 12243.081768867281, 12295.139340246187, 12375.814362784566, 12382.318972456602, 12402.069844761589, 4707.270373092176, 4720.12677654635, 4797.673855100533, 4821.035792841376, 4920.3603531541385, 10462.738431539121, 10496.317739346918, 10505.789884202273, 10516.789664206673, 10521.210909181842, 5499.037668408013, 5500.724963751796, 5501.119820828728, 5508.669479831223, 5509.063459211943, 4364.71629344098, 4504.436945381827, 4802.447718512346, 4916.754162291871, 5071.518205770446, 4102.548719640837, 4118.629323360912, 4205.789710514462, 4225.852095176716, 4245.681573881971, 1308.6793735534854, 1315.046591221357, 1323.3383308345826, 1330.973380532384, 1341.5698250902258, 954.117441366733, 956.268454632207, 983.9606415743433, 1017.2472370445817, 1043.6868939318174, 6000.0, 6109.450149486567, 6126.540509461719, 6143.662098584531, 6159.538034647419, 995.6316163019584, 995.9053889880449, 1013.8225810483136, 1050.8896565860628, 1073.736934451049, 4197.349410841324, 4429.712068715523, 4431.512533621299, 4448.755318457451, 4515.593596576324, 10823.512941917475, 11054.834177487344, 11129.33224006546, 11163.386013769159, 11164.330140191452, 11009.61466348674, 11044.723881903017, 11049.33703977764, 11050.447477626087, 11056.226064175591, 7659.119201291923, 8058.798530036679, 8293.585320733939, 8347.081820999685, 8426.831463370698, 6153.8307721532765, 6229.190205273467, 6300.432961033529, 6356.141920840627, 6401.775937842153, 10072.143867771028, 10112.241581881535, 10131.79736405253, 10137.138343240907, 10137.341072830242, 9660.468674222986, 9995.150412214753, 10031.29780915329, 10247.077763001067, 10315.020073093045, 7178.676959536729, 7391.113066432063, 7395.926040739524, 7922.841543169219, 8057.798555036171, 7998.48009879356, 8100.837983240184, 8453.112423195476, 8481.618327175416, 8587.871181932402, 7765.844683106419, 7895.131535531202, 7931.762047138595, 8062.113167551682, 8097.2712455879255, 7705.345045670956, 7751.186125456746, 7756.728514501965, 7757.0, 7857.607119643881, 6930.27232140618, 7086.539374940612, 7096.858062838611, 7100.254473280231, 7102.14774227096, 5256.316678831728, 5341.813036543857, 5439.537639300704, 5455.1544510600925, 5509.889802204014, 5403.702796346239, 5463.235147079333, 5480.479354461319, 5513.9448605513435, 5618.04493236159], "value": 4751.381912550877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.50456585667854, 352.8782570013345, 359.7266077780886, 374.6459595682078, 378.77462909568817, 5575.609707320489, 5578.581606379523, 5600.971995140024, 5604.299462567179, 5626.409227031164, 5236.476352364771, 5333.866653333668, 5407.891842163154, 5476.91784623231, 5543.029969755296, 4361.629261512775, 4375.4311939447825, 4379.496357918841, 4381.9561804381865, 4383.9342409863875, 4376.409184760048, 4382.496012958519, 4384.298512238042, 4386.1008493258805, 4394.450693663292, 4115.54728979812, 4329.242382583051, 4348.478182618091, 4348.804303806336, 4350.673699472536, 4317.827286908519, 4320.265554855682, 4327.870163895088, 4334.523202447728, 4340.045190058182, 3843.903902402434, 3844.308024555579, 3848.4034974578985, 3855.1711382052995, 3867.1878905429894, 5223.294855194538, 5367.718719544178, 5422.240886275925, 5429.457054294539, 5439.782408703647, 4974.950250497521, 4978.178600530908, 4980.252962055721, 5008.348914641073, 5023.547880690755, 5803.680797556132, 5813.593048486608, 5823.737931793079, 5829.708514574254, 5830.562707796932, 4150.796269081962, 4205.432266643995, 4241.830326786925, 4257.510386305584, 4261.446012018418, 6014.578979471439, 6020.5785595008365, 6026.0, 6046.909296360602, 6049.909251361233, 4252.829886804493, 4258.42511260982, 4275.722078064916, 4278.850240241577, 4285.314349704033, 4199.475065616798, 4351.0, 4393.692441529062, 4415.271480205794, 4432.202203603318, 4989.501049894981, 4990.925136122961, 4998.5751211146735, 5002.673222307198, 5008.549230569266, 5848.912266316009, 5854.736536855767, 5859.267591551056, 5860.150278209636, 5884.617499862496, 1479.9926000369928, 1483.9686417939429, 1497.1615895098562, 1525.6262215756988, 1563.3199558191995, 1055.9598795186735, 1066.2323127348297, 1082.2316155529504, 1082.77646259726, 1089.5260561655705, 5610.943890561124, 5654.5193658538665, 5662.37713851476, 5672.128197694751, 5673.716314184274, 5938.940610593839, 5958.046712525975, 5972.910406343908, 5991.5206783457215, 5997.8200653979575, 5461.890762184734, 5606.467385598362, 5640.266765320564, 5652.519535839418, 5659.915101273484, 3136.3654530194744, 3163.7785355024926, 3166.461701510703, 3179.395914776231, 3185.792923459968, 5882.823515294548, 6108.602940808833, 6124.326324104345, 6135.478484328793, 6154.353792851775, 6014.218151640259, 6052.878942421215, 6066.393360663898, 6067.7876274331065, 6089.725962331617, 6116.633002019893, 6128.771147907929, 6131.294901086432, 6140.530600210866, 6148.723307451175, 5705.172749951317, 5909.674967876808, 5924.52603791687, 5940.762369505172, 5972.611780234271, 5839.562032847638, 5868.589198756217, 5871.7651293947765, 5875.354900627831, 5886.734352114316, 5952.345242023461, 6083.9695801522475, 6125.601835880653, 6134.509239260759, 6164.568480206342, 4371.51368534687, 4426.5130835607415, 4445.1998640245065, 4457.576530229623, 4464.464264288306, 5864.912026319524, 5872.500837428866, 5893.675847828239, 5894.823155305347, 5942.168096466585, 5579.2746942897165, 5740.885182296414, 5780.5953583248765, 5859.296884373903, 5886.23478947734, 5813.0, 5838.153467747238, 5857.414258574108, 5868.618539794899, 5868.882622347614, 5587.888242235052, 5784.334801497882, 5798.304203495608, 5850.2102216200265, 5855.707214639337, 5794.217780599565, 5799.884002320015, 5846.766129354948, 5877.617954832922, 5897.970510147422, 5701.688611619434, 5706.80288089097, 5718.885622287614, 5722.484976352148, 5746.310442746897], "value": 4469.892448885741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.2195935820329, 856.5674334461096, 874.2918236228654, 899.6761165980242, 924.0713083351233, 16471.505854824358, 17694.0, 17741.201645925932, 17765.64468710625, 17785.110744462756, 16071.437499687514, 16438.589035274123, 16448.342066317364, 16453.67092658146, 16460.259288332025, 709.0994437064925, 724.384273367636, 847.9448835825667, 869.5999840073542, 871.9564021798884, 827.3918669777738, 841.9368547358972, 845.4039901869168, 849.2144766091371, 851.1360968616827, 898.0346127912487, 902.1609902790402, 902.9051949545302, 903.0202230579829, 903.3811838890381, 881.8280435315116, 886.2201262888681, 890.3767362846002, 891.7191084808297, 893.053363434758, 658.7101675262869, 659.6635715784936, 659.7525927777084, 663.1975309875008, 664.1498881431775, 15985.280662370222, 16037.679246415122, 16088.436904708278, 16090.75863862043, 16121.27454264561, 14628.488002919847, 14693.926530367387, 14740.778888316683, 15143.167125808077, 16199.595010124842, 14458.349374278183, 14653.926730366387, 14852.628684282872, 14899.478518251917, 15261.542153735405, 4826.638002149853, 4838.975805120987, 4880.341153944208, 5038.899222015576, 5057.8229761958155, 69729.0, 72322.63838680772, 73247.63376183138, 90769.0, 92071.0, 11903.047756179485, 12067.57763478274, 12388.194767340274, 12456.439460224312, 12830.55093071738, 22451.663225051638, 22688.65967010496, 22692.773072269065, 22742.431439213822, 22766.0, 9439.575219115019, 9534.380265282734, 9592.95203523992, 9655.951720241354, 9734.0, 4956.975215123974, 5126.974365128225, 5222.0, 5247.02929957959, 5304.310439642822, 3688.207035487383, 3850.6919446444217, 3853.3641949078647, 3858.7684738915755, 3864.381698928158, 666.6500087454125, 676.6075676107846, 686.5914780705472, 699.4369532526264, 712.7540998355558, 693.9236683964759, 786.9134395216522, 806.5967016491754, 808.1998821167119, 808.8463191993502, 10475.319104258198, 10535.367877927349, 10621.666451465544, 10726.302790318605, 11086.944565277123, 729.1833146875427, 790.6205021589554, 805.4683908620283, 812.9471584346999, 833.3832963607008, 5092.0, 5100.464451232567, 5113.846584602468, 5150.253213284052, 5166.974165129225, 72525.2747472529, 121614.39192804156, 124728.37635811763, 125257.37371313268, 133385.0, 107145.4642726797, 108479.45760271148, 109694.0, 112760.0, 113976.0, 88650.55674721586, 90042.29873103686, 94099.52950235204, 94185.5290723542, 94713.0, 9530.714078577654, 9786.85319720219, 9875.950620246853, 10046.799064018825, 10136.391816491034, 56196.438035620755, 57055.42944570501, 57398.42601573931, 58381.12428313664, 58824.64701412067, 79368.60315698385, 82022.58988705018, 82756.0, 83622.16377836144, 87533.0, 12472.688182795502, 12502.124851260689, 12628.558000469939, 12711.61865144047, 13127.0, 13684.589462316146, 13689.315534223448, 13910.026298159437, 14289.928550357597, 15051.473198438001, 12354.444050017592, 13215.471381145031, 13314.267715275366, 13924.16455012662, 14524.636884077983, 13150.145240559334, 13268.93365533166, 13654.0, 13817.0, 14756.188409637572, 12352.505899764268, 14264.643383915485, 14334.569962901129, 14510.201938893462, 15060.924695376452, 11752.706182345168, 12357.93821030925, 12415.875841241472, 12531.310777907303, 12730.68173295675, 12422.503099875903, 12505.124641275388, 12640.620781376574, 12661.430235639602, 12836.358182091044], "value": 8154.048158030604, "unit": "score"}], "name": "dromaeo_css", "value": 7576.828206054012, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 113.0, 114.0, 113.0, 114.0, 114.0, 112.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 122.0, 163.0, 123.0, 119.0, 120.0, 122.0, 144.0, 118.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 164.0, 160.0, 160.0, 160.0, 162.0, 168.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 116.0, 75.0, 77.0, 76.0, 76.0, 97.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 82.0, 82.0, 81.0, 115.0, 81.0, 82.0, 118.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 50.0, 55.0, 50.0, 50.0, 50.0, 51.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 81.0, 75.0, 80.0, 72.0, 74.0, 76.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 121.0, 121.0, 122.0, 132.0, 129.0, 122.0, 163.0, 121.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 152.0, 158.0, 154.0, 153.0, 153.0, 155.0, 153.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 66.0, 62.0, 66.0, 62.0, 62.0, 60.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1467.0, "alertThreshold": 2.0}]} 19:05:40 INFO - Return code: 0 19:05:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:05:40 INFO - # TBPL SUCCESS # 19:05:40 INFO - Running post-action listener: _resource_record_post_action 19:05:40 INFO - [mozharness: 2016-11-24 03:05:40.212813Z] Finished run-tests step (success) 19:05:40 INFO - Running post-run listener: _resource_record_post_run 19:05:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1744896; Write bytes: 330035200; Read time: 252; Write time: 190500 19:05:40 INFO - TinderboxPrint: CPU usage
12.9% 19:05:40 INFO - TinderboxPrint: I/O read bytes / time
1,744,896 / 252 19:05:40 INFO - TinderboxPrint: I/O write bytes / time
330,035,200 / 190,500 19:05:40 INFO - TinderboxPrint: CPU idle
8,251.2 (87.1%) 19:05:40 INFO - TinderboxPrint: CPU user
1,182.0 (12.5%) 19:05:40 INFO - TinderboxPrint: Swap in / out
0 / 0 19:05:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106885120; Read time: 40; Write time: 80196 19:05:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 217882624; Read time: 192; Write time: 109692 19:05:40 INFO - Running post-run listener: _upload_blobber_files 19:05:40 INFO - Blob upload gear active. 19:05:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05: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 19:05: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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:05: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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:05:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:42 INFO - (blobuploader) - INFO - Done attempting. 19:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:46 INFO - (blobuploader) - INFO - Done attempting. 19:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:46 INFO - (blobuploader) - INFO - Done attempting. 19:05:46 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:46 INFO - Return code: 0 19:05:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a185776c8099adda3c1ea210a06a44553386a7324bffe34f1b0b2c85dfdfa8584527dcde38235dbfdc0fee63d690e945f3de0c02d9a2dce465f057d16276ae83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62950a473499aaa39c8aa4b3cc1850c793de834e7bad897668e88411f66e4bd82b2dbc7e7a32d0ba3f5aec2d23711b25fabda8ebacae9d7689926a2e471f7148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4529a4c48f8fdc9713cb268e86d859ef3a6990364e6eb1d6e822cb9ae16366f3b9b301354837ce35fa5d5e0a7048f149f6821b3a6587d7a5a9823d8199a84efe"} 19:05:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:46 INFO - Contents: 19:05:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a185776c8099adda3c1ea210a06a44553386a7324bffe34f1b0b2c85dfdfa8584527dcde38235dbfdc0fee63d690e945f3de0c02d9a2dce465f057d16276ae83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62950a473499aaa39c8aa4b3cc1850c793de834e7bad897668e88411f66e4bd82b2dbc7e7a32d0ba3f5aec2d23711b25fabda8ebacae9d7689926a2e471f7148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4529a4c48f8fdc9713cb268e86d859ef3a6990364e6eb1d6e822cb9ae16366f3b9b301354837ce35fa5d5e0a7048f149f6821b3a6587d7a5a9823d8199a84efe"} 19:05:46 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:46 INFO - Copying logs to upload dir... 19:05:46 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.419469 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-23 19:05:46.732090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 19:05:46.736177) ========= 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=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a185776c8099adda3c1ea210a06a44553386a7324bffe34f1b0b2c85dfdfa8584527dcde38235dbfdc0fee63d690e945f3de0c02d9a2dce465f057d16276ae83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62950a473499aaa39c8aa4b3cc1850c793de834e7bad897668e88411f66e4bd82b2dbc7e7a32d0ba3f5aec2d23711b25fabda8ebacae9d7689926a2e471f7148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4529a4c48f8fdc9713cb268e86d859ef3a6990364e6eb1d6e822cb9ae16366f3b9b301354837ce35fa5d5e0a7048f149f6821b3a6587d7a5a9823d8199a84efe"} build_url:https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011948 build_url: 'https://queue.taskcluster.net/v1/task/S1ThVFqISJmaVOvT2b-wDw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a185776c8099adda3c1ea210a06a44553386a7324bffe34f1b0b2c85dfdfa8584527dcde38235dbfdc0fee63d690e945f3de0c02d9a2dce465f057d16276ae83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62950a473499aaa39c8aa4b3cc1850c793de834e7bad897668e88411f66e4bd82b2dbc7e7a32d0ba3f5aec2d23711b25fabda8ebacae9d7689926a2e471f7148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4529a4c48f8fdc9713cb268e86d859ef3a6990364e6eb1d6e822cb9ae16366f3b9b301354837ce35fa5d5e0a7048f149f6821b3a6587d7a5a9823d8199a84efe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 19:05:46.762561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 19:05:46.762978) ========= 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=836cfdc75598d54cb747368e000001a9-1479954936.340031-998302144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 19:05:46.846709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 19:05:46.847045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 19:05:46.847371) ========= ========= Total master_lag: 0.17 =========