builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1483091769.97 results: success (0) buildid: 20161229194619 builduid: c781d4d54a4a42e384227158e31764ad revision: 665c91fbf4bd40b25beb12ef7e69ffced2044262 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:09.971220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:09.971684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:09.971966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:09.987134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:09.987430) ========= 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=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 01:56:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-12-30 01:56:10 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165662 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:10.377599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:10.377918) ========= 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=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015857 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:10.408886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-30 01:56:10.409250) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 665c91fbf4bd40b25beb12ef7e69ffced2044262 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 665c91fbf4bd40b25beb12ef7e69ffced2044262 --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=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 01:56:10,687 truncating revision to first 12 chars 2016-12-30 01:56:10,687 Setting DEBUG logging. 2016-12-30 01:56:10,687 attempt 1/10 2016-12-30 01:56:10,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/665c91fbf4bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 01:56:11,878 unpacking tar archive at: graphics-665c91fbf4bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.555749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-30 01:56:11.981304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:11.981635) ========= script_repo_revision: 665c91fbf4bd40b25beb12ef7e69ffced2044262 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:11.982051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:11.982327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 01:56:11.990856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-30 01:56:11.991254) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:56:12 INFO - MultiFileLogger online at 20161230 01:56:12 in /builds/slave/test 01:56:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 01:56:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:56:12 INFO - {'append_to_log': False, 01:56:12 INFO - 'base_work_dir': '/builds/slave/test', 01:56:12 INFO - 'blob_upload_branch': 'Graphics', 01:56:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:56:12 INFO - 'branch': 'Graphics', 01:56:12 INFO - 'buildbot_json_path': 'buildprops.json', 01:56:12 INFO - 'config_files': ('talos/linux_config.py',), 01:56:12 INFO - 'default_actions': ('clobber', 01:56:12 INFO - 'read-buildbot-config', 01:56:12 INFO - 'download-and-extract', 01:56:12 INFO - 'populate-webroot', 01:56:12 INFO - 'create-virtualenv', 01:56:12 INFO - 'install', 01:56:12 INFO - 'run-tests'), 01:56:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:56:12 INFO - 'download_minidump_stackwalk': True, 01:56:12 INFO - 'download_symbols': 'ondemand', 01:56:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:56:12 INFO - 'tooltool.py': '/tools/tooltool.py', 01:56:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:56:12 INFO - '/tools/misc-python/virtualenv.py')}, 01:56:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:56:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:56:12 INFO - 'installer_path': 'installer.exe', 01:56:12 INFO - 'log_level': 'info', 01:56:12 INFO - 'log_name': 'talos', 01:56:12 INFO - 'log_to_console': True, 01:56:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:56:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:56:12 INFO - 'opt_config_files': (), 01:56:12 INFO - 'pip_index': False, 01:56:12 INFO - 'sps_profile': False, 01:56:12 INFO - 'sps_profile_interval': 0, 01:56:12 INFO - 'suite': 'dromaeojs-e10s', 01:56:12 INFO - 'system_bits': '32', 01:56:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:56:12 INFO - 'title': 'talos-linux64-ix-052', 01:56:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:56:12 INFO - 'use_talos_json': True, 01:56:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:56:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:56:12 INFO - 'work_dir': 'build'} 01:56:12 INFO - [mozharness: 2016-12-30 09:56:12.362301Z] Running clobber step. 01:56:12 INFO - Running pre-action listener: _resource_record_pre_action 01:56:12 INFO - Running main action method: clobber 01:56:12 INFO - rmtree: /builds/slave/test/build 01:56:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:56:13 INFO - Running post-action listener: _resource_record_post_action 01:56:13 INFO - [mozharness: 2016-12-30 09:56:13.367050Z] Finished clobber step (success) 01:56:13 INFO - [mozharness: 2016-12-30 09:56:13.367149Z] Running read-buildbot-config step. 01:56:13 INFO - Running pre-action listener: _resource_record_pre_action 01:56:13 INFO - Running main action method: read_buildbot_config 01:56:13 INFO - Using buildbot properties: 01:56:13 INFO - { 01:56:13 INFO - "project": "", 01:56:13 INFO - "product": "firefox", 01:56:13 INFO - "script_repo_revision": "default", 01:56:13 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 01:56:13 INFO - "repository": "", 01:56:13 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 01:56:13 INFO - "buildid": "20161229194619", 01:56:13 INFO - "pgo_build": "False", 01:56:13 INFO - "basedir": "/builds/slave/test", 01:56:13 INFO - "buildnumber": 22, 01:56:13 INFO - "slavename": "talos-linux64-ix-052", 01:56:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:56:13 INFO - "platform": "ubuntu64_hw", 01:56:13 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 01:56:13 INFO - "branch": "graphics", 01:56:13 INFO - "repo_path": "projects/graphics", 01:56:13 INFO - "revision": "665c91fbf4bd40b25beb12ef7e69ffced2044262", 01:56:13 INFO - "stage_platform": "linux64", 01:56:13 INFO - "builduid": "c781d4d54a4a42e384227158e31764ad", 01:56:13 INFO - "slavebuilddir": "test" 01:56:13 INFO - } 01:56:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:56:13 INFO - Running post-action listener: _resource_record_post_action 01:56:13 INFO - [mozharness: 2016-12-30 09:56:13.369604Z] Finished read-buildbot-config step (success) 01:56:13 INFO - [mozharness: 2016-12-30 09:56:13.369694Z] Running download-and-extract step. 01:56:13 INFO - Running pre-action listener: _resource_record_pre_action 01:56:13 INFO - Running main action method: download_and_extract 01:56:13 INFO - mkdir: /builds/slave/test/build/tests 01:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:13 INFO - trying https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:56:13 INFO - Downloading https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:56:13 INFO - Downloaded 1361 bytes. 01:56:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:56:13 INFO - Using the following test package requirements: 01:56:13 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:56:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:56:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:56:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'jsshell-linux-x86_64.zip'], 01:56:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:56:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:56:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:56:13 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:56:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:56:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:56:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:56:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:56:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:56:13 INFO - Fetch https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:56:14 INFO - Expected file size: 20245925 01:56:14 INFO - Obtained file size: 20245925 01:56:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:56:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:56:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:56:18 INFO - Fetch https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:56:19 INFO - Expected file size: 20245925 01:56:19 INFO - Obtained file size: 20245925 01:56:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:56:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:56:23 INFO - Fetch https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:56:24 INFO - Expected file size: 14409776 01:56:24 INFO - Obtained file size: 14409776 01:56:24 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')]} 01:56:24 INFO - trying https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:56:24 INFO - Downloading https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:56:26 INFO - Downloaded 55921681 bytes. 01:56:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:56:26 INFO - mkdir: /builds/slave/test/properties 01:56:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:56:26 INFO - Writing to file /builds/slave/test/properties/build_url 01:56:26 INFO - Contents: 01:56:26 INFO - build_url:https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:56:26 INFO - Running post-action listener: _resource_record_post_action 01:56:26 INFO - Running post-action listener: set_extra_try_arguments 01:56:26 INFO - [mozharness: 2016-12-30 09:56:26.735057Z] Finished download-and-extract step (success) 01:56:26 INFO - [mozharness: 2016-12-30 09:56:26.735284Z] Running populate-webroot step. 01:56:26 INFO - Running pre-action listener: _resource_record_pre_action 01:56:26 INFO - Running main action method: populate_webroot 01:56:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:56:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:56:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:56:26 INFO - '--tppagecycles', 01:56:26 INFO - '7'], 01:56:26 INFO - 'tests': ['tsvgm']}}, 01:56:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:56:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:56:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:56:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:56:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['damp', 'tps']}, 01:56:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'tests': ['damp', 'tps']}, 01:56:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['dromaeo_dom']}, 01:56:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:56:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['basic_compositor_video']}, 01:56:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:56:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'other-e10s': {'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['a11yr', 01:56:26 INFO - 'ts_paint', 01:56:26 INFO - 'tpaint', 01:56:26 INFO - 'sessionrestore', 01:56:26 INFO - 'sessionrestore_no_auto_restore', 01:56:26 INFO - 'tabpaint']}, 01:56:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['tsvgx', 01:56:26 INFO - 'tsvgr_opacity', 01:56:26 INFO - 'tart', 01:56:26 INFO - 'tscrollx', 01:56:26 INFO - 'cart', 01:56:26 INFO - 'tsvg_static']}, 01:56:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:56:26 INFO - 'tsvgr_opacity', 01:56:26 INFO - 'tart', 01:56:26 INFO - 'tscrollx', 01:56:26 INFO - 'cart', 01:56:26 INFO - 'tsvg_static']}, 01:56:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'talos_options': ['--disable-e10s'], 01:56:26 INFO - 'tests': ['tp5o']}, 01:56:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:56:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'talos_options': ['--disable-e10s', 01:56:26 INFO - '--xperf_path', 01:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:26 INFO - 'tests': ['tp5n']}, 01:56:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:56:26 INFO - 'talos_options': ['--xperf_path', 01:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:26 INFO - 'tests': ['tp5n']}}, 01:56:26 INFO - 'talos.zip': {'path': '', 01:56:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:56:26 INFO - Running post-action listener: _resource_record_post_action 01:56:26 INFO - [mozharness: 2016-12-30 09:56:26.754319Z] Finished populate-webroot step (success) 01:56:26 INFO - [mozharness: 2016-12-30 09:56:26.754407Z] Running create-virtualenv step. 01:56:26 INFO - Running pre-action listener: _resource_record_pre_action 01:56:26 INFO - Running main action method: create_virtualenv 01:56:26 INFO - Creating virtualenv /builds/slave/test/build/venv 01:56:26 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 01:56:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:56:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:56:26 INFO - Using real prefix '/usr' 01:56:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:56:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:56:29 INFO - Installing pip.................done. 01:56:29 INFO - Return code: 0 01:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:56:29 INFO - Reading from file tmpfile_stdout 01:56:29 INFO - Output received: 01:56:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:56:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:29 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 01:56:29 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 01:56:29 INFO - Using env: {'DISPLAY': ':0', 01:56:29 INFO - 'HOME': '/home/cltbld', 01:56:29 INFO - 'LANG': 'en_US.UTF-8', 01:56:29 INFO - 'LANGUAGE': 'en_US:en', 01:56:29 INFO - 'LOGNAME': 'cltbld', 01:56:29 INFO - 'MAIL': '/var/mail/cltbld', 01:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:29 INFO - 'MOZ_NO_REMOTE': '1', 01:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:29 INFO - 'NO_EM_RESTART': '1', 01:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:29 INFO - 'PWD': '/builds/slave/test', 01:56:29 INFO - 'SHELL': '/bin/bash', 01:56:29 INFO - 'SHLVL': '1', 01:56:29 INFO - 'TERM': 'linux', 01:56:29 INFO - 'TMOUT': '86400', 01:56:29 INFO - 'USER': 'cltbld', 01:56:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:29 INFO - '_': '/tools/buildbot/bin/python'} 01:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:29 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 01:56:29 INFO - Cleaning up... 01:56:29 INFO - Return code: 0 01:56:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:29 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:29 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 01:56:29 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 01:56:29 INFO - Using env: {'DISPLAY': ':0', 01:56:29 INFO - 'HOME': '/home/cltbld', 01:56:29 INFO - 'LANG': 'en_US.UTF-8', 01:56:29 INFO - 'LANGUAGE': 'en_US:en', 01:56:29 INFO - 'LOGNAME': 'cltbld', 01:56:29 INFO - 'MAIL': '/var/mail/cltbld', 01:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:29 INFO - 'MOZ_NO_REMOTE': '1', 01:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:29 INFO - 'NO_EM_RESTART': '1', 01:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:29 INFO - 'PWD': '/builds/slave/test', 01:56:29 INFO - 'SHELL': '/bin/bash', 01:56:29 INFO - 'SHLVL': '1', 01:56:29 INFO - 'TERM': 'linux', 01:56:29 INFO - 'TMOUT': '86400', 01:56:29 INFO - 'USER': 'cltbld', 01:56:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:29 INFO - '_': '/tools/buildbot/bin/python'} 01:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:30 INFO - Downloading/unpacking psutil>=3.1.1 01:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:32 INFO - Installing collected packages: psutil 01:56:32 INFO - Running setup.py install for psutil 01:56:32 INFO - building 'psutil._psutil_linux' extension 01:56:32 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 01:56:32 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 01:56:32 INFO - building 'psutil._psutil_posix' extension 01:56:32 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 01:56:32 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 01:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:32 INFO - Successfully installed psutil 01:56:32 INFO - Cleaning up... 01:56:32 INFO - Return code: 0 01:56:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:56: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 mozsystemmonitor==0.3 01:56:32 INFO - Using env: {'DISPLAY': ':0', 01:56:32 INFO - 'HOME': '/home/cltbld', 01:56:32 INFO - 'LANG': 'en_US.UTF-8', 01:56:32 INFO - 'LANGUAGE': 'en_US:en', 01:56:32 INFO - 'LOGNAME': 'cltbld', 01:56:32 INFO - 'MAIL': '/var/mail/cltbld', 01:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:32 INFO - 'MOZ_NO_REMOTE': '1', 01:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:32 INFO - 'NO_EM_RESTART': '1', 01:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:32 INFO - 'PWD': '/builds/slave/test', 01:56:32 INFO - 'SHELL': '/bin/bash', 01:56:32 INFO - 'SHLVL': '1', 01:56:32 INFO - 'TERM': 'linux', 01:56:32 INFO - 'TMOUT': '86400', 01:56:32 INFO - 'USER': 'cltbld', 01:56:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:32 INFO - '_': '/tools/buildbot/bin/python'} 01:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:56:35 INFO - Installing collected packages: mozsystemmonitor 01:56:35 INFO - Running setup.py install for mozsystemmonitor 01:56:35 INFO - Successfully installed mozsystemmonitor 01:56:35 INFO - Cleaning up... 01:56:35 INFO - Return code: 0 01:56:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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', '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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:56: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 jsonschema==2.5.1 01:56:35 INFO - Using env: {'DISPLAY': ':0', 01:56:35 INFO - 'HOME': '/home/cltbld', 01:56:35 INFO - 'LANG': 'en_US.UTF-8', 01:56:35 INFO - 'LANGUAGE': 'en_US:en', 01:56:35 INFO - 'LOGNAME': 'cltbld', 01:56:35 INFO - 'MAIL': '/var/mail/cltbld', 01:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:35 INFO - 'MOZ_NO_REMOTE': '1', 01:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:35 INFO - 'NO_EM_RESTART': '1', 01:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:35 INFO - 'PWD': '/builds/slave/test', 01:56:35 INFO - 'SHELL': '/bin/bash', 01:56:35 INFO - 'SHLVL': '1', 01:56:35 INFO - 'TERM': 'linux', 01:56:35 INFO - 'TMOUT': '86400', 01:56:35 INFO - 'USER': 'cltbld', 01:56:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:35 INFO - '_': '/tools/buildbot/bin/python'} 01:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:35 INFO - Downloading/unpacking jsonschema==2.5.1 01:56:35 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 01:56:35 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 01:56:35 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 01:56:35 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 01:56:35 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 01:56:35 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 01:56:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:56:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 INFO - Downloading functools32-3.2.3-2.tar.gz 01:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:56:37 INFO - warning: no files found matching '*.txt' 01:56:37 INFO - no previously-included directories found matching 'build' 01:56:37 INFO - no previously-included directories found matching 'dist' 01:56:37 INFO - no previously-included directories found matching '.git*' 01:56:37 INFO - Installing collected packages: jsonschema, functools32 01:56:37 INFO - Running setup.py install for functools32 01:56:37 INFO - warning: no files found matching '*.txt' 01:56:37 INFO - no previously-included directories found matching 'build' 01:56:37 INFO - no previously-included directories found matching 'dist' 01:56:37 INFO - no previously-included directories found matching '.git*' 01:56:37 INFO - Successfully installed jsonschema functools32 01:56:37 INFO - Cleaning up... 01:56:37 INFO - Return code: 0 01:56:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:56:37 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')]} 01:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:37 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')]} 01:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:37 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:37 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 01:56:37 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 01:56:37 INFO - Using env: {'DISPLAY': ':0', 01:56:37 INFO - 'HOME': '/home/cltbld', 01:56:37 INFO - 'LANG': 'en_US.UTF-8', 01:56:37 INFO - 'LANGUAGE': 'en_US:en', 01:56:37 INFO - 'LOGNAME': 'cltbld', 01:56:37 INFO - 'MAIL': '/var/mail/cltbld', 01:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:37 INFO - 'MOZ_NO_REMOTE': '1', 01:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:37 INFO - 'NO_EM_RESTART': '1', 01:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:37 INFO - 'PWD': '/builds/slave/test', 01:56:37 INFO - 'SHELL': '/bin/bash', 01:56:37 INFO - 'SHLVL': '1', 01:56:37 INFO - 'TERM': 'linux', 01:56:37 INFO - 'TMOUT': '86400', 01:56:37 INFO - 'USER': 'cltbld', 01:56:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:37 INFO - '_': '/tools/buildbot/bin/python'} 01:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:56:38 INFO - Cleaning up... 01:56:38 INFO - Return code: 0 01:56:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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', '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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:56: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 blobuploader==1.2.4 01:56:38 INFO - Using env: {'DISPLAY': ':0', 01:56:38 INFO - 'HOME': '/home/cltbld', 01:56:38 INFO - 'LANG': 'en_US.UTF-8', 01:56:38 INFO - 'LANGUAGE': 'en_US:en', 01:56:38 INFO - 'LOGNAME': 'cltbld', 01:56:38 INFO - 'MAIL': '/var/mail/cltbld', 01:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:38 INFO - 'MOZ_NO_REMOTE': '1', 01:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:38 INFO - 'NO_EM_RESTART': '1', 01:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:38 INFO - 'PWD': '/builds/slave/test', 01:56:38 INFO - 'SHELL': '/bin/bash', 01:56:38 INFO - 'SHLVL': '1', 01:56:38 INFO - 'TERM': 'linux', 01:56:38 INFO - 'TMOUT': '86400', 01:56:38 INFO - 'USER': 'cltbld', 01:56:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:38 INFO - '_': '/tools/buildbot/bin/python'} 01:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:41 INFO - Downloading docopt-0.6.1.tar.gz 01:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:41 INFO - Running setup.py install for blobuploader 01:56:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:41 INFO - Running setup.py install for requests 01:56:41 INFO - Running setup.py install for docopt 01:56:41 INFO - Successfully installed blobuploader requests docopt 01:56:41 INFO - Cleaning up... 01:56:41 INFO - Return code: 0 01:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:41 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:41 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 01:56:41 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 01:56:41 INFO - Using env: {'DISPLAY': ':0', 01:56:41 INFO - 'HOME': '/home/cltbld', 01:56:41 INFO - 'LANG': 'en_US.UTF-8', 01:56:41 INFO - 'LANGUAGE': 'en_US:en', 01:56:41 INFO - 'LOGNAME': 'cltbld', 01:56:41 INFO - 'MAIL': '/var/mail/cltbld', 01:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:41 INFO - 'MOZ_NO_REMOTE': '1', 01:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:41 INFO - 'NO_EM_RESTART': '1', 01:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:41 INFO - 'PWD': '/builds/slave/test', 01:56:41 INFO - 'SHELL': '/bin/bash', 01:56:41 INFO - 'SHLVL': '1', 01:56:41 INFO - 'TERM': 'linux', 01:56:41 INFO - 'TMOUT': '86400', 01:56:41 INFO - 'USER': 'cltbld', 01:56:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:41 INFO - '_': '/tools/buildbot/bin/python'} 01:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:42 INFO - Running setup.py (path:/tmp/pip-8Kf_bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:42 INFO - Running setup.py (path:/tmp/pip-6DMKrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:42 INFO - Running setup.py (path:/tmp/pip-Up92dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:42 INFO - Running setup.py (path:/tmp/pip-nAjqFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:42 INFO - Running setup.py (path:/tmp/pip-GhXdJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:42 INFO - Running setup.py (path:/tmp/pip-MLVxFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:42 INFO - Running setup.py (path:/tmp/pip-11EugB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:42 INFO - Running setup.py (path:/tmp/pip-gWxVVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:42 INFO - Running setup.py (path:/tmp/pip-5q_QNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:42 INFO - Running setup.py (path:/tmp/pip-7wbriq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:42 INFO - Running setup.py (path:/tmp/pip-onpFYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:42 INFO - Running setup.py (path:/tmp/pip-mMg8L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:42 INFO - Running setup.py (path:/tmp/pip-r7IgTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:42 INFO - Running setup.py (path:/tmp/pip-SKqidQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:43 INFO - Running setup.py (path:/tmp/pip-mOw0iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:43 INFO - Running setup.py (path:/tmp/pip-rKFJwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:43 INFO - Running setup.py (path:/tmp/pip-0AL4nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:43 INFO - Running setup.py install for manifestparser 01:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:43 INFO - Running setup.py install for mozcrash 01:56:43 INFO - Running setup.py install for mozdebug 01:56:43 INFO - Running setup.py install for mozdevice 01:56:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:43 INFO - Running setup.py install for mozfile 01:56:43 INFO - Running setup.py install for mozhttpd 01:56:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:43 INFO - Running setup.py install for mozinfo 01:56:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:43 INFO - Running setup.py install for mozInstall 01:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Running setup.py install for mozleak 01:56:44 INFO - Running setup.py install for mozlog 01:56:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Running setup.py install for moznetwork 01:56:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Running setup.py install for mozprocess 01:56:44 INFO - Running setup.py install for mozprofile 01:56:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Running setup.py install for mozrunner 01:56:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:44 INFO - Running setup.py install for mozscreenshot 01:56:44 INFO - Running setup.py install for moztest 01:56:44 INFO - Running setup.py install for mozversion 01:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:45 INFO - Cleaning up... 01:56:45 INFO - Return code: 0 01:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:45 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')]} 01:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:45 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')]} 01:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:45 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:45 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 01:56:45 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 01:56:45 INFO - Using env: {'DISPLAY': ':0', 01:56:45 INFO - 'HOME': '/home/cltbld', 01:56:45 INFO - 'LANG': 'en_US.UTF-8', 01:56:45 INFO - 'LANGUAGE': 'en_US:en', 01:56:45 INFO - 'LOGNAME': 'cltbld', 01:56:45 INFO - 'MAIL': '/var/mail/cltbld', 01:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:45 INFO - 'MOZ_NO_REMOTE': '1', 01:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:45 INFO - 'NO_EM_RESTART': '1', 01:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:45 INFO - 'PWD': '/builds/slave/test', 01:56:45 INFO - 'SHELL': '/bin/bash', 01:56:45 INFO - 'SHLVL': '1', 01:56:45 INFO - 'TERM': 'linux', 01:56:45 INFO - 'TMOUT': '86400', 01:56:45 INFO - 'USER': 'cltbld', 01:56:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:45 INFO - '_': '/tools/buildbot/bin/python'} 01:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:45 INFO - Running setup.py (path:/tmp/pip-JUKDKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:45 INFO - Running setup.py (path:/tmp/pip-8GQEcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:45 INFO - Running setup.py (path:/tmp/pip-P2d9fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:45 INFO - Running setup.py (path:/tmp/pip-I5W8dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:45 INFO - Running setup.py (path:/tmp/pip-v4FySk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:45 INFO - Running setup.py (path:/tmp/pip-sgfUN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:45 INFO - Running setup.py (path:/tmp/pip-r42qDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:45 INFO - Running setup.py (path:/tmp/pip-Efyh9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:45 INFO - Running setup.py (path:/tmp/pip-Kz3PVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:45 INFO - Running setup.py (path:/tmp/pip-FB4sCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:45 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)) 01:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:45 INFO - Running setup.py (path:/tmp/pip-PHV8d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:46 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)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:46 INFO - Running setup.py (path:/tmp/pip-y5BleU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:46 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)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:46 INFO - Running setup.py (path:/tmp/pip-U9bahY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:46 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)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:46 INFO - Running setup.py (path:/tmp/pip-LjhzbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:46 INFO - Running setup.py (path:/tmp/pip-sesGpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:46 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)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:46 INFO - Running setup.py (path:/tmp/pip-JThu1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:46 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)) 01:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:46 INFO - Running setup.py (path:/tmp/pip-Czcsni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:46 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)) 01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:46 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)) 01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:46 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 01:56:46 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 01:56:46 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 01:56:46 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 01:56:46 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 01:56:46 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 01:56:49 INFO - Downloading blessings-1.6.tar.gz 01:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:49 INFO - Installing collected packages: blessings 01:56:49 INFO - Running setup.py install for blessings 01:56:49 INFO - Successfully installed blessings 01:56:49 INFO - Cleaning up... 01:56:49 INFO - Return code: 0 01:56:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:49 INFO - Reading from file tmpfile_stdout 01:56:49 INFO - Current package versions: 01:56:49 INFO - argparse == 1.2.1 01:56:49 INFO - blessings == 1.6 01:56:49 INFO - blobuploader == 1.2.4 01:56:49 INFO - docopt == 0.6.1 01:56:49 INFO - functools32 == 3.2.3-2 01:56:49 INFO - jsonschema == 2.5.1 01:56:49 INFO - manifestparser == 1.1 01:56:49 INFO - mozInstall == 1.12 01:56:49 INFO - mozcrash == 1.0 01:56:49 INFO - mozdebug == 0.1 01:56:49 INFO - mozdevice == 0.49 01:56:49 INFO - mozfile == 1.2 01:56:49 INFO - mozhttpd == 0.7 01:56:49 INFO - mozinfo == 0.9 01:56:49 INFO - mozleak == 0.1 01:56:49 INFO - mozlog == 3.4 01:56:49 INFO - moznetwork == 0.27 01:56:49 INFO - mozprocess == 0.23 01:56:49 INFO - mozprofile == 0.28 01:56:49 INFO - mozrunner == 6.13 01:56:49 INFO - mozscreenshot == 0.1 01:56:49 INFO - mozsystemmonitor == 0.3 01:56:49 INFO - moztest == 0.7 01:56:49 INFO - mozversion == 1.4 01:56:49 INFO - psutil == 3.1.1 01:56:49 INFO - requests == 1.2.3 01:56:49 INFO - wsgiref == 0.1.2 01:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:49 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')]} 01:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:49 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')]} 01:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:49 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:49 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 01:56:49 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 01:56:49 INFO - Using env: {'DISPLAY': ':0', 01:56:49 INFO - 'HOME': '/home/cltbld', 01:56:49 INFO - 'LANG': 'en_US.UTF-8', 01:56:49 INFO - 'LANGUAGE': 'en_US:en', 01:56:49 INFO - 'LOGNAME': 'cltbld', 01:56:49 INFO - 'MAIL': '/var/mail/cltbld', 01:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:49 INFO - 'MOZ_NO_REMOTE': '1', 01:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:49 INFO - 'NO_EM_RESTART': '1', 01:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:49 INFO - 'PWD': '/builds/slave/test', 01:56:49 INFO - 'SHELL': '/bin/bash', 01:56:49 INFO - 'SHLVL': '1', 01:56:49 INFO - 'TERM': 'linux', 01:56:49 INFO - 'TMOUT': '86400', 01:56:49 INFO - 'USER': 'cltbld', 01:56:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:49 INFO - '_': '/tools/buildbot/bin/python'} 01:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 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)) 01:56:49 INFO - Cleaning up... 01:56:49 INFO - Return code: 0 01:56:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:56:49 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')]} 01:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:49 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')]} 01:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:50 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 0x26051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, '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': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', '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 01:56:50 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 01:56:50 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 01:56:50 INFO - Using env: {'DISPLAY': ':0', 01:56:50 INFO - 'HOME': '/home/cltbld', 01:56:50 INFO - 'LANG': 'en_US.UTF-8', 01:56:50 INFO - 'LANGUAGE': 'en_US:en', 01:56:50 INFO - 'LOGNAME': 'cltbld', 01:56:50 INFO - 'MAIL': '/var/mail/cltbld', 01:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:50 INFO - 'MOZ_NO_REMOTE': '1', 01:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:50 INFO - 'NO_EM_RESTART': '1', 01:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:50 INFO - 'PWD': '/builds/slave/test', 01:56:50 INFO - 'SHELL': '/bin/bash', 01:56:50 INFO - 'SHLVL': '1', 01:56:50 INFO - 'TERM': 'linux', 01:56:50 INFO - 'TMOUT': '86400', 01:56:50 INFO - 'USER': 'cltbld', 01:56:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:50 INFO - '_': '/tools/buildbot/bin/python'} 01:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:56:50 INFO - Cleaning up... 01:56:50 INFO - Return code: 0 01:56:50 INFO - Running post-action listener: _resource_record_post_action 01:56:50 INFO - Running post-action listener: _start_resource_monitoring 01:56:50 INFO - Starting resource monitoring. 01:56:50 INFO - [mozharness: 2016-12-30 09:56:50.261505Z] Finished create-virtualenv step (success) 01:56:50 INFO - [mozharness: 2016-12-30 09:56:50.261961Z] Running install step. 01:56:50 INFO - Running pre-action listener: _resource_record_pre_action 01:56:50 INFO - Running main action method: install 01:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:50 INFO - Reading from file tmpfile_stdout 01:56:50 INFO - Detecting whether we're running mozinstall >=1.0... 01:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:56:50 INFO - Reading from file tmpfile_stdout 01:56:50 INFO - Output received: 01:56:50 INFO - Usage: mozinstall [options] installer 01:56:50 INFO - Options: 01:56:50 INFO - -h, --help show this help message and exit 01:56:50 INFO - -d DEST, --destination=DEST 01:56:50 INFO - Directory to install application into. [default: 01:56:50 INFO - "/builds/slave/test"] 01:56:50 INFO - --app=APP Application being installed. [default: firefox] 01:56:50 INFO - mkdir: /builds/slave/test/build/application 01:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:57:06 INFO - Reading from file tmpfile_stdout 01:57:06 INFO - Output received: 01:57:06 INFO - /builds/slave/test/build/application/firefox/firefox 01:57:06 INFO - Running post-action listener: _resource_record_post_action 01:57:06 INFO - [mozharness: 2016-12-30 09:57:06.653254Z] Finished install step (success) 01:57:06 INFO - [mozharness: 2016-12-30 09:57:06.653500Z] Running run-tests step. 01:57:06 INFO - Running pre-action listener: _resource_record_pre_action 01:57:06 INFO - Running main action method: run_tests 01:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:57:06 INFO - Python 2.7.3 01:57:06 INFO - Return code: 0 01:57:06 INFO - grabbing minidump binary from tooltool 01:57: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')]} 01:57: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 0x29743f0>, '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 0x2974cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29751a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:57: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 01:57: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 01:57: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 01:57:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:57:06 INFO - Return code: 0 01:57:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:57:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:57:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:57:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:57:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:57:06 INFO - Using env: {'DISPLAY': ':0', 01:57:06 INFO - 'HOME': '/home/cltbld', 01:57:06 INFO - 'LANG': 'en_US.UTF-8', 01:57:06 INFO - 'LANGUAGE': 'en_US:en', 01:57:06 INFO - 'LOGNAME': 'cltbld', 01:57:06 INFO - 'MAIL': '/var/mail/cltbld', 01:57:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:57:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:06 INFO - 'MOZ_NO_REMOTE': '1', 01:57:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:06 INFO - 'NO_EM_RESTART': '1', 01:57:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:06 INFO - 'PWD': '/builds/slave/test', 01:57:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:57:06 INFO - 'SHELL': '/bin/bash', 01:57:06 INFO - 'SHLVL': '1', 01:57:06 INFO - 'TERM': 'linux', 01:57:06 INFO - 'TMOUT': '86400', 01:57:06 INFO - 'USER': 'cltbld', 01:57:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405', 01:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:06 INFO - '_': '/tools/buildbot/bin/python'} 01:57:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:57:06 INFO - mozversion application_buildid: 20161229194619 01:57:06 INFO - mozversion application_changeset: 665c91fbf4bd40b25beb12ef7e69ffced2044262 01:57:06 INFO - mozversion application_display_name: Nightly 01:57:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:57:06 INFO - mozversion application_name: Firefox 01:57:06 INFO - mozversion application_remotingname: firefox 01:57:06 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:57:06 INFO - mozversion application_vendor: Mozilla 01:57:06 INFO - mozversion application_version: 53.0a1 01:57:06 INFO - mozversion platform_buildid: 20161229194619 01:57:06 INFO - mozversion platform_changeset: 665c91fbf4bd40b25beb12ef7e69ffced2044262 01:57:06 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:57:06 INFO - mozversion platform_version: 53.0a1 01:57:06 INFO - using testdate: 1483091826 01:57:06 INFO - actual date: 1483091826 01:57:06 INFO - starting webserver on 'localhost:54348' 01:57:06 INFO - SUITE-START | Running 2 tests 01:57:06 INFO - TEST-START | dromaeo_css 01:57:06 INFO - operating with platform_type : linux_ 01:57:06 INFO - Initialising browser for dromaeo_css test... 01:57:06 INFO - TEST-INFO | started process 11645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6NQpkj/profile http://localhost:54348/getInfo.html) 01:57:07 INFO - PROCESS | 11645 | 1483091827442 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 01:57:11 INFO - PROCESS | 11645 | __metrics Screen width/height:1600/1200 01:57:11 INFO - PROCESS | 11645 | colorDepth:24 01:57:11 INFO - PROCESS | 11645 | Browser inner width/height: 1024/697 01:57:11 INFO - PROCESS | 11645 | __metrics 01:57:11 ERROR - PROCESS | 11645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 01:57:13 INFO - TEST-INFO | 11645: exit 0 01:57:13 INFO - Browser initialized. 01:57:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:57:13 INFO - TEST-INFO | started process 11767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6NQpkj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:25 INFO - PROCESS | 11767 | RSS: Main: 157749248 01:57:25 INFO - PROCESS | 11767 | 02:00:28 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54348/tests/dromaeo/cssquery-ext.html) 02:00:29 INFO - PROCESS | 11767 | RSS: Main: 165187584 02:00:29 INFO - PROCESS | 11767 | 02:02:13 INFO - PROCESS | 11767 | ************************* 02:02:13 INFO - PROCESS | 11767 | A coding exception was thrown and uncaught in a Task. 02:02:13 INFO - PROCESS | 11767 | 02:02:13 INFO - PROCESS | 11767 | Full message: ReferenceError: fetch is not defined 02:02:13 INFO - PROCESS | 11767 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:02:13 INFO - PROCESS | 11767 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:02:13 INFO - PROCESS | 11767 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:02:13 INFO - PROCESS | 11767 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:02:13 INFO - PROCESS | 11767 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:02:13 INFO - PROCESS | 11767 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:02:13 INFO - PROCESS | 11767 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:02:13 INFO - PROCESS | 11767 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:02:13 INFO - PROCESS | 11767 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:02:13 INFO - PROCESS | 11767 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:02:13 INFO - PROCESS | 11767 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:02:13 INFO - PROCESS | 11767 | 02:02:13 INFO - PROCESS | 11767 | ************************* 02:03:31 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-ext.html (next: http://localhost:54348/tests/dromaeo/cssquery-jquery.html) 02:03:32 INFO - PROCESS | 11767 | RSS: Main: 162037760 02:03:32 INFO - PROCESS | 11767 | 02:06:34 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54348/tests/dromaeo/cssquery-mootools.html) 02:06:35 INFO - PROCESS | 11767 | RSS: Main: 167759872 02:06:35 INFO - PROCESS | 11767 | 02:09:37 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54348/tests/dromaeo/cssquery-prototype.html) 02:09:38 INFO - PROCESS | 11767 | RSS: Main: 162619392 02:09:38 INFO - PROCESS | 11767 | 02:12:41 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54348/tests/dromaeo/cssquery-yui.html) 02:12:41 INFO - PROCESS | 11767 | RSS: Main: 166051840 02:12:41 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | Cycle 1(1): loaded http://localhost:54348/tests/dromaeo/cssquery-yui.html (next: http://localhost:54348/tests/dromaeo/cssquery-dojo.html) 02:15:44 INFO - PROCESS | 11767 | RSS: Main: 165982208 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | __start_tp_report 02:15:44 INFO - PROCESS | 11767 | _x_x_mozilla_page_load 02:15:44 INFO - PROCESS | 11767 | _x_x_mozilla_page_load_details 02:15:44 INFO - PROCESS | 11767 | |i|pagename|runs| 02:15:44 INFO - PROCESS | 11767 | |0;dojo.html;2600.3369140869077;2619.384444655506;2629.88165532551;2649.3773963118665;2668.186203208022;4690.413698287714;4796.472388037318;4799.664023518355;4820.060088282787;4829.106615276176;4743.7153770773775;4787.784549695263;4827.5172482751705;4831.251156070814;4892.706437613737;4406.317020861764;4457.5096739358805;4468.798904049309;4536.296873984521;4575.245084561044;4082.8979275518054;4509.165804326194;4514.210013247685;4536.682432229745;4541.818327266906;4295.656347492193;4462.1744977179005;4471.6646251531265;4511.030128522367;4571.725696458223;4340.435743353375;4360.716553424049;4396.802143903532;4408.40486534317;4482.5069242383315;4390.4511936008;4397.604215620578;4399.23013472641;4408.867733967986;4423.800928958204;4735.195016847144;4751.71489710615;4761.857144285677;4812.639052071074;4835.347228124228;4961.454240033593;5003.224500202438;5061.822836200715;5071.873203169914;5075.035743208816;5151.793928242866;5154.433012368674;5161.896762064775;5164.870878228036;5210.088234558937;4836.081144582518;4839.201531747222;4843.636727245471;4843.951560484421;4854.878628034292;5131.102057139986;5160.716160611128;5184.066867963803;5213.869653258699;5265.921011184835;5039.244113382949;5042.848714538496;5046.091703493333;5061.772220250097;5092.2361645753435;5109.489051094935;5131.948680513222;5134.358205224347;5137.434882162959;5168.61235407346;4918.827841025547;4978.5270399312;5025.949740502621;5054.772535235923;5055.241713742968;5083.110455670243;5088.1350170471105;5097.133487307166;5097.6941383517105;5108.131617625013;4244.766537840448;4289.335153051282;4296.742195468282;4315.244832154361;4332;3644.5444319460066;3661.8169091545315;3665.8350374233223;3730.8321125549414;3782.7541209821275;4434.11317736454;4472.575105364985;4474.932876006863;4500.752458614742;4502.4371953505815;5156.149235376196;5173.249878767558;5183.0670479314085;5193.896122077537;5246.658967167122;4382.715123516961;4423.137488189836;4477.70894891831;4486.349479325545;4559.498455169929;4627.329037289574;4667.6732628716345;4674.602658773974;4685.835995740201;4687.32033855096;4886.071646387246;4891.559759621651;4901.754912254444;4905.926411103907;4935.309056731989;5026.84919452417;5223.686578805132;5230.895382092261;5241.213817927342;5274.419813820554;4746.050789841976;4781.737004464788;4812.614990800797;4827.324174615627;4911.778969946433;5043.394792624908;5070.771815268248;5080.46655101209;5089.745512724275;5135.3324067870935;5146.639735218649;5165.560927321219;5166.715830629351;5168.8449346519665;5174.482551744795;4853.39332583427;4853.975730121468;4940.184869496493;4977.925331120108;4990.126727822544;5009.699418034929;5015.3480047593575;5017.197248440232;5026.547610715053;5066;4776.522347765195;4780.569748722632;4933.062718083553;4935.358403407534;4955.8017679292425;4941.43173535048;4960.429550601727;5024.698518088926;5030.698158110525;5096.388433388017;4898.363212782458;4917.262410638433;4918.778654960463;4924.03981223658;4968.726720030289 02:15:44 INFO - PROCESS | 11767 | |1;ext.html;524.2634099090777;529.4573062610823;542.9212764149198;544.75758287562;558.620138305952;37395.626043739554;38366;38405.80797096011;42103.36844947321;42110.15779684405;38451.23097538047;38932.80533597328;38977.41533876987;38980.61019389805;39017;7648.120466146394;7858.410619203554;7859.056913170399;7873.960630196841;9579.473128977903;9509.286803489731;9759.268054895876;9762.707118786448;9779.55991980359;9798.41209527427;9702.70891873245;9841.114299713025;9841.606335746561;9848.60605575776;9849.950750246238;9662.951685241564;9725.173360264385;9763.90236097637;9797.167240784542;9815.36200146988;9634.903650963472;9678.806423871554;9725.65960191397;9729.173020293283;9739.610415583367;34251.65748342535;34532.13669658254;34534.65465345339;34593.48109778355;34616;3435.7251419886597;3540.7344449166158;3565.607783143852;3575;3596.7122630189524;25503;25591.87204063968;25994.61008084861;26050.218493445227;26227.344316392242;2992.1921081307923;3043.802152860057;3072.784905056647;3191.4255434021866;3192.8403579820915;232300;232551;234083;235077.82461087755;235107;46716.29925551119;46771.76614116908;46868.76565617218;47121.17272963633;47142.52857471381;48647.75676121597;48653.02693946172;48714.512854871704;48865;48891.75554122207;12533.43599538023;12869.4208760606;12883.54907578249;12896.226226426445;12903;9122.452652840851;9316.8602470963;9572.808543829224;9956.054174853378;10093.09162175393;15861.603459913595;15861.968972017014;15878.967867088833;15887.364505419884;15928.840711592737;6447.7743278985945;6502.317256688074;6511.3163117871945;6640.8671826563195;6782.8304292392095;784.6782819044164;785.76034309535;791.1929831571764;805.2350267246022;813.0649752784345;26011.349716256867;27273.590896136575;27291.802042668594;27618;27784.444311114068;924.2975338742469;924.6209054287709;925.4965318812596;944.8252073366311;949.4018768176005;13945.721085578434;14288.785668214985;14297;14592.708145837023;14615.342309596093;311941;314485.9859809837;314752;315830;316030;48245.5175448241;48929.510704893204;49067;49069.75465122652;49144.26283605749;1202.3447221264257;1217.1419149499582;1238.238483332744;1243.4031664801128;1256.0391300655006;24597;25767.742322576534;26804;26831.731682682923;26853.731462685904;41694.79152604217;42341.36487952745;42378.15243695171;42465;42485.362719558616;215715;216366;216771;216911;219209;24706.752932470445;25425.237242882;25543.489130217662;25551.744482554936;25603.487930241663;40524.1895162101;41182.38226426546;42194.57805421906;42395.152096957274;42448;34029.82985085059;34383;34495.482567762;34715;34962.82518587391;33534.329313414084;34082;34088.48867266943;34109;34405.139871503416;34199;34303.82848085744;34550.65449345474;36358.636413635526;37600.2479950394;34306;36692.63307366999;36920;37068.25863482769;38085.4287185698;27417;29485.557716633837;29846.850765746032;29949.85025074861;30294.84852575723 02:15:44 INFO - PROCESS | 11767 | |2;jquery.html;367.9135403180254;371.5615573623124;374.87254333526596;377.1438833847167;396.0139253259383;15609.375624974988;16532.752008719865;17034.318627254925;17117.57206069849;17149.742753858704;16229.188540572954;16603.50189494314;16764.161791910385;16885.83114168858;16937.91531042346;4971.875703107424;5175.508326708976;5203.947960520384;5205.739713014353;5217.895642087156;5097.209932460474;5321.973390133063;5613.186088017235;5646.18130371096;5646.717664116798;5612.438756124396;5616.382197958222;5624.465675760796;5632.267805185341;5640.464155905203;5331.706756128411;5357.223202635635;5404.432534583871;5407.702576358299;5447.700376479292;5217.530422261977;5229.320188375525;5239.056969745444;5247.921281180786;5261.316028916254;12832.422540985584;17584.560385990324;18540.351087711864;19268.132934018002;19297.324593639154;2115.9263921357156;2197.1540956731615;2214.900329485161;2229.565234779219;2240.316703405461;8977.236934860544;9029.729108126767;9031.729048128567;9530.761730956712;9538.90461095387;1753.6054387762779;1764.550039739871;1837.8621603379665;1844.2530775035998;1876.2588777432838;61572.69213653948;61689.691551542404;63585;64022.67988660074;66403.66798166027;8277.461964972257;8648.827023459622;8762.123787621187;8875.378723489423;9409.670661526814;11650.825237621442;11656.941715291368;11682.883171168349;11693.473793679304;11750.529978800923;6685.130932978779;6687.632180230037;6808.08090907731;6930.61881596517;6947.4789390795895;6136.386361363828;6266.561340706106;6446.452051575575;6554.442872355903;6600.042993765877;3671.52270204877;3745.85016599333;3750.8124593770203;3777.33896568105;3898.902527436837;1580.130927989624;1592.8805339599576;1635.1415506858993;1752.6056637256515;1831.4871835885706;818.9549574773445;829.1542626520915;832.500499700175;833.2500749325534;834.6619619054293;15331;15613.297401616728;15838.445654402041;15866.127362994916;16684.165791710366;794.4438892775081;812.0470269003057;816.1960468938091;821.3018933906252;844.7043534762906;8697.95651021741;8836.513991730388;9142.81714365709;9241.537923103819;9415.482148481899;288703;288789.7802554953;292518;299389;302003;48542.441124587676;67641.32358676351;68142.65928670325;68182.31817681859;72200;859.5216228087554;882.8410886040574;907.9909200908038;908.2370808520742;909.6588779207797;14274.71450570962;14437.163550210376;14487.565373038826;14552.199629020506;14733.55799326022;33469.49795753017;33534.49698254577;34796.47805282872;34888.034517065316;35611.643883560835;45682.314765277886;45703.54296457126;45928;46294.074118516764;47568.762156189;7518.699252029857;7548.207438219128;7626.96186519086;7740.342070923809;7812.960935195288;9041.547922603975;9446.527673616154;10472.31400023888;10532.157427405637;10547.261691681508;9040.728778136667;9106.635734570544;9243;9262.72211833646;9321.580528876353;8886.955565222392;9185.954070229605;9270.119338662817;9287.164155226063;9356.064393560862;8988;9323.953380233055;9407.388519746468;9533.23734101284;10106.979316667781;7564.432667549846;7693.961530192313;7697.923020769945;7737.613119344122;7848.9215107848195;7531.359834413917;8641.265492432962;8867.246284065926;9187.08129187076;9362.719118426457 02:15:44 INFO - PROCESS | 11767 | |3;mootools.html;1309.6725818545365;1313.1989486413286;1317.1504379675105;1321.603518944317;1327.6017194841545;6281.654509002003;6529.608223506581;6680.331966803317;7068.293170682936;7094.32603902629;6667;6922.861542769142;6929.965350173255;7038.788836334918;7046.541974771636;2061.6186005588975;2092.3722883134997;2092.8639638423456;2098.370488853338;2101.0125241136716;2027.5336672565318;2067.1111422088497;2069.689546568012;2129.659254519277;2219.6892435059103;2113;2137.572485502898;2141.732283464567;2142.111023925077;2142.817860481861;2019.7273368095339;2030.786767389425;2033.9389818305326;2038.1745393115812;2040.9693854592192;2065.814076733086;2071.5028393185676;2091.968620470694;2095.0991073838245;2104.7263855698816;7019.157701075853;7148.49960502765;7179.964100179518;7217.133943926762;7338.633068346561;4325.653947684209;4463.107378524276;4465.151621191995;4472.373867658531;4481.991551900796;2708.620793088969;2799.762020228283;2845.231787417386;2859.342351259222;2861.5135426977254;1132.6318946342471;1134.3307448605362;1137.4995002199005;1141.8686851012158;1192.3620862838427;8958.776030599221;8961.507117108556;8974.685885993958;9049.321300902458;9084;3611.963880361215;3733.9439908401396;3820.1595648957186;3822.8853134406013;3941.1329507508303;7436.73971410998;7438;7445.851082978418;7453.813654658677;7479.476436649491;4266.530681625019;4270.0605866709275;4270.188664153801;4278.55075217104;4289.399484072233;3942.3495123304906;4007.499062617173;4030.899227519277;4065.410515475299;4072.144849581621;3153.30627262002;3175.920601984969;3225.0647312279643;3226.7741258111705;3259.4947783093658;951.1344676344494;994.3188915592842;997.9251556133319;1001.979960400788;1141.9600313989138;779.5439667794291;801.703369753195;807.6648191000786;810.2140923304386;814.2712272516065;4778.474367819537;4783.521647835189;4806.639502037291;4918.139325618003;5046;808.1514409869613;811.6225954930985;812.5733989655478;831.2518733140222;874.6282829797311;3219.3239419721654;3301.3562355340478;3437.3984552703178;3459.775114617592;3569.785812851237;8161.510309381456;8302.464044151851;8345.663214300006;8411;8414.579271036424;8365.163483651586;8378.49729016261;8379.748607541784;8392.034915984617;8392.748217553482;6300.495960323072;6350.460210882126;6440.0661904023655;6464.353564643592;6491.740330386731;4501.324801279834;4608.769561521844;4729;4751.904961900812;4844.442889067803;7367.889481657672;7404.592747398945;7514.962425188058;7521.623918803928;7523.548587084792;7575.053118360205;7738.458307918391;7851.803704907423;7879.527228366087;7893.644785984529;6077.787277445268;6233.563650544418;6261.7182226799;6271.811845644638;6272.466840318624;6559.27847936717;6562.639054852029;6595.934040659532;6664.5334826561675;6672.566283191577;5728.369879313355;5761.164631128547;5838.357780644041;5858.94141058584;5859.5019423349495;5942.762289508544;6010.609310394811;6035.245594300713;6049.517868122338;6131.816045518642;5285.127953887565;5325.387580428301;5337.279467271868;5356.143017117242;5370.275012873212;3991.8203680833853;4037.475128233428;4129.607687269705;4147.0461793787;4183.518895327076;4190.078182799779;4230.830766769294;4243.5544267852665;4335.371371151103;4337.934930975975 02:15:44 INFO - PROCESS | 11767 | |4;prototype.html;348.9965100348996;349.72721277403616;354.2295507271683;361.6799132767501;373.40628400842655;4921.163402221622;4936.580390666798;4963.950360496394;4981.252812078185;5029.798808047678;4869.513048695128;4883.511648835115;4908.337374454457;4908.950910490903;4909.410870695513;3738.8130593470355;3777.792221427834;3806.7525610835205;3828.770273783568;4014.2372949139644;3820.617938206185;3830.4637350770913;3835.6958634064413;3847.615238476158;3850.84596616135;3803.7147213959065;3806.5812760596314;3806.809659517027;3811.9618803812023;3823.751456155355;3690.5571331440133;3814.90462738431;3817.3892177251646;3822.311983842907;3822.522184726909;3323.351946370459;3338.1821453743746;3338.7996720196866;3350.9444524974556;3355.2618423946938;4717.367626927281;4722.504137065593;4729.6452766042685;4739.772307015697;4753.643476739224;4309.41822853917;4323.82704691812;4328.5887840655405;4331.848385306531;4342.871992723574;4975.427825800043;5048.596112311006;5049.495050494921;5075.670081444694;5109.591232701412;3619.895931740818;3627.292677927805;3635.63643635637;3637.890863274106;3654.28741395428;5181.766820493049;5292.2326262691695;5328.280682107905;5343.305370301836;5348.893022139574;3712.3132220539287;3721.702263818888;3723.4414837774552;3728.9677125966414;3730.8321125549414;3723.5717892442717;3763.5483741950593;3766.5856755756845;3766.8116594170183;3780.8487660493824;4296.570342965679;4306.332518459643;4313.935290970638;4316.482022157298;4319.028218650778;5004.624653151028;5074.340335756402;5110.182370820651;5123.205903085028;5149.138146390207;1254.2787896959285;1262.551794113095;1263.4882872436679;1266.4174479739422;1273.3124112978887;806.9354451643972;837.3050368194384;843.35904712419;847.8897743293332;849.2696281198165;4351.214443434233;4360.4331436913;4418.2488976873365;4423.51341352451;4425.889352766142;5073.492650734971;5084.847454576368;5123.97438012815;5152.665076770073;5157.252198431282;4286.882258493474;4398.164348773723;4423.712458690175;4427.634997401933;4453.554644535585;2656;2698.446818402223;2714.4164004739077;2714.443539074485;2719.8232114912466;4754.358161648133;4762.761861906891;4764.523547645277;4773.9045219096115;4795.760211989386;5116.341815601862;5168.793248270103;5169.353830771153;5202.271681964528;5206.349206349207;5003.399592048978;5008.1486147355035;5029.119904016782;5031.84904452867;5036.496350365008;5331.333583302087;5331.920021199608;5333.466653334791;5341.385740639721;5353.544948679406;4939.517640063818;5193.402758682649;5229.771003814177;5249.238860365149;5250.606204534752;4868.3934301681065;5028.572571331478;5028.572571331478;5038.823641172541;5053.620978426559;3644.7084233261808;3654.8903532894055;3656.3966945453703;3671.632836716307;3679.4848721178523;5308.548773354308;5309.2301616266195;5311.628186026941;5322.8935421292135;5350.892982140414;4949.208126699711;5136.794528218829;5140.794368225229;5151.347056265951;5151.686319988379;5119.539241468286;5122.410922743932;5156.922646160386;5161.483851614808;5174.327337446108;5068.265101560327;5109.3613298337705;5111.923321150261;5118.3090282811345;5127.743612819269;5034.720487585523;5116;5186.507281808223;5199.844004679866;5204.869878253074;5050.823221187241;5072.797088116434;5075.264086707481;5087.847364579068;5088.160453525127 02:15:44 INFO - PROCESS | 11767 | |5;yui.html;657.9506537009722;675.1257122026975;738.2285511640335;755.4334249313015;774.5275382016969;12180;13454.59636210914;14512.78230826537;15128.697426051473;15141.697166056672;15308.158051307173;15374.693151082143;15467.535973920772;15512.84487155128;15516.61208469786;781.9296263336298;809.0412860759989;825.3768404854327;828.4159667434444;829.4069740135802;790.5967956342249;807.8222790985974;808.8301456694102;810.1655295046112;811.1645005644195;864.3042350907517;865.7748985263845;866.1857853617579;868.6785889220965;868.7828042989253;858.5063588436611;860.5181098584812;861.9482831030095;864.822711344173;864.8659457784022;627.5826575327402;629.7575433458106;634.5177664974652;635.8569321902581;636.6816591704148;13971.86028139726;14180;14399;14488.782668259984;14550.70898582033;12465.75068498625;12778.169418987829;12814.679633009157;13245.07284490086;13330.733580309856;10197.133243674296;10438.68683939483;10517.9474102629;10620.734481637943;10945.343279403261;3202;3224.98387508061;3229.4671379222636;3308;3385.8307084645917;68997.31002689959;70042.29957700409;70253.2974670257;70703.2929670707;72598;9723.173530250007;9774.51127443625;9959.80080398388;10011;10084.697459076093;17836.10819459022;17862.821371786376;18274.90862545679;18624.906875465807;18663.81336186648;6712.674398891055;6777.915533514614;6855.211650660138;7057.258987806309;7100.325469080429;3495.2310491691787;3589.623089575557;3631.618680038611;3645.0522864055006;3663.3222853772136;2943.0876428307292;3003.6695963444004;3023.410434965205;3024.138120635608;3031.045220755455;469.94360676719015;478.8627010849233;480.2795806290564;485.861529464101;497.08536293219925;604.2869414091326;626.8934281172212;637.7162162837493;637.9649119298483;639.8944174211204;7748.760198368234;7814.765557033298;7964.641591128413;8012.479188852706;8150.877736833952;586.3081563754725;598.4733434577631;598.8053882488122;600.9819705408845;607.3895734786511;3514.8594056237976;3758.342290099222;3763.2285381496727;3795.3927371620407;3796.848126074926;63369.36630633635;64407.355926440134;64408.35591644117;65697.67151164309;66723.33276667268;48584.757076214395;55832.72083639556;55872;56081.27024756974;57701.42298577044;52055;52552.47447525552;52650.736746316026;52947;53155.468445315826;7113.644317784194;7518.661660225193;7538.773836784686;7582.090149182133;7649.847003059796;35801.64198357983;37036.44445333268;37205.25589488141;37293.254134916606;38169.80915095407;44698.55301446944;45427.318590220515;46144.307835383166;46589.534104658516;46717;9245.399049061789;9321.580528876353;9339.41682190855;9430.95284523573;9663.661771837951;11044.33733975964;11199.328040317607;11302.717432064264;11397.487113079766;11904.940475297568;10490.52792624349;10530.684079477322;10584.100351470212;10588.523516441932;10648.361098334124;10618.203634727271;10896.455177241265;10942.398168100512;10973;11127.443627818415;10396.272260941661;10410.739731506774;10436.739081523023;10438.164946804085;10608.734781630212;9221.677241296791;9396.154346108882;9580.13778759915;9734.9026509734;9813.165880900204;8587.871181932402;8655.826883462421;8834.690785822466;9121.954390228006;9316.627334906529 02:15:44 INFO - PROCESS | 11767 | __end_tp_report 02:15:44 INFO - PROCESS | 11767 | __start_cc_report 02:15:44 INFO - PROCESS | 11767 | _x_x_mozilla_cycle_collect,347 02:15:44 INFO - PROCESS | 11767 | __end_cc_report 02:15:44 INFO - PROCESS | 11767 | __startTimestamp1483092944855__endTimestamp 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | ------- Summary: start ------- 02:15:44 INFO - PROCESS | 11767 | Number of tests: 6 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#0] dojo.html Cycles:165 Average:4741.33 Median:4886.07 stddev:505.05 (10.3%) stddev-sans-first:477.86 02:15:44 INFO - PROCESS | 11767 | Values: 2600.3 2619.4 2629.9 2649.4 2668.2 4690.4 4796.5 4799.7 4820.1 4829.1 4743.7 4787.8 4827.5 4831.3 4892.7 4406.3 4457.5 4468.8 4536.3 4575.2 4082.9 4509.2 4514.2 4536.7 4541.8 4295.7 4462.2 4471.7 4511.0 4571.7 4340.4 4360.7 4396.8 4408.4 4482.5 4390.5 4397.6 4399.2 4408.9 4423.8 4735.2 4751.7 4761.9 4812.6 4835.3 4961.5 5003.2 5061.8 5071.9 5075.0 5151.8 5154.4 5161.9 5164.9 5210.1 4836.1 4839.2 4843.6 4844.0 4854.9 5131.1 5160.7 5184.1 5213.9 5265.9 5039.2 5042.8 5046.1 5061.8 5092.2 5109.5 5131.9 5134.4 5137.4 5168.6 4918.8 4978.5 5025.9 5054.8 5055.2 5083.1 5088.1 5097.1 5097.7 5108.1 4244.8 4289.3 4296.7 4315.2 4332.0 3644.5 3661.8 3665.8 3730.8 3782.8 4434.1 4472.6 4474.9 4500.8 4502.4 5156.1 5173.2 5183.1 5193.9 5246.7 4382.7 4423.1 4477.7 4486.3 4559.5 4627.3 4667.7 4674.6 4685.8 4687.3 4886.1 4891.6 4901.8 4905.9 4935.3 5026.8 5223.7 5230.9 5241.2 5274.4 4746.1 4781.7 4812.6 4827.3 4911.8 5043.4 5070.8 5080.5 5089.7 5135.3 5146.6 5165.6 5166.7 5168.8 5174.5 4853.4 4854.0 4940.2 4977.9 4990.1 5009.7 5015.3 5017.2 5026.5 5066.0 4776.5 4780.6 4933.1 4935.4 4955.8 4941.4 4960.4 5024.7 5030.7 5096.4 4898.4 4917.3 4918.8 4924.0 4968.7 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#1] ext.html Cycles:180 Average:41616.43 Median:36525.63 stddev:67467.54 (184.7%) stddev-sans-first:67586.25 02:15:44 INFO - PROCESS | 11767 | Values: 524.3 529.5 542.9 544.8 558.6 37395.6 38366.0 38405.8 42103.4 42110.2 38451.2 38932.8 38977.4 38980.6 39017.0 7648.1 7858.4 7859.1 7874.0 9579.5 9509.3 9759.3 9762.7 9779.6 9798.4 9702.7 9841.1 9841.6 9848.6 9850.0 9663.0 9725.2 9763.9 9797.2 9815.4 9634.9 9678.8 9725.7 9729.2 9739.6 34251.7 34532.1 34534.7 34593.5 34616.0 3435.7 3540.7 3565.6 3575.0 3596.7 25503.0 25591.9 25994.6 26050.2 26227.3 2992.2 3043.8 3072.8 3191.4 3192.8 232300.0 232551.0 234083.0 235077.8 235107.0 46716.3 46771.8 46868.8 47121.2 47142.5 48647.8 48653.0 48714.5 48865.0 48891.8 12533.4 12869.4 12883.5 12896.2 12903.0 9122.5 9316.9 9572.8 9956.1 10093.1 15861.6 15862.0 15879.0 15887.4 15928.8 6447.8 6502.3 6511.3 6640.9 6782.8 784.7 785.8 791.2 805.2 813.1 26011.3 27273.6 27291.8 27618.0 27784.4 924.3 924.6 925.5 944.8 949.4 13945.7 14288.8 14297.0 14592.7 14615.3 311941.0 314486.0 314752.0 315830.0 316030.0 48245.5 48929.5 49067.0 49069.8 49144.3 1202.3 1217.1 1238.2 1243.4 1256.0 24597.0 25767.7 26804.0 26831.7 26853.7 41694.8 42341.4 42378.2 42465.0 42485.4 215715.0 216366.0 216771.0 216911.0 219209.0 24706.8 25425.2 25543.5 25551.7 25603.5 40524.2 41182.4 42194.6 42395.2 42448.0 34029.8 34383.0 34495.5 34715.0 34962.8 33534.3 34082.0 34088.5 34109.0 34405.1 34199.0 34303.8 34550.7 36358.6 37600.2 34306.0 36692.6 36920.0 37068.3 38085.4 27417.0 29485.6 29846.9 29949.9 30294.8 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#2] jquery.html Cycles:180 Average:20494.42 Median:5427.70 stddev:48921.41 (901.3%) stddev-sans-first:49035.31 02:15:44 INFO - PROCESS | 11767 | Values: 367.9 371.6 374.9 377.1 396.0 15609.4 16532.8 17034.3 17117.6 17149.7 16229.2 16603.5 16764.2 16885.8 16937.9 4971.9 5175.5 5203.9 5205.7 5217.9 5097.2 5322.0 5613.2 5646.2 5646.7 5612.4 5616.4 5624.5 5632.3 5640.5 5331.7 5357.2 5404.4 5407.7 5447.7 5217.5 5229.3 5239.1 5247.9 5261.3 12832.4 17584.6 18540.4 19268.1 19297.3 2115.9 2197.2 2214.9 2229.6 2240.3 8977.2 9029.7 9031.7 9530.8 9538.9 1753.6 1764.6 1837.9 1844.3 1876.3 61572.7 61689.7 63585.0 64022.7 66403.7 8277.5 8648.8 8762.1 8875.4 9409.7 11650.8 11656.9 11682.9 11693.5 11750.5 6685.1 6687.6 6808.1 6930.6 6947.5 6136.4 6266.6 6446.5 6554.4 6600.0 3671.5 3745.9 3750.8 3777.3 3898.9 1580.1 1592.9 1635.1 1752.6 1831.5 819.0 829.2 832.5 833.3 834.7 15331.0 15613.3 15838.4 15866.1 16684.2 794.4 812.0 816.2 821.3 844.7 8698.0 8836.5 9142.8 9241.5 9415.5 288703.0 288789.8 292518.0 299389.0 302003.0 48542.4 67641.3 68142.7 68182.3 72200.0 859.5 882.8 908.0 908.2 909.7 14274.7 14437.2 14487.6 14552.2 14733.6 33469.5 33534.5 34796.5 34888.0 35611.6 45682.3 45703.5 45928.0 46294.1 47568.8 7518.7 7548.2 7627.0 7740.3 7813.0 9041.5 9446.5 10472.3 10532.2 10547.3 9040.7 9106.6 9243.0 9262.7 9321.6 8887.0 9186.0 9270.1 9287.2 9356.1 8988.0 9324.0 9407.4 9533.2 10107.0 7564.4 7694.0 7697.9 7737.6 7848.9 7531.4 8641.3 8867.2 9187.1 9362.7 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#3] mootools.html Cycles:180 Average:4586.09 Median:4982.07 stddev:2415.03 (48.5%) stddev-sans-first:2409.25 02:15:44 INFO - PROCESS | 11767 | Values: 1309.7 1313.2 1317.2 1321.6 1327.6 6281.7 6529.6 6680.3 7068.3 7094.3 6667.0 6922.9 6930.0 7038.8 7046.5 2061.6 2092.4 2092.9 2098.4 2101.0 2027.5 2067.1 2069.7 2129.7 2219.7 2113.0 2137.6 2141.7 2142.1 2142.8 2019.7 2030.8 2033.9 2038.2 2041.0 2065.8 2071.5 2092.0 2095.1 2104.7 7019.2 7148.5 7180.0 7217.1 7338.6 4325.7 4463.1 4465.2 4472.4 4482.0 2708.6 2799.8 2845.2 2859.3 2861.5 1132.6 1134.3 1137.5 1141.9 1192.4 8958.8 8961.5 8974.7 9049.3 9084.0 3612.0 3733.9 3820.2 3822.9 3941.1 7436.7 7438.0 7445.9 7453.8 7479.5 4266.5 4270.1 4270.2 4278.6 4289.4 3942.3 4007.5 4030.9 4065.4 4072.1 3153.3 3175.9 3225.1 3226.8 3259.5 951.1 994.3 997.9 1002.0 1142.0 779.5 801.7 807.7 810.2 814.3 4778.5 4783.5 4806.6 4918.1 5046.0 808.2 811.6 812.6 831.3 874.6 3219.3 3301.4 3437.4 3459.8 3569.8 8161.5 8302.5 8345.7 8411.0 8414.6 8365.2 8378.5 8379.7 8392.0 8392.7 6300.5 6350.5 6440.1 6464.4 6491.7 4501.3 4608.8 4729.0 4751.9 4844.4 7367.9 7404.6 7515.0 7521.6 7523.5 7575.1 7738.5 7851.8 7879.5 7893.6 6077.8 6233.6 6261.7 6271.8 6272.5 6559.3 6562.6 6595.9 6664.5 6672.6 5728.4 5761.2 5838.4 5858.9 5859.5 5942.8 6010.6 6035.2 6049.5 6131.8 5285.1 5325.4 5337.3 5356.1 5370.3 3991.8 4037.5 4129.6 4147.0 4183.5 4190.1 4230.8 4243.6 4335.4 4337.9 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#4] prototype.html Cycles:180 Average:4236.84 Median:4868.95 stddev:1235.36 (25.4%) stddev-sans-first:1203.86 02:15:44 INFO - PROCESS | 11767 | Values: 349.0 349.7 354.2 361.7 373.4 4921.2 4936.6 4964.0 4981.3 5029.8 4869.5 4883.5 4908.3 4909.0 4909.4 3738.8 3777.8 3806.8 3828.8 4014.2 3820.6 3830.5 3835.7 3847.6 3850.8 3803.7 3806.6 3806.8 3812.0 3823.8 3690.6 3814.9 3817.4 3822.3 3822.5 3323.4 3338.2 3338.8 3350.9 3355.3 4717.4 4722.5 4729.6 4739.8 4753.6 4309.4 4323.8 4328.6 4331.8 4342.9 4975.4 5048.6 5049.5 5075.7 5109.6 3619.9 3627.3 3635.6 3637.9 3654.3 5181.8 5292.2 5328.3 5343.3 5348.9 3712.3 3721.7 3723.4 3729.0 3730.8 3723.6 3763.5 3766.6 3766.8 3780.8 4296.6 4306.3 4313.9 4316.5 4319.0 5004.6 5074.3 5110.2 5123.2 5149.1 1254.3 1262.6 1263.5 1266.4 1273.3 806.9 837.3 843.4 847.9 849.3 4351.2 4360.4 4418.2 4423.5 4425.9 5073.5 5084.8 5124.0 5152.7 5157.3 4286.9 4398.2 4423.7 4427.6 4453.6 2656.0 2698.4 2714.4 2714.4 2719.8 4754.4 4762.8 4764.5 4773.9 4795.8 5116.3 5168.8 5169.4 5202.3 5206.3 5003.4 5008.1 5029.1 5031.8 5036.5 5331.3 5331.9 5333.5 5341.4 5353.5 4939.5 5193.4 5229.8 5249.2 5250.6 4868.4 5028.6 5028.6 5038.8 5053.6 3644.7 3654.9 3656.4 3671.6 3679.5 5308.5 5309.2 5311.6 5322.9 5350.9 4949.2 5136.8 5140.8 5151.3 5151.7 5119.5 5122.4 5156.9 5161.5 5174.3 5068.3 5109.4 5111.9 5118.3 5127.7 5034.7 5116.0 5186.5 5199.8 5204.9 5050.8 5072.8 5075.3 5087.8 5088.2 02:15:44 INFO - PROCESS | 11767 | 02:15:44 INFO - PROCESS | 11767 | [#5] yui.html Cycles:180 Average:14858.71 Median:52798.87 stddev:18921.25 (35.8%) stddev-sans-first:18944.28 02:15:44 INFO - PROCESS | 11767 | Values: 658.0 675.1 738.2 755.4 774.5 12180.0 13454.6 14512.8 15128.7 15141.7 15308.2 15374.7 15467.5 15512.8 15516.6 781.9 809.0 825.4 828.4 829.4 790.6 807.8 808.8 810.2 811.2 864.3 865.8 866.2 868.7 868.8 858.5 860.5 861.9 864.8 864.9 627.6 629.8 634.5 635.9 636.7 13971.9 14180.0 14399.0 14488.8 14550.7 12465.8 12778.2 12814.7 13245.1 13330.7 10197.1 10438.7 10517.9 10620.7 10945.3 3202.0 3225.0 3229.5 3308.0 3385.8 68997.3 70042.3 70253.3 70703.3 72598.0 9723.2 9774.5 9959.8 10011.0 10084.7 17836.1 17862.8 18274.9 18624.9 18663.8 6712.7 6777.9 6855.2 7057.3 7100.3 3495.2 3589.6 3631.6 3645.1 3663.3 2943.1 3003.7 3023.4 3024.1 3031.0 469.9 478.9 480.3 485.9 497.1 604.3 626.9 637.7 638.0 639.9 7748.8 7814.8 7964.6 8012.5 8150.9 586.3 598.5 598.8 601.0 607.4 3514.9 3758.3 3763.2 3795.4 3796.8 63369.4 64407.4 64408.4 65697.7 66723.3 48584.8 55832.7 55872.0 56081.3 57701.4 52055.0 52552.5 52650.7 52947.0 53155.5 7113.6 7518.7 7538.8 7582.1 7649.8 35801.6 37036.4 37205.3 37293.3 38169.8 44698.6 45427.3 46144.3 46589.5 46717.0 9245.4 9321.6 9339.4 9431.0 9663.7 11044.3 11199.3 11302.7 11397.5 11904.9 10490.5 10530.7 10584.1 10588.5 10648.4 10618.2 10896.5 10942.4 10973.0 11127.4 10396.3 10410.7 10436.7 10438.2 10608.7 9221.7 9396.2 9580.1 9734.9 9813.2 8587.9 8655.8 8834.7 9122.0 9316.6 02:15:44 INFO - PROCESS | 11767 | -------- Summary: end -------- 02:15:44 INFO - PROCESS | 11767 | 02:15:45 INFO - TEST-INFO | 11767: exit 0 02:15:45 INFO - TEST-OK | dromaeo_css | took 1118778ms 02:15:45 INFO - TEST-START | kraken 02:15:45 INFO - operating with platform_type : linux_ 02:15:45 INFO - Initialising browser for kraken test... 02:15:45 INFO - TEST-INFO | started process 12118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3sQfMc/profile http://localhost:54348/getInfo.html) 02:15:46 INFO - PROCESS | 12118 | 1483092946203 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 02:15:50 INFO - PROCESS | 12118 | __metrics Screen width/height:1600/1200 02:15:50 INFO - PROCESS | 12118 | colorDepth:24 02:15:50 INFO - PROCESS | 12118 | Browser inner width/height: 1024/697 02:15:50 INFO - PROCESS | 12118 | __metrics 02:15:50 ERROR - PROCESS | 12118 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 02:15:51 INFO - TEST-INFO | 12118: exit 0 02:15:51 INFO - Browser initialized. 02:15:51 INFO - Running cycle 1/1 for kraken test... 02:15:51 INFO - TEST-INFO | started process 12236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3sQfMc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:03 INFO - PROCESS | 12236 | RSS: Main: 158031872 02:16:03 INFO - PROCESS | 12236 | 02:16:06 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54348/tests/kraken/driver.html?testName=audio-beat-detection) 02:16:07 INFO - PROCESS | 12236 | RSS: Main: 164012032 02:16:07 INFO - PROCESS | 12236 | 02:16:10 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54348/tests/kraken/driver.html?testName=audio-dft) 02:16:10 INFO - PROCESS | 12236 | RSS: Main: 163237888 02:16:10 INFO - PROCESS | 12236 | 02:16:13 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54348/tests/kraken/driver.html?testName=audio-fft) 02:16:14 INFO - PROCESS | 12236 | RSS: Main: 159973376 02:16:14 INFO - PROCESS | 12236 | 02:16:16 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54348/tests/kraken/driver.html?testName=audio-oscillator) 02:16:17 INFO - PROCESS | 12236 | RSS: Main: 160522240 02:16:17 INFO - PROCESS | 12236 | 02:16:19 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:16:19 INFO - PROCESS | 12236 | RSS: Main: 160337920 02:16:19 INFO - PROCESS | 12236 | 02:16:22 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54348/tests/kraken/driver.html?testName=imaging-darkroom) 02:16:23 INFO - PROCESS | 12236 | RSS: Main: 164450304 02:16:23 INFO - PROCESS | 12236 | 02:16:27 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54348/tests/kraken/driver.html?testName=imaging-desaturate) 02:16:27 INFO - PROCESS | 12236 | RSS: Main: 161599488 02:16:27 INFO - PROCESS | 12236 | 02:16:30 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54348/tests/kraken/driver.html?testName=json-parse-financial) 02:16:31 INFO - PROCESS | 12236 | RSS: Main: 162664448 02:16:31 INFO - PROCESS | 12236 | 02:16:33 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:16:33 INFO - PROCESS | 12236 | RSS: Main: 163045376 02:16:33 INFO - PROCESS | 12236 | 02:16:35 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:16:36 INFO - PROCESS | 12236 | RSS: Main: 163033088 02:16:36 INFO - PROCESS | 12236 | 02:16:38 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:16:39 INFO - PROCESS | 12236 | RSS: Main: 163622912 02:16:39 INFO - PROCESS | 12236 | 02:16:41 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:16:42 INFO - PROCESS | 12236 | RSS: Main: 163852288 02:16:42 INFO - PROCESS | 12236 | 02:16:45 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:46 INFO - PROCESS | 12236 | RSS: Main: 163540992 02:16:46 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:54348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54348/tests/kraken/driver.html?testName=ai-astar) 02:16:48 INFO - PROCESS | 12236 | RSS: Main: 165187584 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | __start_tp_report 02:16:48 INFO - PROCESS | 12236 | _x_x_mozilla_page_load 02:16:48 INFO - PROCESS | 12236 | _x_x_mozilla_page_load_details 02:16:48 INFO - PROCESS | 12236 | |i|pagename|runs| 02:16:48 INFO - PROCESS | 12236 | |0;ai-astar;107;115;115;117;115;115;116;116;116;115 02:16:48 INFO - PROCESS | 12236 | |1;audio-beat-detection;158;134;128;176;131;130;129;128;145;130 02:16:48 INFO - PROCESS | 12236 | |2;audio-dft;163;164;166;177;163;163;163;165;164;161 02:16:48 INFO - PROCESS | 12236 | |3;audio-fft;76;77;77;120;79;79;79;79;92;77 02:16:48 INFO - PROCESS | 12236 | |4;audio-oscillator;85;85;106;85;86;86;98;85;85;106 02:16:48 INFO - PROCESS | 12236 | |5;imaging-gaussian-blur;117;118;118;118;118;117;118;117;119;118 02:16:48 INFO - PROCESS | 12236 | |6;imaging-darkroom;150;149;152;150;150;150;151;151;151;151 02:16:48 INFO - PROCESS | 12236 | |7;imaging-desaturate;96;95;97;96;96;96;96;97;95;96 02:16:48 INFO - PROCESS | 12236 | |8;json-parse-financial;72;74;71;72;78;71;73;74;71;75 02:16:48 INFO - PROCESS | 12236 | |9;json-stringify-tinderbox;67;68;67;69;68;69;67;68;67;69 02:16:48 INFO - PROCESS | 12236 | |10;stanford-crypto-aes;89;86;87;84;84;85;85;85;86;85 02:16:48 INFO - PROCESS | 12236 | |11;stanford-crypto-ccm;138;142;135;139;134;136;138;153;182;153 02:16:48 INFO - PROCESS | 12236 | |12;stanford-crypto-pbkdf2;189;174;175;181;183;187;179;177;175;181 02:16:48 INFO - PROCESS | 12236 | |13;stanford-crypto-sha256-iterative;68;69;70;69;70;72;68;72;68;69 02:16:48 INFO - PROCESS | 12236 | __end_tp_report 02:16:48 INFO - PROCESS | 12236 | __start_cc_report 02:16:48 INFO - PROCESS | 12236 | _x_x_mozilla_cycle_collect,792 02:16:48 INFO - PROCESS | 12236 | __end_cc_report 02:16:48 INFO - PROCESS | 12236 | __startTimestamp1483093008425__endTimestamp 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | ------- Summary: start ------- 02:16:48 INFO - PROCESS | 12236 | Number of tests: 14 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.50 stddev:2.79 (2.4%) stddev-sans-first:0.73 02:16:48 INFO - PROCESS | 12236 | Values: 107.0 115.0 115.0 117.0 115.0 115.0 116.0 116.0 116.0 115.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:132.50 stddev:16.19 (12.2%) stddev-sans-first:15.63 02:16:48 INFO - PROCESS | 12236 | Values: 158.0 134.0 128.0 176.0 131.0 130.0 129.0 128.0 145.0 130.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.46 (2.7%) stddev-sans-first:4.68 02:16:48 INFO - PROCESS | 12236 | Values: 163.0 164.0 166.0 177.0 163.0 163.0 163.0 165.0 164.0 161.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#3] audio-fft Cycles:10 Average:83.50 Median:79.00 stddev:13.62 (17.2%) stddev-sans-first:14.17 02:16:48 INFO - PROCESS | 12236 | Values: 76.0 77.0 77.0 120.0 79.0 79.0 79.0 79.0 92.0 77.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:85.00 stddev:8.99 (10.6%) stddev-sans-first:9.30 02:16:48 INFO - PROCESS | 12236 | Values: 85.0 85.0 106.0 85.0 86.0 86.0 98.0 85.0 85.0 106.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 02:16:48 INFO - PROCESS | 12236 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 119.0 118.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 02:16:48 INFO - PROCESS | 12236 | Values: 150.0 149.0 152.0 150.0 150.0 150.0 151.0 151.0 151.0 151.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:16:48 INFO - PROCESS | 12236 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.50 stddev:2.23 (3.0%) stddev-sans-first:2.33 02:16:48 INFO - PROCESS | 12236 | Values: 72.0 74.0 71.0 72.0 78.0 71.0 73.0 74.0 71.0 75.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 02:16:48 INFO - PROCESS | 12236 | Values: 67.0 68.0 67.0 69.0 68.0 69.0 67.0 68.0 67.0 69.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:1.51 (1.8%) stddev-sans-first:0.97 02:16:48 INFO - PROCESS | 12236 | Values: 89.0 86.0 87.0 84.0 84.0 85.0 85.0 85.0 86.0 85.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:140.50 stddev:14.69 (10.5%) stddev-sans-first:15.36 02:16:48 INFO - PROCESS | 12236 | Values: 138.0 142.0 135.0 139.0 134.0 136.0 138.0 153.0 182.0 153.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:181.00 stddev:5.13 (2.8%) stddev-sans-first:4.31 02:16:48 INFO - PROCESS | 12236 | Values: 189.0 174.0 175.0 181.0 183.0 187.0 179.0 177.0 175.0 181.0 02:16:48 INFO - PROCESS | 12236 | 02:16:48 INFO - PROCESS | 12236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.50 02:16:48 INFO - PROCESS | 12236 | Values: 68.0 69.0 70.0 69.0 70.0 72.0 68.0 72.0 68.0 69.0 02:16:48 INFO - PROCESS | 12236 | -------- Summary: end -------- 02:16:48 INFO - PROCESS | 12236 | 02:16:49 INFO - TEST-INFO | 12236: exit 0 02:16:49 INFO - TEST-OK | kraken | took 63883ms 02:16:49 INFO - SUITE-END | took 1182s 02:16:50 INFO - Completed test suite (00:19:43) 02:16:50 INFO - javascript benchmark 02:16:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6197.19487607735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.3369140869077, 2619.384444655506, 2629.88165532551, 2649.3773963118665, 2668.186203208022, 4690.413698287714, 4796.472388037318, 4799.664023518355, 4820.060088282787, 4829.106615276176, 4743.7153770773775, 4787.784549695263, 4827.5172482751705, 4831.251156070814, 4892.706437613737, 4406.317020861764, 4457.5096739358805, 4468.798904049309, 4536.296873984521, 4575.245084561044, 4082.8979275518054, 4509.165804326194, 4514.210013247685, 4536.682432229745, 4541.818327266906, 4295.656347492193, 4462.1744977179005, 4471.6646251531265, 4511.030128522367, 4571.725696458223, 4340.435743353375, 4360.716553424049, 4396.802143903532, 4408.40486534317, 4482.5069242383315, 4390.4511936008, 4397.604215620578, 4399.23013472641, 4408.867733967986, 4423.800928958204, 4735.195016847144, 4751.71489710615, 4761.857144285677, 4812.639052071074, 4835.347228124228, 4961.454240033593, 5003.224500202438, 5061.822836200715, 5071.873203169914, 5075.035743208816, 5151.793928242866, 5154.433012368674, 5161.896762064775, 5164.870878228036, 5210.088234558937, 4836.081144582518, 4839.201531747222, 4843.636727245471, 4843.951560484421, 4854.878628034292, 5131.102057139986, 5160.716160611128, 5184.066867963803, 5213.869653258699, 5265.921011184835, 5039.244113382949, 5042.848714538496, 5046.091703493333, 5061.772220250097, 5092.2361645753435, 5109.489051094935, 5131.948680513222, 5134.358205224347, 5137.434882162959, 5168.61235407346, 4918.827841025547, 4978.5270399312, 5025.949740502621, 5054.772535235923, 5055.241713742968, 5083.110455670243, 5088.1350170471105, 5097.133487307166, 5097.6941383517105, 5108.131617625013, 4244.766537840448, 4289.335153051282, 4296.742195468282, 4315.244832154361, 4332.0, 3644.5444319460066, 3661.8169091545315, 3665.8350374233223, 3730.8321125549414, 3782.7541209821275, 4434.11317736454, 4472.575105364985, 4474.932876006863, 4500.752458614742, 4502.4371953505815, 5156.149235376196, 5173.249878767558, 5183.0670479314085, 5193.896122077537, 5246.658967167122, 4382.715123516961, 4423.137488189836, 4477.70894891831, 4486.349479325545, 4559.498455169929, 4627.329037289574, 4667.6732628716345, 4674.602658773974, 4685.835995740201, 4687.32033855096, 4886.071646387246, 4891.559759621651, 4901.754912254444, 4905.926411103907, 4935.309056731989, 5026.84919452417, 5223.686578805132, 5230.895382092261, 5241.213817927342, 5274.419813820554, 4746.050789841976, 4781.737004464788, 4812.614990800797, 4827.324174615627, 4911.778969946433, 5043.394792624908, 5070.771815268248, 5080.46655101209, 5089.745512724275, 5135.3324067870935, 5146.639735218649, 5165.560927321219, 5166.715830629351, 5168.8449346519665, 5174.482551744795, 4853.39332583427, 4853.975730121468, 4940.184869496493, 4977.925331120108, 4990.126727822544, 5009.699418034929, 5015.3480047593575, 5017.197248440232, 5026.547610715053, 5066.0, 4776.522347765195, 4780.569748722632, 4933.062718083553, 4935.358403407534, 4955.8017679292425, 4941.43173535048, 4960.429550601727, 5024.698518088926, 5030.698158110525, 5096.388433388017, 4898.363212782458, 4917.262410638433, 4918.778654960463, 4924.03981223658, 4968.726720030289], "value": 4708.176353268747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.2634099090777, 529.4573062610823, 542.9212764149198, 544.75758287562, 558.620138305952, 37395.626043739554, 38366.0, 38405.80797096011, 42103.36844947321, 42110.15779684405, 38451.23097538047, 38932.80533597328, 38977.41533876987, 38980.61019389805, 39017.0, 7648.120466146394, 7858.410619203554, 7859.056913170399, 7873.960630196841, 9579.473128977903, 9509.286803489731, 9759.268054895876, 9762.707118786448, 9779.55991980359, 9798.41209527427, 9702.70891873245, 9841.114299713025, 9841.606335746561, 9848.60605575776, 9849.950750246238, 9662.951685241564, 9725.173360264385, 9763.90236097637, 9797.167240784542, 9815.36200146988, 9634.903650963472, 9678.806423871554, 9725.65960191397, 9729.173020293283, 9739.610415583367, 34251.65748342535, 34532.13669658254, 34534.65465345339, 34593.48109778355, 34616.0, 3435.7251419886597, 3540.7344449166158, 3565.607783143852, 3575.0, 3596.7122630189524, 25503.0, 25591.87204063968, 25994.61008084861, 26050.218493445227, 26227.344316392242, 2992.1921081307923, 3043.802152860057, 3072.784905056647, 3191.4255434021866, 3192.8403579820915, 232300.0, 232551.0, 234083.0, 235077.82461087755, 235107.0, 46716.29925551119, 46771.76614116908, 46868.76565617218, 47121.17272963633, 47142.52857471381, 48647.75676121597, 48653.02693946172, 48714.512854871704, 48865.0, 48891.75554122207, 12533.43599538023, 12869.4208760606, 12883.54907578249, 12896.226226426445, 12903.0, 9122.452652840851, 9316.8602470963, 9572.808543829224, 9956.054174853378, 10093.09162175393, 15861.603459913595, 15861.968972017014, 15878.967867088833, 15887.364505419884, 15928.840711592737, 6447.7743278985945, 6502.317256688074, 6511.3163117871945, 6640.8671826563195, 6782.8304292392095, 784.6782819044164, 785.76034309535, 791.1929831571764, 805.2350267246022, 813.0649752784345, 26011.349716256867, 27273.590896136575, 27291.802042668594, 27618.0, 27784.444311114068, 924.2975338742469, 924.6209054287709, 925.4965318812596, 944.8252073366311, 949.4018768176005, 13945.721085578434, 14288.785668214985, 14297.0, 14592.708145837023, 14615.342309596093, 311941.0, 314485.9859809837, 314752.0, 315830.0, 316030.0, 48245.5175448241, 48929.510704893204, 49067.0, 49069.75465122652, 49144.26283605749, 1202.3447221264257, 1217.1419149499582, 1238.238483332744, 1243.4031664801128, 1256.0391300655006, 24597.0, 25767.742322576534, 26804.0, 26831.731682682923, 26853.731462685904, 41694.79152604217, 42341.36487952745, 42378.15243695171, 42465.0, 42485.362719558616, 215715.0, 216366.0, 216771.0, 216911.0, 219209.0, 24706.752932470445, 25425.237242882, 25543.489130217662, 25551.744482554936, 25603.487930241663, 40524.1895162101, 41182.38226426546, 42194.57805421906, 42395.152096957274, 42448.0, 34029.82985085059, 34383.0, 34495.482567762, 34715.0, 34962.82518587391, 33534.329313414084, 34082.0, 34088.48867266943, 34109.0, 34405.139871503416, 34199.0, 34303.82848085744, 34550.65449345474, 36358.636413635526, 37600.2479950394, 34306.0, 36692.63307366999, 36920.0, 37068.25863482769, 38085.4287185698, 27417.0, 29485.557716633837, 29846.850765746032, 29949.85025074861, 30294.84852575723], "value": 17130.382925791546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.9135403180254, 371.5615573623124, 374.87254333526596, 377.1438833847167, 396.0139253259383, 15609.375624974988, 16532.752008719865, 17034.318627254925, 17117.57206069849, 17149.742753858704, 16229.188540572954, 16603.50189494314, 16764.161791910385, 16885.83114168858, 16937.91531042346, 4971.875703107424, 5175.508326708976, 5203.947960520384, 5205.739713014353, 5217.895642087156, 5097.209932460474, 5321.973390133063, 5613.186088017235, 5646.18130371096, 5646.717664116798, 5612.438756124396, 5616.382197958222, 5624.465675760796, 5632.267805185341, 5640.464155905203, 5331.706756128411, 5357.223202635635, 5404.432534583871, 5407.702576358299, 5447.700376479292, 5217.530422261977, 5229.320188375525, 5239.056969745444, 5247.921281180786, 5261.316028916254, 12832.422540985584, 17584.560385990324, 18540.351087711864, 19268.132934018002, 19297.324593639154, 2115.9263921357156, 2197.1540956731615, 2214.900329485161, 2229.565234779219, 2240.316703405461, 8977.236934860544, 9029.729108126767, 9031.729048128567, 9530.761730956712, 9538.90461095387, 1753.6054387762779, 1764.550039739871, 1837.8621603379665, 1844.2530775035998, 1876.2588777432838, 61572.69213653948, 61689.691551542404, 63585.0, 64022.67988660074, 66403.66798166027, 8277.461964972257, 8648.827023459622, 8762.123787621187, 8875.378723489423, 9409.670661526814, 11650.825237621442, 11656.941715291368, 11682.883171168349, 11693.473793679304, 11750.529978800923, 6685.130932978779, 6687.632180230037, 6808.08090907731, 6930.61881596517, 6947.4789390795895, 6136.386361363828, 6266.561340706106, 6446.452051575575, 6554.442872355903, 6600.042993765877, 3671.52270204877, 3745.85016599333, 3750.8124593770203, 3777.33896568105, 3898.902527436837, 1580.130927989624, 1592.8805339599576, 1635.1415506858993, 1752.6056637256515, 1831.4871835885706, 818.9549574773445, 829.1542626520915, 832.500499700175, 833.2500749325534, 834.6619619054293, 15331.0, 15613.297401616728, 15838.445654402041, 15866.127362994916, 16684.165791710366, 794.4438892775081, 812.0470269003057, 816.1960468938091, 821.3018933906252, 844.7043534762906, 8697.95651021741, 8836.513991730388, 9142.81714365709, 9241.537923103819, 9415.482148481899, 288703.0, 288789.7802554953, 292518.0, 299389.0, 302003.0, 48542.441124587676, 67641.32358676351, 68142.65928670325, 68182.31817681859, 72200.0, 859.5216228087554, 882.8410886040574, 907.9909200908038, 908.2370808520742, 909.6588779207797, 14274.71450570962, 14437.163550210376, 14487.565373038826, 14552.199629020506, 14733.55799326022, 33469.49795753017, 33534.49698254577, 34796.47805282872, 34888.034517065316, 35611.643883560835, 45682.314765277886, 45703.54296457126, 45928.0, 46294.074118516764, 47568.762156189, 7518.699252029857, 7548.207438219128, 7626.96186519086, 7740.342070923809, 7812.960935195288, 9041.547922603975, 9446.527673616154, 10472.31400023888, 10532.157427405637, 10547.261691681508, 9040.728778136667, 9106.635734570544, 9243.0, 9262.72211833646, 9321.580528876353, 8886.955565222392, 9185.954070229605, 9270.119338662817, 9287.164155226063, 9356.064393560862, 8988.0, 9323.953380233055, 9407.388519746468, 9533.23734101284, 10106.979316667781, 7564.432667549846, 7693.961530192313, 7697.923020769945, 7737.613119344122, 7848.9215107848195, 7531.359834413917, 8641.265492432962, 8867.246284065926, 9187.08129187076, 9362.719118426457], "value": 7712.926027651995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6725818545365, 1313.1989486413286, 1317.1504379675105, 1321.603518944317, 1327.6017194841545, 6281.654509002003, 6529.608223506581, 6680.331966803317, 7068.293170682936, 7094.32603902629, 6667.0, 6922.861542769142, 6929.965350173255, 7038.788836334918, 7046.541974771636, 2061.6186005588975, 2092.3722883134997, 2092.8639638423456, 2098.370488853338, 2101.0125241136716, 2027.5336672565318, 2067.1111422088497, 2069.689546568012, 2129.659254519277, 2219.6892435059103, 2113.0, 2137.572485502898, 2141.732283464567, 2142.111023925077, 2142.817860481861, 2019.7273368095339, 2030.786767389425, 2033.9389818305326, 2038.1745393115812, 2040.9693854592192, 2065.814076733086, 2071.5028393185676, 2091.968620470694, 2095.0991073838245, 2104.7263855698816, 7019.157701075853, 7148.49960502765, 7179.964100179518, 7217.133943926762, 7338.633068346561, 4325.653947684209, 4463.107378524276, 4465.151621191995, 4472.373867658531, 4481.991551900796, 2708.620793088969, 2799.762020228283, 2845.231787417386, 2859.342351259222, 2861.5135426977254, 1132.6318946342471, 1134.3307448605362, 1137.4995002199005, 1141.8686851012158, 1192.3620862838427, 8958.776030599221, 8961.507117108556, 8974.685885993958, 9049.321300902458, 9084.0, 3611.963880361215, 3733.9439908401396, 3820.1595648957186, 3822.8853134406013, 3941.1329507508303, 7436.73971410998, 7438.0, 7445.851082978418, 7453.813654658677, 7479.476436649491, 4266.530681625019, 4270.0605866709275, 4270.188664153801, 4278.55075217104, 4289.399484072233, 3942.3495123304906, 4007.499062617173, 4030.899227519277, 4065.410515475299, 4072.144849581621, 3153.30627262002, 3175.920601984969, 3225.0647312279643, 3226.7741258111705, 3259.4947783093658, 951.1344676344494, 994.3188915592842, 997.9251556133319, 1001.979960400788, 1141.9600313989138, 779.5439667794291, 801.703369753195, 807.6648191000786, 810.2140923304386, 814.2712272516065, 4778.474367819537, 4783.521647835189, 4806.639502037291, 4918.139325618003, 5046.0, 808.1514409869613, 811.6225954930985, 812.5733989655478, 831.2518733140222, 874.6282829797311, 3219.3239419721654, 3301.3562355340478, 3437.3984552703178, 3459.775114617592, 3569.785812851237, 8161.510309381456, 8302.464044151851, 8345.663214300006, 8411.0, 8414.579271036424, 8365.163483651586, 8378.49729016261, 8379.748607541784, 8392.034915984617, 8392.748217553482, 6300.495960323072, 6350.460210882126, 6440.0661904023655, 6464.353564643592, 6491.740330386731, 4501.324801279834, 4608.769561521844, 4729.0, 4751.904961900812, 4844.442889067803, 7367.889481657672, 7404.592747398945, 7514.962425188058, 7521.623918803928, 7523.548587084792, 7575.053118360205, 7738.458307918391, 7851.803704907423, 7879.527228366087, 7893.644785984529, 6077.787277445268, 6233.563650544418, 6261.7182226799, 6271.811845644638, 6272.466840318624, 6559.27847936717, 6562.639054852029, 6595.934040659532, 6664.5334826561675, 6672.566283191577, 5728.369879313355, 5761.164631128547, 5838.357780644041, 5858.94141058584, 5859.5019423349495, 5942.762289508544, 6010.609310394811, 6035.245594300713, 6049.517868122338, 6131.816045518642, 5285.127953887565, 5325.387580428301, 5337.279467271868, 5356.143017117242, 5370.275012873212, 3991.8203680833853, 4037.475128233428, 4129.607687269705, 4147.0461793787, 4183.518895327076, 4190.078182799779, 4230.830766769294, 4243.5544267852665, 4335.371371151103, 4337.934930975975], "value": 3785.3861540170456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9965100348996, 349.72721277403616, 354.2295507271683, 361.6799132767501, 373.40628400842655, 4921.163402221622, 4936.580390666798, 4963.950360496394, 4981.252812078185, 5029.798808047678, 4869.513048695128, 4883.511648835115, 4908.337374454457, 4908.950910490903, 4909.410870695513, 3738.8130593470355, 3777.792221427834, 3806.7525610835205, 3828.770273783568, 4014.2372949139644, 3820.617938206185, 3830.4637350770913, 3835.6958634064413, 3847.615238476158, 3850.84596616135, 3803.7147213959065, 3806.5812760596314, 3806.809659517027, 3811.9618803812023, 3823.751456155355, 3690.5571331440133, 3814.90462738431, 3817.3892177251646, 3822.311983842907, 3822.522184726909, 3323.351946370459, 3338.1821453743746, 3338.7996720196866, 3350.9444524974556, 3355.2618423946938, 4717.367626927281, 4722.504137065593, 4729.6452766042685, 4739.772307015697, 4753.643476739224, 4309.41822853917, 4323.82704691812, 4328.5887840655405, 4331.848385306531, 4342.871992723574, 4975.427825800043, 5048.596112311006, 5049.495050494921, 5075.670081444694, 5109.591232701412, 3619.895931740818, 3627.292677927805, 3635.63643635637, 3637.890863274106, 3654.28741395428, 5181.766820493049, 5292.2326262691695, 5328.280682107905, 5343.305370301836, 5348.893022139574, 3712.3132220539287, 3721.702263818888, 3723.4414837774552, 3728.9677125966414, 3730.8321125549414, 3723.5717892442717, 3763.5483741950593, 3766.5856755756845, 3766.8116594170183, 3780.8487660493824, 4296.570342965679, 4306.332518459643, 4313.935290970638, 4316.482022157298, 4319.028218650778, 5004.624653151028, 5074.340335756402, 5110.182370820651, 5123.205903085028, 5149.138146390207, 1254.2787896959285, 1262.551794113095, 1263.4882872436679, 1266.4174479739422, 1273.3124112978887, 806.9354451643972, 837.3050368194384, 843.35904712419, 847.8897743293332, 849.2696281198165, 4351.214443434233, 4360.4331436913, 4418.2488976873365, 4423.51341352451, 4425.889352766142, 5073.492650734971, 5084.847454576368, 5123.97438012815, 5152.665076770073, 5157.252198431282, 4286.882258493474, 4398.164348773723, 4423.712458690175, 4427.634997401933, 4453.554644535585, 2656.0, 2698.446818402223, 2714.4164004739077, 2714.443539074485, 2719.8232114912466, 4754.358161648133, 4762.761861906891, 4764.523547645277, 4773.9045219096115, 4795.760211989386, 5116.341815601862, 5168.793248270103, 5169.353830771153, 5202.271681964528, 5206.349206349207, 5003.399592048978, 5008.1486147355035, 5029.119904016782, 5031.84904452867, 5036.496350365008, 5331.333583302087, 5331.920021199608, 5333.466653334791, 5341.385740639721, 5353.544948679406, 4939.517640063818, 5193.402758682649, 5229.771003814177, 5249.238860365149, 5250.606204534752, 4868.3934301681065, 5028.572571331478, 5028.572571331478, 5038.823641172541, 5053.620978426559, 3644.7084233261808, 3654.8903532894055, 3656.3966945453703, 3671.632836716307, 3679.4848721178523, 5308.548773354308, 5309.2301616266195, 5311.628186026941, 5322.8935421292135, 5350.892982140414, 4949.208126699711, 5136.794528218829, 5140.794368225229, 5151.347056265951, 5151.686319988379, 5119.539241468286, 5122.410922743932, 5156.922646160386, 5161.483851614808, 5174.327337446108, 5068.265101560327, 5109.3613298337705, 5111.923321150261, 5118.3090282811345, 5127.743612819269, 5034.720487585523, 5116.0, 5186.507281808223, 5199.844004679866, 5204.869878253074, 5050.823221187241, 5072.797088116434, 5075.264086707481, 5087.847364579068, 5088.160453525127], "value": 3855.4006622125044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9506537009722, 675.1257122026975, 738.2285511640335, 755.4334249313015, 774.5275382016969, 12180.0, 13454.59636210914, 14512.78230826537, 15128.697426051473, 15141.697166056672, 15308.158051307173, 15374.693151082143, 15467.535973920772, 15512.84487155128, 15516.61208469786, 781.9296263336298, 809.0412860759989, 825.3768404854327, 828.4159667434444, 829.4069740135802, 790.5967956342249, 807.8222790985974, 808.8301456694102, 810.1655295046112, 811.1645005644195, 864.3042350907517, 865.7748985263845, 866.1857853617579, 868.6785889220965, 868.7828042989253, 858.5063588436611, 860.5181098584812, 861.9482831030095, 864.822711344173, 864.8659457784022, 627.5826575327402, 629.7575433458106, 634.5177664974652, 635.8569321902581, 636.6816591704148, 13971.86028139726, 14180.0, 14399.0, 14488.782668259984, 14550.70898582033, 12465.75068498625, 12778.169418987829, 12814.679633009157, 13245.07284490086, 13330.733580309856, 10197.133243674296, 10438.68683939483, 10517.9474102629, 10620.734481637943, 10945.343279403261, 3202.0, 3224.98387508061, 3229.4671379222636, 3308.0, 3385.8307084645917, 68997.31002689959, 70042.29957700409, 70253.2974670257, 70703.2929670707, 72598.0, 9723.173530250007, 9774.51127443625, 9959.80080398388, 10011.0, 10084.697459076093, 17836.10819459022, 17862.821371786376, 18274.90862545679, 18624.906875465807, 18663.81336186648, 6712.674398891055, 6777.915533514614, 6855.211650660138, 7057.258987806309, 7100.325469080429, 3495.2310491691787, 3589.623089575557, 3631.618680038611, 3645.0522864055006, 3663.3222853772136, 2943.0876428307292, 3003.6695963444004, 3023.410434965205, 3024.138120635608, 3031.045220755455, 469.94360676719015, 478.8627010849233, 480.2795806290564, 485.861529464101, 497.08536293219925, 604.2869414091326, 626.8934281172212, 637.7162162837493, 637.9649119298483, 639.8944174211204, 7748.760198368234, 7814.765557033298, 7964.641591128413, 8012.479188852706, 8150.877736833952, 586.3081563754725, 598.4733434577631, 598.8053882488122, 600.9819705408845, 607.3895734786511, 3514.8594056237976, 3758.342290099222, 3763.2285381496727, 3795.3927371620407, 3796.848126074926, 63369.36630633635, 64407.355926440134, 64408.35591644117, 65697.67151164309, 66723.33276667268, 48584.757076214395, 55832.72083639556, 55872.0, 56081.27024756974, 57701.42298577044, 52055.0, 52552.47447525552, 52650.736746316026, 52947.0, 53155.468445315826, 7113.644317784194, 7518.661660225193, 7538.773836784686, 7582.090149182133, 7649.847003059796, 35801.64198357983, 37036.44445333268, 37205.25589488141, 37293.254134916606, 38169.80915095407, 44698.55301446944, 45427.318590220515, 46144.307835383166, 46589.534104658516, 46717.0, 9245.399049061789, 9321.580528876353, 9339.41682190855, 9430.95284523573, 9663.661771837951, 11044.33733975964, 11199.328040317607, 11302.717432064264, 11397.487113079766, 11904.940475297568, 10490.52792624349, 10530.684079477322, 10584.100351470212, 10588.523516441932, 10648.361098334124, 10618.203634727271, 10896.455177241265, 10942.398168100512, 10973.0, 11127.443627818415, 10396.272260941661, 10410.739731506774, 10436.739081523023, 10438.164946804085, 10608.734781630212, 9221.677241296791, 9396.154346108882, 9580.13778759915, 9734.9026509734, 9813.165880900204, 8587.871181932402, 8655.826883462421, 8834.690785822466, 9121.954390228006, 9316.627334906529], "value": 6238.811365147799, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 117.0, 115.0, 115.0, 116.0, 116.0, 116.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 128.0, 176.0, 131.0, 130.0, 129.0, 128.0, 145.0, 130.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 177.0, 163.0, 163.0, 163.0, 165.0, 164.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 120.0, 79.0, 79.0, 79.0, 79.0, 92.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 106.0, 85.0, 86.0, 86.0, 98.0, 85.0, 85.0, 106.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 152.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 72.0, 78.0, 71.0, 73.0, 74.0, 71.0, 75.0], "value": 73.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 69.0, 67.0, 68.0, 67.0, 69.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 84.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 135.0, 139.0, 134.0, 136.0, 138.0, 153.0, 182.0, 153.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 174.0, 175.0, 181.0, 183.0, 187.0, 179.0, 177.0, 175.0, 181.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 70.0, 72.0, 68.0, 72.0, 68.0, 69.0], "value": 69.5, "unit": "score"}]}]} 02:16:50 INFO - Return code: 0 02:16:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:16:50 ERROR - # TBPL SUCCESS # 02:16:50 INFO - Running post-action listener: _resource_record_post_action 02:16:50 INFO - [mozharness: 2016-12-30 10:16:50.235325Z] Finished run-tests step (success) 02:16:50 INFO - Running post-run listener: _resource_record_post_run 02:16:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 16384; Write bytes: 383455232; Read time: 220; Write time: 277036 02:16:50 INFO - TinderboxPrint: CPU usage
13.5% 02:16:50 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 220 02:16:50 INFO - TinderboxPrint: I/O write bytes / time
383,455,232 / 277,036 02:16:50 INFO - TinderboxPrint: CPU idle
8,275.8 (86.5%) 02:16:50 INFO - TinderboxPrint: CPU user
1,230.5 (12.9%) 02:16:50 INFO - TinderboxPrint: Swap in / out
0 / 0 02:16:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99332096; Read time: 36; Write time: 86048 02:16:50 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281759744; Read time: 172; Write time: 190800 02:16:50 INFO - Running post-run listener: _upload_blobber_files 02:16:50 INFO - Blob upload gear active. 02:16:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:16:50 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 02:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:16:51 INFO - (blobuploader) - INFO - Open directory for files ... 02:16:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:52 INFO - (blobuploader) - INFO - Done attempting. 02:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:52 INFO - (blobuploader) - INFO - Done attempting. 02:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:56 INFO - (blobuploader) - INFO - Done attempting. 02:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:57 INFO - (blobuploader) - INFO - Done attempting. 02:16:57 INFO - (blobuploader) - INFO - Iteration through files over. 02:16:57 INFO - Return code: 0 02:16:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:16:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:16:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d8cf9a5f6395cb866ba545586b1b7d391b8504410907d3abf8312679c0286854ee206640352cc0722bdde56f0b1089b2fcee8d3877e71e69fedd87cf959294c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ab18974a69de685a3c32bd4cc2644c684a8d53c183df8de23a2e5ddb7da9a3e9be97f7e0e9b0397eade542c925016ba76e3f7231b6c96ae4ea83bad7a49ef0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fed21efd13824681b8c63b9e97728576d82f7c1bfe00dac146bc6e62b00f79bbcb1d6be8e40a0b53d46efe6063133bee84a9cdbec7d8027a18281611816a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f6ef0c86b1c88a5b0604c38da2fb5d866f97bc463aa1629e45e45f720dc0c73363530b176484872feab2184aa316952992858c7ec13f697b26891780e51baa15"} 02:16:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:16:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:16:57 INFO - Contents: 02:16:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d8cf9a5f6395cb866ba545586b1b7d391b8504410907d3abf8312679c0286854ee206640352cc0722bdde56f0b1089b2fcee8d3877e71e69fedd87cf959294c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ab18974a69de685a3c32bd4cc2644c684a8d53c183df8de23a2e5ddb7da9a3e9be97f7e0e9b0397eade542c925016ba76e3f7231b6c96ae4ea83bad7a49ef0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fed21efd13824681b8c63b9e97728576d82f7c1bfe00dac146bc6e62b00f79bbcb1d6be8e40a0b53d46efe6063133bee84a9cdbec7d8027a18281611816a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f6ef0c86b1c88a5b0604c38da2fb5d866f97bc463aa1629e45e45f720dc0c73363530b176484872feab2184aa316952992858c7ec13f697b26891780e51baa15"} 02:16:57 INFO - Running post-run listener: copy_logs_to_upload_dir 02:16:57 INFO - Copying logs to upload dir... 02:16:57 INFO - mkdir: /builds/slave/test/build/upload/logs 02:16:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.289284 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-30 02:16:57.289509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 02:16:57.293424) ========= 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=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d8cf9a5f6395cb866ba545586b1b7d391b8504410907d3abf8312679c0286854ee206640352cc0722bdde56f0b1089b2fcee8d3877e71e69fedd87cf959294c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ab18974a69de685a3c32bd4cc2644c684a8d53c183df8de23a2e5ddb7da9a3e9be97f7e0e9b0397eade542c925016ba76e3f7231b6c96ae4ea83bad7a49ef0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fed21efd13824681b8c63b9e97728576d82f7c1bfe00dac146bc6e62b00f79bbcb1d6be8e40a0b53d46efe6063133bee84a9cdbec7d8027a18281611816a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f6ef0c86b1c88a5b0604c38da2fb5d866f97bc463aa1629e45e45f720dc0c73363530b176484872feab2184aa316952992858c7ec13f697b26891780e51baa15"} build_url:https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/W3eDkSGSR_eK4u7NXbVnNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d8cf9a5f6395cb866ba545586b1b7d391b8504410907d3abf8312679c0286854ee206640352cc0722bdde56f0b1089b2fcee8d3877e71e69fedd87cf959294c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ab18974a69de685a3c32bd4cc2644c684a8d53c183df8de23a2e5ddb7da9a3e9be97f7e0e9b0397eade542c925016ba76e3f7231b6c96ae4ea83bad7a49ef0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fed21efd13824681b8c63b9e97728576d82f7c1bfe00dac146bc6e62b00f79bbcb1d6be8e40a0b53d46efe6063133bee84a9cdbec7d8027a18281611816a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f6ef0c86b1c88a5b0604c38da2fb5d866f97bc463aa1629e45e45f720dc0c73363530b176484872feab2184aa316952992858c7ec13f697b26891780e51baa15"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 02:16:57.318606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:16:57.318919) ========= 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=826874ccc97bd7bf541b4875000001d5-1483091768.576517-644013405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:16:57.401756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 02:16:57.402163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 02:16:57.402449) ========= ========= Total master_lag: 0.36 =========