builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1482963066.6 results: success (0) buildid: 20161228121037 builduid: 9cc1a6fc6bbd49c79879c26b793d59a8 revision: 96716340bdf33caec3bb939fc76fd837d1a3d197 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.605050) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.605649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.605940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.630793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.631164) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-28 14:11:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-12-28 14:11:08 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.726247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.726620) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.777063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:06.777419) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 96716340bdf33caec3bb939fc76fd837d1a3d197 --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 96716340bdf33caec3bb939fc76fd837d1a3d197 --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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-28 14:11:08,969 truncating revision to first 12 chars 2016-12-28 14:11:08,969 Setting DEBUG logging. 2016-12-28 14:11:08,969 attempt 1/10 2016-12-28 14:11:08,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/96716340bdf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-28 14:11:09,297 unpacking tar archive at: graphics-96716340bdf3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:07.420098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:07.420441) ========= script_repo_revision: 96716340bdf33caec3bb939fc76fd837d1a3d197 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:07.420822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:07.421086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 14:11:07.437450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-28 14:11:07.437725) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:09 INFO - MultiFileLogger online at 20161228 14:11:09 in /builds/slave/test 14:11:09 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 14:11:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:09 INFO - {'append_to_log': False, 14:11:09 INFO - 'base_work_dir': '/builds/slave/test', 14:11:09 INFO - 'blob_upload_branch': 'Graphics', 14:11:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:09 INFO - 'branch': 'Graphics', 14:11:09 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:09 INFO - 'config_files': ('talos/linux_config.py',), 14:11:09 INFO - 'default_actions': ('clobber', 14:11:09 INFO - 'read-buildbot-config', 14:11:09 INFO - 'download-and-extract', 14:11:09 INFO - 'populate-webroot', 14:11:09 INFO - 'create-virtualenv', 14:11:09 INFO - 'install', 14:11:09 INFO - 'run-tests'), 14:11:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:09 INFO - 'download_minidump_stackwalk': True, 14:11:09 INFO - 'download_symbols': 'ondemand', 14:11:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:09 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:09 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:09 INFO - 'installer_path': 'installer.exe', 14:11:09 INFO - 'log_level': 'info', 14:11:09 INFO - 'log_name': 'talos', 14:11:09 INFO - 'log_to_console': True, 14:11:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:09 INFO - 'opt_config_files': (), 14:11:09 INFO - 'pip_index': False, 14:11:09 INFO - 'sps_profile': False, 14:11:09 INFO - 'sps_profile_interval': 0, 14:11:09 INFO - 'suite': 'dromaeojs-e10s', 14:11:09 INFO - 'system_bits': '32', 14:11:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:09 INFO - 'title': 'talos-linux64-ix-068', 14:11:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:09 INFO - 'use_talos_json': True, 14:11:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:09 INFO - 'work_dir': 'build'} 14:11:09 INFO - [mozharness: 2016-12-28 22:11:09.724816Z] Running clobber step. 14:11:09 INFO - Running pre-action listener: _resource_record_pre_action 14:11:09 INFO - Running main action method: clobber 14:11:09 INFO - rmtree: /builds/slave/test/build 14:11:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:10 INFO - Running post-action listener: _resource_record_post_action 14:11:10 INFO - [mozharness: 2016-12-28 22:11:10.188957Z] Finished clobber step (success) 14:11:10 INFO - [mozharness: 2016-12-28 22:11:10.189060Z] Running read-buildbot-config step. 14:11:10 INFO - Running pre-action listener: _resource_record_pre_action 14:11:10 INFO - Running main action method: read_buildbot_config 14:11:10 INFO - Using buildbot properties: 14:11:10 INFO - { 14:11:10 INFO - "project": "", 14:11:10 INFO - "product": "firefox", 14:11:10 INFO - "script_repo_revision": "default", 14:11:10 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 14:11:10 INFO - "repository": "", 14:11:10 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 14:11:10 INFO - "buildid": "20161228121037", 14:11:10 INFO - "pgo_build": "False", 14:11:10 INFO - "basedir": "/builds/slave/test", 14:11:10 INFO - "buildnumber": 46, 14:11:10 INFO - "slavename": "talos-linux64-ix-068", 14:11:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:11:10 INFO - "platform": "ubuntu64_hw", 14:11:10 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 14:11:10 INFO - "branch": "graphics", 14:11:10 INFO - "repo_path": "projects/graphics", 14:11:10 INFO - "revision": "96716340bdf33caec3bb939fc76fd837d1a3d197", 14:11:10 INFO - "stage_platform": "linux64", 14:11:10 INFO - "builduid": "9cc1a6fc6bbd49c79879c26b793d59a8", 14:11:10 INFO - "slavebuilddir": "test" 14:11:10 INFO - } 14:11:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:11:10 INFO - Running post-action listener: _resource_record_post_action 14:11:10 INFO - [mozharness: 2016-12-28 22:11:10.191523Z] Finished read-buildbot-config step (success) 14:11:10 INFO - [mozharness: 2016-12-28 22:11:10.191613Z] Running download-and-extract step. 14:11:10 INFO - Running pre-action listener: _resource_record_pre_action 14:11:10 INFO - Running main action method: download_and_extract 14:11:10 INFO - mkdir: /builds/slave/test/build/tests 14:11:10 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')]} 14:11:10 INFO - trying https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:11:10 INFO - Downloading https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/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 14:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/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 14:11:10 INFO - Downloaded 1361 bytes. 14:11:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:11:10 INFO - Using the following test package requirements: 14:11:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'jsshell-linux-x86_64.zip'], 14:11:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:11:11 INFO - Expected file size: 20241358 14:11:11 INFO - Obtained file size: 20241358 14:11:15 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 14:11:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:11:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:15 INFO - Fetch https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:11:16 INFO - Expected file size: 20241358 14:11:16 INFO - Obtained file size: 20241358 14:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:11:21 INFO - Expected file size: 14409776 14:11:21 INFO - Obtained file size: 14409776 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:22 INFO - trying https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:11:22 INFO - Downloading https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/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 14:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/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 14:11:23 INFO - Downloaded 55917426 bytes. 14:11:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:11:23 INFO - mkdir: /builds/slave/test/properties 14:11:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:23 INFO - Contents: 14:11:23 INFO - build_url:https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:11:24 INFO - Running post-action listener: _resource_record_post_action 14:11:24 INFO - Running post-action listener: set_extra_try_arguments 14:11:24 INFO - [mozharness: 2016-12-28 22:11:24.073949Z] Finished download-and-extract step (success) 14:11:24 INFO - [mozharness: 2016-12-28 22:11:24.074176Z] Running populate-webroot step. 14:11:24 INFO - Running pre-action listener: _resource_record_pre_action 14:11:24 INFO - Running main action method: populate_webroot 14:11:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:24 INFO - '--tppagecycles', 14:11:24 INFO - '7'], 14:11:24 INFO - 'tests': ['tsvgm']}}, 14:11:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['damp', 'tps']}, 14:11:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'tests': ['damp', 'tps']}, 14:11:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['dromaeo_dom']}, 14:11:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['basic_compositor_video']}, 14:11:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['a11yr', 14:11:24 INFO - 'ts_paint', 14:11:24 INFO - 'tpaint', 14:11:24 INFO - 'sessionrestore', 14:11:24 INFO - 'sessionrestore_no_auto_restore', 14:11:24 INFO - 'tabpaint']}, 14:11:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['tsvgx', 14:11:24 INFO - 'tsvgr_opacity', 14:11:24 INFO - 'tart', 14:11:24 INFO - 'tscrollx', 14:11:24 INFO - 'cart', 14:11:24 INFO - 'tsvg_static']}, 14:11:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:24 INFO - 'tsvgr_opacity', 14:11:24 INFO - 'tart', 14:11:24 INFO - 'tscrollx', 14:11:24 INFO - 'cart', 14:11:24 INFO - 'tsvg_static']}, 14:11:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'talos_options': ['--disable-e10s'], 14:11:24 INFO - 'tests': ['tp5o']}, 14:11:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:11:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'talos_options': ['--disable-e10s', 14:11:24 INFO - '--xperf_path', 14:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:24 INFO - 'tests': ['tp5n']}, 14:11:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:11:24 INFO - 'talos_options': ['--xperf_path', 14:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:24 INFO - 'tests': ['tp5n']}}, 14:11:24 INFO - 'talos.zip': {'path': '', 14:11:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:24 INFO - Running post-action listener: _resource_record_post_action 14:11:24 INFO - [mozharness: 2016-12-28 22:11:24.092408Z] Finished populate-webroot step (success) 14:11:24 INFO - [mozharness: 2016-12-28 22:11:24.092497Z] Running create-virtualenv step. 14:11:24 INFO - Running pre-action listener: _resource_record_pre_action 14:11:24 INFO - Running main action method: create_virtualenv 14:11:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:24 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 14:11:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:24 INFO - Using real prefix '/usr' 14:11:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:26 INFO - Installing pip.................done. 14:11:26 INFO - Return code: 0 14:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:11:26 INFO - Reading from file tmpfile_stdout 14:11:26 INFO - Output received: 14:11:26 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) 14:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:26 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:26 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 14:11:26 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 14:11:26 INFO - Using env: {'DISPLAY': ':0', 14:11:26 INFO - 'HOME': '/home/cltbld', 14:11:26 INFO - 'LANG': 'en_US.UTF-8', 14:11:26 INFO - 'LANGUAGE': 'en_US:en', 14:11:26 INFO - 'LOGNAME': 'cltbld', 14:11:26 INFO - 'MAIL': '/var/mail/cltbld', 14:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:26 INFO - 'MOZ_NO_REMOTE': '1', 14:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:26 INFO - 'NO_EM_RESTART': '1', 14:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:26 INFO - 'PWD': '/builds/slave/test', 14:11:26 INFO - 'SHELL': '/bin/bash', 14:11:26 INFO - 'SHLVL': '1', 14:11:26 INFO - 'TERM': 'linux', 14:11:26 INFO - 'TMOUT': '86400', 14:11:26 INFO - 'USER': 'cltbld', 14:11:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:26 INFO - '_': '/tools/buildbot/bin/python'} 14:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:27 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 14:11:27 INFO - Cleaning up... 14:11:27 INFO - Return code: 0 14:11:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:27 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')]} 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:27 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')]} 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:27 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:27 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 14:11:27 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 14:11:27 INFO - Using env: {'DISPLAY': ':0', 14:11:27 INFO - 'HOME': '/home/cltbld', 14:11:27 INFO - 'LANG': 'en_US.UTF-8', 14:11:27 INFO - 'LANGUAGE': 'en_US:en', 14:11:27 INFO - 'LOGNAME': 'cltbld', 14:11:27 INFO - 'MAIL': '/var/mail/cltbld', 14:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:27 INFO - 'MOZ_NO_REMOTE': '1', 14:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:27 INFO - 'NO_EM_RESTART': '1', 14:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:27 INFO - 'PWD': '/builds/slave/test', 14:11:27 INFO - 'SHELL': '/bin/bash', 14:11:27 INFO - 'SHLVL': '1', 14:11:27 INFO - 'TERM': 'linux', 14:11:27 INFO - 'TMOUT': '86400', 14:11:27 INFO - 'USER': 'cltbld', 14:11:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:27 INFO - '_': '/tools/buildbot/bin/python'} 14:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:27 INFO - Downloading/unpacking psutil>=3.1.1 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:29 INFO - Installing collected packages: psutil 14:11:29 INFO - Running setup.py install for psutil 14:11:29 INFO - building 'psutil._psutil_linux' extension 14:11:29 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 14:11:29 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 14:11:29 INFO - building 'psutil._psutil_posix' extension 14:11:29 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 14:11:29 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 14:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:29 INFO - Successfully installed psutil 14:11:29 INFO - Cleaning up... 14:11:30 INFO - Return code: 0 14:11:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:30 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')]} 14:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:30 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')]} 14:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:30 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:30 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 14:11:30 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 14:11:30 INFO - Using env: {'DISPLAY': ':0', 14:11:30 INFO - 'HOME': '/home/cltbld', 14:11:30 INFO - 'LANG': 'en_US.UTF-8', 14:11:30 INFO - 'LANGUAGE': 'en_US:en', 14:11:30 INFO - 'LOGNAME': 'cltbld', 14:11:30 INFO - 'MAIL': '/var/mail/cltbld', 14:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:30 INFO - 'MOZ_NO_REMOTE': '1', 14:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:30 INFO - 'NO_EM_RESTART': '1', 14:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:30 INFO - 'PWD': '/builds/slave/test', 14:11:30 INFO - 'SHELL': '/bin/bash', 14:11:30 INFO - 'SHLVL': '1', 14:11:30 INFO - 'TERM': 'linux', 14:11:30 INFO - 'TMOUT': '86400', 14:11:30 INFO - 'USER': 'cltbld', 14:11:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:30 INFO - '_': '/tools/buildbot/bin/python'} 14:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:32 INFO - Installing collected packages: mozsystemmonitor 14:11:32 INFO - Running setup.py install for mozsystemmonitor 14:11:32 INFO - Successfully installed mozsystemmonitor 14:11:32 INFO - Cleaning up... 14:11:32 INFO - Return code: 0 14:11:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11: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 jsonschema==2.5.1 14:11:32 INFO - Using env: {'DISPLAY': ':0', 14:11:32 INFO - 'HOME': '/home/cltbld', 14:11:32 INFO - 'LANG': 'en_US.UTF-8', 14:11:32 INFO - 'LANGUAGE': 'en_US:en', 14:11:32 INFO - 'LOGNAME': 'cltbld', 14:11:32 INFO - 'MAIL': '/var/mail/cltbld', 14:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:32 INFO - 'MOZ_NO_REMOTE': '1', 14:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:32 INFO - 'NO_EM_RESTART': '1', 14:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:32 INFO - 'PWD': '/builds/slave/test', 14:11:32 INFO - 'SHELL': '/bin/bash', 14:11:32 INFO - 'SHLVL': '1', 14:11:32 INFO - 'TERM': 'linux', 14:11:32 INFO - 'TMOUT': '86400', 14:11:32 INFO - 'USER': 'cltbld', 14:11:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:32 INFO - '_': '/tools/buildbot/bin/python'} 14:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:32 INFO - Downloading/unpacking jsonschema==2.5.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:35 INFO - warning: no files found matching '*.txt' 14:11:35 INFO - no previously-included directories found matching 'build' 14:11:35 INFO - no previously-included directories found matching 'dist' 14:11:35 INFO - no previously-included directories found matching '.git*' 14:11:35 INFO - Installing collected packages: jsonschema, functools32 14:11:35 INFO - Running setup.py install for functools32 14:11:35 INFO - warning: no files found matching '*.txt' 14:11:35 INFO - no previously-included directories found matching 'build' 14:11:35 INFO - no previously-included directories found matching 'dist' 14:11:35 INFO - no previously-included directories found matching '.git*' 14:11:35 INFO - Successfully installed jsonschema functools32 14:11:35 INFO - Cleaning up... 14:11:35 INFO - Return code: 0 14:11:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:11: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 functools32==3.2.3-2 14:11:35 INFO - Using env: {'DISPLAY': ':0', 14:11:35 INFO - 'HOME': '/home/cltbld', 14:11:35 INFO - 'LANG': 'en_US.UTF-8', 14:11:35 INFO - 'LANGUAGE': 'en_US:en', 14:11:35 INFO - 'LOGNAME': 'cltbld', 14:11:35 INFO - 'MAIL': '/var/mail/cltbld', 14:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:35 INFO - 'MOZ_NO_REMOTE': '1', 14:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:35 INFO - 'NO_EM_RESTART': '1', 14:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:35 INFO - 'PWD': '/builds/slave/test', 14:11:35 INFO - 'SHELL': '/bin/bash', 14:11:35 INFO - 'SHLVL': '1', 14:11:35 INFO - 'TERM': 'linux', 14:11:35 INFO - 'TMOUT': '86400', 14:11:35 INFO - 'USER': 'cltbld', 14:11:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:35 INFO - '_': '/tools/buildbot/bin/python'} 14:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:35 INFO - Cleaning up... 14:11:35 INFO - Return code: 0 14:11:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11: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 blobuploader==1.2.4 14:11:35 INFO - Using env: {'DISPLAY': ':0', 14:11:35 INFO - 'HOME': '/home/cltbld', 14:11:35 INFO - 'LANG': 'en_US.UTF-8', 14:11:35 INFO - 'LANGUAGE': 'en_US:en', 14:11:35 INFO - 'LOGNAME': 'cltbld', 14:11:35 INFO - 'MAIL': '/var/mail/cltbld', 14:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:35 INFO - 'MOZ_NO_REMOTE': '1', 14:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:35 INFO - 'NO_EM_RESTART': '1', 14:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:35 INFO - 'PWD': '/builds/slave/test', 14:11:35 INFO - 'SHELL': '/bin/bash', 14:11:35 INFO - 'SHLVL': '1', 14:11:35 INFO - 'TERM': 'linux', 14:11:35 INFO - 'TMOUT': '86400', 14:11:35 INFO - 'USER': 'cltbld', 14:11:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:35 INFO - '_': '/tools/buildbot/bin/python'} 14:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:35 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:38 INFO - Downloading docopt-0.6.1.tar.gz 14:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:38 INFO - Running setup.py install for blobuploader 14:11:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:38 INFO - Running setup.py install for requests 14:11:38 INFO - Running setup.py install for docopt 14:11:39 INFO - Successfully installed blobuploader requests docopt 14:11:39 INFO - Cleaning up... 14:11:39 INFO - Return code: 0 14:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:39 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 14:11:39 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 14:11:39 INFO - Using env: {'DISPLAY': ':0', 14:11:39 INFO - 'HOME': '/home/cltbld', 14:11:39 INFO - 'LANG': 'en_US.UTF-8', 14:11:39 INFO - 'LANGUAGE': 'en_US:en', 14:11:39 INFO - 'LOGNAME': 'cltbld', 14:11:39 INFO - 'MAIL': '/var/mail/cltbld', 14:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:39 INFO - 'MOZ_NO_REMOTE': '1', 14:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:39 INFO - 'NO_EM_RESTART': '1', 14:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:39 INFO - 'PWD': '/builds/slave/test', 14:11:39 INFO - 'SHELL': '/bin/bash', 14:11:39 INFO - 'SHLVL': '1', 14:11:39 INFO - 'TERM': 'linux', 14:11:39 INFO - 'TMOUT': '86400', 14:11:39 INFO - 'USER': 'cltbld', 14:11:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:39 INFO - '_': '/tools/buildbot/bin/python'} 14:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:39 INFO - Running setup.py (path:/tmp/pip-rBFWZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:39 INFO - Running setup.py (path:/tmp/pip-Y5adjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:39 INFO - Running setup.py (path:/tmp/pip-EpeqcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:39 INFO - Running setup.py (path:/tmp/pip-rz6grE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:39 INFO - Running setup.py (path:/tmp/pip-BigjTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:39 INFO - Running setup.py (path:/tmp/pip-1dSBU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:39 INFO - Running setup.py (path:/tmp/pip-g3S4m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:39 INFO - Running setup.py (path:/tmp/pip-itO5m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:39 INFO - Running setup.py (path:/tmp/pip-GVkBkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:39 INFO - Running setup.py (path:/tmp/pip-MoGZAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:40 INFO - Running setup.py (path:/tmp/pip-pkvM63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:40 INFO - Running setup.py (path:/tmp/pip-01Rb1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:40 INFO - Running setup.py (path:/tmp/pip-PTpK1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:40 INFO - Running setup.py (path:/tmp/pip-N8bMrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:40 INFO - Running setup.py (path:/tmp/pip-iOUJEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:40 INFO - Running setup.py (path:/tmp/pip-Ewy2p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:40 INFO - Running setup.py (path:/tmp/pip-5LQuZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:40 INFO - Running setup.py install for manifestparser 14:11:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozcrash 14:11:40 INFO - Running setup.py install for mozdebug 14:11:40 INFO - Running setup.py install for mozdevice 14:11:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozfile 14:11:41 INFO - Running setup.py install for mozhttpd 14:11:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozinfo 14:11:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozInstall 14:11:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozleak 14:11:41 INFO - Running setup.py install for mozlog 14:11:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for moznetwork 14:11:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozprocess 14:11:41 INFO - Running setup.py install for mozprofile 14:11:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozrunner 14:11:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozscreenshot 14:11:42 INFO - Running setup.py install for moztest 14:11:42 INFO - Running setup.py install for mozversion 14:11:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:42 INFO - Cleaning up... 14:11:42 INFO - Return code: 0 14:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:42 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')]} 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 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')]} 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:42 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 14:11:42 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 14:11:42 INFO - Using env: {'DISPLAY': ':0', 14:11:42 INFO - 'HOME': '/home/cltbld', 14:11:42 INFO - 'LANG': 'en_US.UTF-8', 14:11:42 INFO - 'LANGUAGE': 'en_US:en', 14:11:42 INFO - 'LOGNAME': 'cltbld', 14:11:42 INFO - 'MAIL': '/var/mail/cltbld', 14:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:42 INFO - 'MOZ_NO_REMOTE': '1', 14:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:42 INFO - 'NO_EM_RESTART': '1', 14:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:42 INFO - 'PWD': '/builds/slave/test', 14:11:42 INFO - 'SHELL': '/bin/bash', 14:11:42 INFO - 'SHLVL': '1', 14:11:42 INFO - 'TERM': 'linux', 14:11:42 INFO - 'TMOUT': '86400', 14:11:42 INFO - 'USER': 'cltbld', 14:11:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:42 INFO - '_': '/tools/buildbot/bin/python'} 14:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:42 INFO - Running setup.py (path:/tmp/pip-FddZSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:42 INFO - Running setup.py (path:/tmp/pip-BpL_L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:42 INFO - Running setup.py (path:/tmp/pip-Ml1Qj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:42 INFO - Running setup.py (path:/tmp/pip-sxmFP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:42 INFO - Running setup.py (path:/tmp/pip-WMeRGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:42 INFO - Running setup.py (path:/tmp/pip-nQ3Iae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:42 INFO - Running setup.py (path:/tmp/pip-hnmj24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:43 INFO - Running setup.py (path:/tmp/pip-6ncu9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:43 INFO - Running setup.py (path:/tmp/pip-mJMqoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:43 INFO - Running setup.py (path:/tmp/pip-p01ypq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:43 INFO - Running setup.py (path:/tmp/pip-xepMcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:43 INFO - Running setup.py (path:/tmp/pip-2DfuEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:43 INFO - Running setup.py (path:/tmp/pip-A4DGNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:43 INFO - Running setup.py (path:/tmp/pip-c0TMPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:43 INFO - Running setup.py (path:/tmp/pip-YMYUHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:43 INFO - Running setup.py (path:/tmp/pip-QO_e_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:43 INFO - Running setup.py (path:/tmp/pip-Wmdu2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:43 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)) 14:11:43 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)) 14:11:43 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)) 14:11:43 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)) 14:11:43 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)) 14:11:43 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)) 14:11:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:45 INFO - Downloading blessings-1.6.tar.gz 14:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:45 INFO - Installing collected packages: blessings 14:11:45 INFO - Running setup.py install for blessings 14:11:45 INFO - Successfully installed blessings 14:11:45 INFO - Cleaning up... 14:11:46 INFO - Return code: 0 14:11:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:46 INFO - Reading from file tmpfile_stdout 14:11:46 INFO - Current package versions: 14:11:46 INFO - argparse == 1.2.1 14:11:46 INFO - blessings == 1.6 14:11:46 INFO - blobuploader == 1.2.4 14:11:46 INFO - docopt == 0.6.1 14:11:46 INFO - functools32 == 3.2.3-2 14:11:46 INFO - jsonschema == 2.5.1 14:11:46 INFO - manifestparser == 1.1 14:11:46 INFO - mozInstall == 1.12 14:11:46 INFO - mozcrash == 1.0 14:11:46 INFO - mozdebug == 0.1 14:11:46 INFO - mozdevice == 0.49 14:11:46 INFO - mozfile == 1.2 14:11:46 INFO - mozhttpd == 0.7 14:11:46 INFO - mozinfo == 0.9 14:11:46 INFO - mozleak == 0.1 14:11:46 INFO - mozlog == 3.4 14:11:46 INFO - moznetwork == 0.27 14:11:46 INFO - mozprocess == 0.23 14:11:46 INFO - mozprofile == 0.28 14:11:46 INFO - mozrunner == 6.13 14:11:46 INFO - mozscreenshot == 0.1 14:11:46 INFO - mozsystemmonitor == 0.3 14:11:46 INFO - moztest == 0.7 14:11:46 INFO - mozversion == 1.4 14:11:46 INFO - psutil == 3.1.1 14:11:46 INFO - requests == 1.2.3 14:11:46 INFO - wsgiref == 0.1.2 14:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:46 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')]} 14:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 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')]} 14:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:46 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 14:11:46 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 14:11:46 INFO - Using env: {'DISPLAY': ':0', 14:11:46 INFO - 'HOME': '/home/cltbld', 14:11:46 INFO - 'LANG': 'en_US.UTF-8', 14:11:46 INFO - 'LANGUAGE': 'en_US:en', 14:11:46 INFO - 'LOGNAME': 'cltbld', 14:11:46 INFO - 'MAIL': '/var/mail/cltbld', 14:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:46 INFO - 'MOZ_NO_REMOTE': '1', 14:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:46 INFO - 'NO_EM_RESTART': '1', 14:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:46 INFO - 'PWD': '/builds/slave/test', 14:11:46 INFO - 'SHELL': '/bin/bash', 14:11:46 INFO - 'SHLVL': '1', 14:11:46 INFO - 'TERM': 'linux', 14:11:46 INFO - 'TMOUT': '86400', 14:11:46 INFO - 'USER': 'cltbld', 14:11:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:46 INFO - '_': '/tools/buildbot/bin/python'} 14:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 INFO - Cleaning up... 14:11:46 INFO - Return code: 0 14:11:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:46 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')]} 14:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 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')]} 14:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 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 0x15861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', '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 14:11:46 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 14:11:46 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 14:11:46 INFO - Using env: {'DISPLAY': ':0', 14:11:46 INFO - 'HOME': '/home/cltbld', 14:11:46 INFO - 'LANG': 'en_US.UTF-8', 14:11:46 INFO - 'LANGUAGE': 'en_US:en', 14:11:46 INFO - 'LOGNAME': 'cltbld', 14:11:46 INFO - 'MAIL': '/var/mail/cltbld', 14:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:46 INFO - 'MOZ_NO_REMOTE': '1', 14:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:46 INFO - 'NO_EM_RESTART': '1', 14:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:46 INFO - 'PWD': '/builds/slave/test', 14:11:46 INFO - 'SHELL': '/bin/bash', 14:11:46 INFO - 'SHLVL': '1', 14:11:46 INFO - 'TERM': 'linux', 14:11:46 INFO - 'TMOUT': '86400', 14:11:46 INFO - 'USER': 'cltbld', 14:11:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:46 INFO - '_': '/tools/buildbot/bin/python'} 14:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:46 INFO - Cleaning up... 14:11:46 INFO - Return code: 0 14:11:46 INFO - Running post-action listener: _resource_record_post_action 14:11:46 INFO - Running post-action listener: _start_resource_monitoring 14:11:46 INFO - Starting resource monitoring. 14:11:46 INFO - [mozharness: 2016-12-28 22:11:46.780756Z] Finished create-virtualenv step (success) 14:11:46 INFO - [mozharness: 2016-12-28 22:11:46.781330Z] Running install step. 14:11:46 INFO - Running pre-action listener: _resource_record_pre_action 14:11:46 INFO - Running main action method: install 14:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:46 INFO - Reading from file tmpfile_stdout 14:11:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:47 INFO - Reading from file tmpfile_stdout 14:11:47 INFO - Output received: 14:11:47 INFO - Usage: mozinstall [options] installer 14:11:47 INFO - Options: 14:11:47 INFO - -h, --help show this help message and exit 14:11:47 INFO - -d DEST, --destination=DEST 14:11:47 INFO - Directory to install application into. [default: 14:11:47 INFO - "/builds/slave/test"] 14:11:47 INFO - --app=APP Application being installed. [default: firefox] 14:11:47 INFO - mkdir: /builds/slave/test/build/application 14:11:47 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'] 14:11:47 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 14:12:03 INFO - Reading from file tmpfile_stdout 14:12:03 INFO - Output received: 14:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 14:12:03 INFO - Running post-action listener: _resource_record_post_action 14:12:03 INFO - [mozharness: 2016-12-28 22:12:03.211340Z] Finished install step (success) 14:12:03 INFO - [mozharness: 2016-12-28 22:12:03.211587Z] Running run-tests step. 14:12:03 INFO - Running pre-action listener: _resource_record_pre_action 14:12:03 INFO - Running main action method: run_tests 14:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:03 INFO - Python 2.7.3 14:12:03 INFO - Return code: 0 14:12:03 INFO - grabbing minidump binary from tooltool 14:12:03 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')]} 14:12:03 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 0x18f53f0>, '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 0x18f5cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f61a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:03 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 14:12:03 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 14:12:03 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 14:12:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:03 INFO - Return code: 0 14:12:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:12:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:12:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:03 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/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 14:12:03 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/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 14:12:03 INFO - Using env: {'DISPLAY': ':0', 14:12:03 INFO - 'HOME': '/home/cltbld', 14:12:03 INFO - 'LANG': 'en_US.UTF-8', 14:12:03 INFO - 'LANGUAGE': 'en_US:en', 14:12:03 INFO - 'LOGNAME': 'cltbld', 14:12:03 INFO - 'MAIL': '/var/mail/cltbld', 14:12:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:03 INFO - 'MOZ_NO_REMOTE': '1', 14:12:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:03 INFO - 'NO_EM_RESTART': '1', 14:12:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:03 INFO - 'PWD': '/builds/slave/test', 14:12:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:03 INFO - 'SHELL': '/bin/bash', 14:12:03 INFO - 'SHLVL': '1', 14:12:03 INFO - 'TERM': 'linux', 14:12:03 INFO - 'TMOUT': '86400', 14:12:03 INFO - 'USER': 'cltbld', 14:12:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470', 14:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:03 INFO - '_': '/tools/buildbot/bin/python'} 14:12:03 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/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 14:12:03 INFO - mozversion application_buildid: 20161228121037 14:12:03 INFO - mozversion application_changeset: 96716340bdf33caec3bb939fc76fd837d1a3d197 14:12:03 INFO - mozversion application_display_name: Nightly 14:12:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:03 INFO - mozversion application_name: Firefox 14:12:03 INFO - mozversion application_remotingname: firefox 14:12:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:12:03 INFO - mozversion application_vendor: Mozilla 14:12:03 INFO - mozversion application_version: 53.0a1 14:12:03 INFO - mozversion platform_buildid: 20161228121037 14:12:03 INFO - mozversion platform_changeset: 96716340bdf33caec3bb939fc76fd837d1a3d197 14:12:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:12:03 INFO - mozversion platform_version: 53.0a1 14:12:03 INFO - using testdate: 1482963123 14:12:03 INFO - actual date: 1482963123 14:12:03 INFO - starting webserver on 'localhost:34951' 14:12:03 INFO - SUITE-START | Running 2 tests 14:12:03 INFO - TEST-START | dromaeo_css 14:12:03 INFO - operating with platform_type : linux_ 14:12:03 INFO - Initialising browser for dromaeo_css test... 14:12:03 INFO - TEST-INFO | started process 29477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC6BmN5/profile http://localhost:34951/getInfo.html) 14:12:04 INFO - PROCESS | 29477 | 1482963124025 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:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < 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 14:12:07 INFO - PROCESS | 29477 | __metrics Screen width/height:1600/1200 14:12:07 INFO - PROCESS | 29477 | colorDepth:24 14:12:07 INFO - PROCESS | 29477 | Browser inner width/height: 1024/697 14:12:07 INFO - PROCESS | 29477 | __metrics 14:12:08 ERROR - PROCESS | 29477 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 14:12:09 INFO - TEST-INFO | 29477: exit 0 14:12:09 INFO - Browser initialized. 14:12:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:09 INFO - TEST-INFO | started process 29599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC6BmN5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:21 INFO - PROCESS | 29599 | RSS: Main: 157777920 14:12:21 INFO - PROCESS | 29599 | 14:15:24 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34951/tests/dromaeo/cssquery-ext.html) 14:15:26 INFO - PROCESS | 29599 | RSS: Main: 165859328 14:15:26 INFO - PROCESS | 29599 | 14:17:09 INFO - PROCESS | 29599 | ************************* 14:17:09 INFO - PROCESS | 29599 | A coding exception was thrown and uncaught in a Task. 14:17:09 INFO - PROCESS | 29599 | 14:17:09 INFO - PROCESS | 29599 | Full message: ReferenceError: fetch is not defined 14:17:09 INFO - PROCESS | 29599 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:17:09 INFO - PROCESS | 29599 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:17:09 INFO - PROCESS | 29599 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:17:09 INFO - PROCESS | 29599 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:17:09 INFO - PROCESS | 29599 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:17:09 INFO - PROCESS | 29599 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:17:09 INFO - PROCESS | 29599 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:17:09 INFO - PROCESS | 29599 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:17:09 INFO - PROCESS | 29599 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:17:09 INFO - PROCESS | 29599 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:17:09 INFO - PROCESS | 29599 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:17:09 INFO - PROCESS | 29599 | 14:17:09 INFO - PROCESS | 29599 | ************************* 14:18:29 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-ext.html (next: http://localhost:34951/tests/dromaeo/cssquery-jquery.html) 14:18:30 INFO - PROCESS | 29599 | RSS: Main: 162054144 14:18:30 INFO - PROCESS | 29599 | 14:21:32 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34951/tests/dromaeo/cssquery-mootools.html) 14:21:32 INFO - PROCESS | 29599 | RSS: Main: 167763968 14:21:32 INFO - PROCESS | 29599 | 14:24:34 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34951/tests/dromaeo/cssquery-prototype.html) 14:24:35 INFO - PROCESS | 29599 | RSS: Main: 162889728 14:24:35 INFO - PROCESS | 29599 | 14:27:38 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34951/tests/dromaeo/cssquery-yui.html) 14:27:39 INFO - PROCESS | 29599 | RSS: Main: 165859328 14:27:39 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | Cycle 1(1): loaded http://localhost:34951/tests/dromaeo/cssquery-yui.html (next: http://localhost:34951/tests/dromaeo/cssquery-dojo.html) 14:30:42 INFO - PROCESS | 29599 | RSS: Main: 167718912 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | __start_tp_report 14:30:42 INFO - PROCESS | 29599 | _x_x_mozilla_page_load 14:30:42 INFO - PROCESS | 29599 | _x_x_mozilla_page_load_details 14:30:42 INFO - PROCESS | 29599 | |i|pagename|runs| 14:30:42 INFO - PROCESS | 29599 | |0;dojo.html;2611.856347900866;2624.0815714499927;2631.44739604683;2653.535631264529;2666.973330266697;4764.475907650156;4833.130036593408;4865.148598995175;4870;4872.561469467747;4785.856424307268;4813.927791083137;4832.951670483294;4841.467438581753;4918.926216106761;4416.955830441687;4482.618977386926;4512.842050528232;4590.770461476929;4627.8611641650805;4145.419641250227;4598.655100867449;4601.493835678073;4617.792199351037;4618.930716039262;4380.34294855771;4448.911021779579;4462.0183559616835;4531.886702832423;4574.085182963404;4414.867553973386;4422.64618830496;4454.8886277842985;4470.664700147469;4586.633069354443;4447.8443254486265;4491.191585514606;4497.280435130396;4509.301058335963;4547.522510136421;4847.534033025188;4889.071076495455;4902.044101400228;4910.631702622318;4959.925601115986;5114.181730923035;5142.845714628567;5161.1742121260795;5168.198929165986;5173.430922598511;5267.236250743621;5267.920981185247;5269.552088072518;5273.525382715574;5318.335208098988;4885.60915126789;4899;4910.140725373046;4913;4957.652964292465;5175.430702622709;5210.5831533477985;5211.530962213419;5247;5356.517913387814;5034.974825125924;5048.419431765321;5055.924161137512;5060.5951523878;5073.315102461194;5063.746812659352;5134.229865520202;5137;5140.717260550631;5156.948430515647;5046.77289521965;5048.873778155502;5051.4695956924725;5056.519630635084;5059.645824792303;5105.15764898795;5105.412877519058;5147.150720131136;5151.922721159186;5260.0531904257605;4508.797104130322;4524.5701658342405;4535.047639995638;4562.634989200856;4574.839880604163;3894.162755007687;3899.064224586079;3904.492415985904;3905.5508616508896;3941.921161576752;4342.044750155024;4382.452193475816;4419.911601767946;4483.977580112079;4514.932276015862;5199.2201169824075;5211.895762084813;5272.261883336336;5331.786728530816;5334.91997620036;4420.734755914591;4460.286354183315;4461.598456138898;4463.330500424897;4517.11916176349;4673.065386922561;4683;4690.718556886598;4711.175544279738;4734.479207287196;4803.279508073817;4834.154023045882;4859.246816743411;4862.319275301531;4911.950880491292;5211.1922651989;5220.921686174786;5224.2947202127225;5234.764435600483;5250.527452529291;4728.976355118202;4845.2732090185345;4860.076585448895;4868.537488938545;4874.95125048745;5034.546890779848;5045.394552653705;5125.308083408841;5151.815082530964;5226.059309324358;5240.606954478506;5257.369115706139;5257.579393648422;5257.816991176955;5268.288781014514;5017.096922553976;5019.84940451787;5024;5052.924206136984;5059.089363914531;4935.481774413634;4945.8021679132435;4958.950410495849;4968.3292755479;5015.1223535880345;4940.580050695731;4973.35346404965;4989.426215985208;4998.60011199096;5018.8707540803025;4946.08497427977;5063.645544811828;5117.692938423706;5132.178851383761;5146.9227961581355;4890.975545122252;4893.314935909047;4897.755112244445;4932;4984.352034235526 14:30:42 INFO - PROCESS | 29599 | |1;ext.html;518.42972729997;530.7452422837038;541.8699512117093;546.9671819690816;553.5820455556054;34590.65409345909;38454;38499;38545.22909541807;38552.22895542091;38153.23693526128;38729.41905871414;38731.41902871459;38785.80607096961;38805;7646.502977306485;7822.960885195566;7831.2168783121515;9911.157551608087;10295.948520257425;9664.420134791935;9783.217342612574;9784.315097943147;9786.902130978706;9789.216862651007;9749.561269742842;9753.853692194623;9777.560009799541;9792.804143917117;9818.607255709763;9728.027197280215;9756.609735610567;9757.658481953169;9813.313068085272;9822.01779822012;9691.07934746198;9727.805443891153;9740.659076932274;9743.512824358824;9797.510124493818;33676.831615842006;34158.48762268568;34246.65753342459;34332.14169645754;34413;3570.626207557609;3605.513255710498;3662.853485860562;3674.3018826423163;3695.260947810422;26076.34809129768;26368.73631263701;26498;26634.06780762664;27492.862535687393;3297.1097803592897;3369.5619569456057;3376.864925402981;3386.255023894739;3403.217260030207;245810;247644;248703;248829;249449;47933.28100078501;48296.27555586669;48296.75851620719;48392.758036210296;48493.27260091101;49453.75273123611;49476;49631;49638.75180624074;49680.50319496831;11639.06887449002;11820.82268765952;11823.940880295544;11830.940845295718;11858.881411185777;8112.18878112184;8230;9721.902780972241;9735.221182305399;9852.950735246279;15789.36842526309;15811.288492017657;15921.442749503944;15936.203189840693;16088.839111608968;6344.904826427607;6581.3747693969;6641.169853768279;6656.201255849329;6699.397054265042;785.7917651822272;805.8630032894422;821.7370441458795;830.713403875674;833.9374546908884;27164.728352716615;27165.45669086607;27298.45403091927;27498;27741.722582774317;888.1961824548794;950.1970834644715;950.7765675066354;966.9323147379756;967.1585720423277;13977.86022139786;14613.342399592044;14691.263668470016;14783.482578109715;14789;361203;365201;367081;367112;368309;49518.50481495211;50291;50446.49553504418;50472.242916356285;50612;1183.8824120750305;1215.6596153077153;1228.6252692928563;1234.6542967968983;1237.1340061956666;25132.874335628207;26543.33641658974;26779.866100669373;27504;27657.170284891487;40457;41750.16499670051;41803;41873.37189942093;41970.790146049076;303928;305157;306108;306730;306988;21080.472988175417;21558.6766198504;22933.197338093087;23019.539609207386;23335.649965250876;40442.79778601088;40447.393289101274;40515.79742101271;40723.98190045272;41100.177996439306;33666;34804.65195348115;35486;35641.46537801987;35836.28327433489;34382.65617343895;34598.82700586481;35191;35263;35318;34341;34913.30173396467;35076.64923350836;35157.47263790994;35214.823925880206;29085.418291634473;31126.844365778026;31951.041468755044;31957.520637190926;31981.200469988435;23677.64483532783;24361.39096522601;24382;24470.877645611657;24653 14:30:42 INFO - PROCESS | 29599 | |2;jquery.html;370.7849447320554;370.80532720321827;382.42254196163793;391.67490982484543;396.2827282618461;15753.684926301466;16163;16337.75493367599;16500;16502.174891255418;16534.66930661386;16694;16878.83121168788;17067.91466042671;17111.05889176095;4904.730239836807;4972.726500042496;4978.477259887714;4982.17794063979;4985.127602669537;5038.269450929613;5064.037832811772;5136.691798492084;5425.511703946644;5440.292761940962;5399.9730001350135;5400.405955344929;5400.513953744162;5410.458954104578;5415.918761218585;5328.333958255218;5352.277442545265;5688.118341657029;5716.3426205986425;5752;5110.386753589593;5124.564412024983;5143.305653736735;5143.742812859342;5145.3568303962;14570.562883113524;19593.31423400174;19940.70088948667;20285.594288114302;20312.593748125102;2082.3856962196187;2111.3138230075133;2129.2760461443186;2141.218455263833;2156.320758960938;8627.352948528885;9046.411983221135;9258.037428023035;9545.04549545047;9560.28297877662;1711.5036639374566;1727.464486009341;1754.561359660085;1762.903040332781;1783.7502749615064;68014;68072;68976;69687.65156174237;70070.64964675195;9734.707958761248;9980.301378903407;10006.69979900604;10163.847542286872;10195.235357348229;13739.862601373858;13749.862501374859;13751.106178098591;13756.587302380945;13798.17210967345;6714.429273511806;6840.082709113519;6990.196127445307;7070;7106.2183159852375;6378.425941665179;6502.284748677642;6674.733010679615;6694;6742.696578653972;4179.644730197967;4254.85108021224;4268.786560671954;4348.934765978513;4368;1666;1776.387146434478;1800.8199180081888;1821;1848.1498510685235;779.1351599724302;829.6473998550592;831.3515457942814;836.9204925532065;850.8853402043343;16232.594185145466;16277.674446511004;16587.419440319532;16699.6660066798;17018.489445316412;808.7552223828468;819.4468733604793;821.37575442664;823.3865770001387;839.072824528899;9039.548022598976;9112.271018318519;9300.441973481613;9389.201917836925;9513.571889265;344890;348275;349162;357074;360484;74854;78248;78290;79242;80150.59924700456;873.7946582553095;898.285862739124;903.9186473217574;921.4379228670506;926.7729406295366;14381.92809035948;14440.566782996528;14467.85532144665;14842.851571484578;15114.924425377803;35875.82062089673;36018;36744.81627591845;37033.81483092567;38122.618773811904;46553.53446465492;49074.509254906996;49115.26327105025;49231.50768492412;49627.75186124191;5406.972965135149;5458.372287187024;7648.847023059619;7734.690612375442;7844.17636148219;10751.838722419327;10922.726931826768;11010;11713.472893719974;12056.950318446061;9919;9994.900050999397;10195.7451063724;10319.793604128026;10388.896111038794;10030.799384012133;10322.483875806029;10331.380117192992;10646.148308135176;10869.29349592274;9733.270004749531;10706.785864282827;10924.289921155418;10945.890541094486;11000.944995274973;7756.612169391621;7824.84350313002;7999.240072193133;8018.4787988780545;8023.959880200561;7983.32141767933;9498.572564234764;10200.489975501343;10581.841272381074;10770.138388929023 14:30:42 INFO - PROCESS | 29599 | |3;mootools.html;1256.8805963433474;1256.9120161588692;1274.2672963046246;1278.4119305119646;1303.433006642111;6591.802245932629;6796.116504854374;6951.6524173791295;7406.518576292544;7435.107787065553;6942.236354001056;7100.289971002897;7116.359527642524;7176.928230717691;7228;2110.630639638065;2196.428928478599;2197.307848027874;2197.7802219777973;2198.7251593550805;2046.7339245898013;2138.6364318065966;2147.5275439403385;2156.428546435196;2195.0232146694725;2189.6168170570168;2214.3689048621145;2215.789499997498;2217.4788924602785;2223.3441134865175;2126.36209137259;2135.4874830040835;2136.8183704385146;2138.700581918533;2140.882251476168;2162.5566758814407;2164.9567008659897;2191.254973309067;2191.8684878907156;2192.9561408771897;7253.383462405649;7372.815679607999;7408.407327413794;7430.479866409353;7445.106587209515;4478.753668548228;4598.701084429501;4607.055553611502;4639.188142075123;4641.466231383401;2637.762601365867;2803.215099772067;2806.2282872210103;2861.3848022675015;2902.956455653167;1026.481626778472;1054.2936232724094;1054.8206804843196;1082.0532034469838;1103.0238239158323;9617;9647.1317581418;9686.32195746298;9686.612535498572;9716.562754676057;3750.437434384864;3932.6264004919485;3944.290027794967;4029.6776257899296;4030.133521292936;7830.608469576612;7853.8821917671285;7856.371490280764;7857.096433910059;7882.290593846581;4525.434320709911;4527.728336299832;4564.246899261585;4566.908661826811;4569.474510431343;4030.7581545107387;4115.855945041909;4193.601607847249;4205.789710514462;4207.831686732497;3289.6052473703307;3317.336532693471;3357.0600231935096;3358.328334333143;3500.7374446916583;1011.2213595531547;1011.251673761426;1077.5797438998798;1098.763765790359;1108.467935391017;785.9842803143905;811.0915774332667;823.9382046346548;832.8792325112825;833.2292629317857;4662.533746625379;4823.252395878644;4846.61227101831;4871.902561948741;4936.308916751657;795.4590878202878;813.146196493691;838.3967780043;838.8196537744415;867.9609417576224;2995.8651860666323;3147.693707111569;3286;3291.2923721399534;3365.764396492271;8410.663573456994;8588.098249683693;8652.04827468978;8672;8695.869561956575;8660.913390866011;8738.519381434082;8758.693445729368;8760.693375731818;8781.165789250012;6567.704453299518;6684.899726504106;6690.063391125246;6720.260771315249;6751.729930802811;4490.461144662661;4642.698224615389;4836.758162091811;4855.562999330077;4976.353074100344;7693.692252309845;7792;7805.726799561988;8079.87880181786;8081.070676872235;7943.642536085775;8039.356851451753;8059.677612895419;8164.959175204086;8232.670693172206;6811.114555108003;6928.7228510859;6931.410830079298;6948.687309071003;6974.895376569254;6893.241743408322;6895.586264824126;6926.792196234121;6960.8955865663065;6962.756303529352;6242.438180563589;6329.7151628175925;6333.556651034383;6346.682665866781;6392.968035159794;6230.968845155745;6236.719347629459;6238.563300569098;6263.874722505616;6272;5474;5517.337919449692;5520.06158952987;5536.889262214814;5538.861528461821;3911.7457365271166;3981.7810020449156;4022.557518672885;4047.2917239483563;4164.583541645811;3874;3926.077371817678;4036.8990775230855;4045.676345892263;4088.8160032798 14:30:42 INFO - PROCESS | 29599 | |4;prototype.html;348.9755717099803;356.8715262505496;360.2920261685788;361.3802329005756;361.7305107694768;4877.170880950238;4888.706677599346;4923.950760492394;4951.925721114178;4968.42863070747;4845.345878306428;4852.927206091911;4859.246816743402;4861.878453038676;4895.877603059926;3657.2502636959493;3805.5052843130356;3823.7896915669626;3837.2901013312485;3978.244133614611;3830.8276127574327;3842.289176502342;3846;3856.325143099946;3859.8070096495203;3801.657850793428;3820.083180036785;3825.464434979105;3841.4621952926614;3850.152966347399;3739.5886452490204;3800.1449673823167;3853.7687738735767;3861.8841434757;3863.9374172102616;3314.6188188358165;3319.535265062893;3322.352141332441;3334.933301333984;3340.5323254744353;4755.2153894607345;4775.2598347256235;4791.586481987822;4822.348982887301;4823.541763532458;4333.6598236952;4336.848210312624;4352.477702675667;4369.279068953619;4387.319965405367;4977.303177555145;5116.897662046738;5148.742562871879;5151.7681704323395;5187.144121220032;3666.651668091554;3667.174885650734;3676.7058635309377;3684.207895302496;3684.2631473705364;5232.587201455585;5382.273393091921;5425.7829686812875;5444.156155795858;5444.455554444564;3720.9069773255887;3729.1422972716427;3738.345789486829;3751.531058617673;3751.9437208441896;3754.6433088856515;3770.6417890300377;3790.7346485745734;3798.9620103798607;3803.839828852171;4321;4339.175556644227;4379.386885835986;4380.3210502372185;4397.142557201315;5098.745062746848;5164.690118592896;5185.688858668492;5200.479952004769;5211.322528071327;1241.6895776055985;1252.4927404401233;1252.680566455548;1255.736295377981;1258.6601617563206;854.7905763088083;875.7066382761719;882.7395918204145;887.5917078144126;891.839468895605;4240.703150779415;4307.7261281426345;4333.241682705514;4378.868633940987;4401.557135789603;5112.590992720573;5139.8458046258675;5158.432572417031;5161.793528258828;5168.431472538018;4192.853250136231;4284;4284.335927931175;4333.851529344726;4348.652107831429;2672.839629622229;2731.3581308392513;2734.589811528247;2743.885689742157;2754.9586756198673;4782.378290822171;4815.807367705253;4866.197077482247;4869.610431165569;4887.535684110004;5124.5213052531235;5174.922376164361;5312.123499622597;5314.73426328682;5350.843002628468;4758.571728544517;4758.928616070762;4765.475797662254;4770.189067858403;4822.614190864792;5091.770870310771;5122.79508819658;5133.614978876524;5204.63567550283;5221.503957124067;4857.708537487762;5051.722155281494;5073.822416215415;5119.948800512097;5137.486251374982;4779.340143360196;4792.784324705327;4801.4718380977365;4801.855944321676;4837;3669.229461813049;3678.172411207564;3694.9516648765416;3707.9443808342357;3713.85144594224;5327.920081198863;5335.599830012842;5335.758981227816;5349.652272602269;5352.330958630171;4945.332380128781;5141.53726164647;5154.5824898153305;5158.4583618721;5177.301064356414;5095.796168153232;5122.923156152586;5132.563732082665;5144.434112247575;5153.845384638467;5087.694738315713;5094.108531006985;5111.233315002779;5117.283580298836;5121.385433747974;5062.746862656926;5180.274761533313;5188.143956247328;5197.22041693749;5208.401033881;5016.698998060128;5037.395512538519;5051.646384753032;5056.519630635084;5070.188769796815 14:30:42 INFO - PROCESS | 29599 | |5;yui.html;565.5786439102869;569.9458551437615;696.8780263775321;732.9267073292672;752.7440670172142;11612.24520406173;12322.383880805946;12404.81392779109;12499.812502812465;12515.374231288444;12115.575954841583;12508.186967847107;12555.937220313908;12568;12791.552295669653;784.6312233250363;784.9803754906144;786.0371045469311;791.9208079192092;796.8485987662355;788.2157253532743;817.1093508076225;817.3502065857657;817.5299202958294;818.0224631565281;866.3415803988951;866.9653213871437;868.2923417414818;870.7735988642967;871.6426265231256;865.5109862927426;865.5888452984844;866.7053201911349;867.0808942520916;868.1362044765435;638.8913884639622;639.4500729372736;641.041642744096;641.3810672700866;642.9807105786834;13145.408456619474;13291.800622990662;13320.733585328238;13345.66635834112;14299.07056041354;10773.35359878402;11398.316101033965;11453.484593193327;11511.136664750176;11718.941405292919;11647.385331595848;11692.112022495927;11903.16677832552;11906.523739050428;11944.283342999448;4206.348016057516;4209.284421648327;4246.108317253381;4247.405363249148;4258.53156152823;65987.67006164939;66738.66630666865;67446;67864.66067669679;68173.65913170452;9492.288078394147;9644.324897257125;9674.613015479303;9749.902500975042;9849.803003940024;16774.0774257417;16814.075225862696;16904.239309231114;17024.063676497663;17080.145992700564;6158.168647232566;6159.722812473449;6182.69086545671;6376.84057898547;6406.5515413920575;3559.9110022249133;3578.874739384109;3651.543557055368;3665.743397962117;3689.2990331836863;2506.1729629222677;2534.7085085215435;2556.872156392173;2565.4997275531464;2567.6405303257557;458.8394062078246;464.66079761774097;465.07218099890935;471.7263986887597;471.8631596836879;521.3587287636228;538.0166974128467;540.4730387871872;542.4304480295752;548.8655279456559;7023.438124949992;7456.403487721078;7771.242833996494;7774.533527988338;7823.2567906048835;529.208832794974;531.9069162896556;537.8278950735805;538.2276433318123;564.2749067448309;3640.2719456108885;3705.481232627434;3720.534933133358;3765.0963768695865;3801.904952376213;54118.45881541213;60819.69590152021;69098;72537.27462725305;72820.27179728136;48685;52247.47752522426;54504.727476362365;54984.725076374365;58366.12450813241;47463;49024.264636030486;49776.50223497791;49983.25025124626;50063.49936500588;7996.760097197093;8019.318357939407;8154.429189956883;8276.627551760306;8610.48337099751;32191;32817.50773738348;33333.333333333685;34865.65134348624;35515.28969420546;41465.58534414617;47725;49419;50101.74949125231;50298.24552631786;10363.170946324426;10417.583296668048;10470.528826202686;10600.826830499574;10792.838107428552;12242.204256723284;12655;12714.809277860655;12892.29092399927;13681;11630.709232268922;11789.646310610695;12236.694082648006;12529.436175372313;12729.936350318188;10532.157427405942;11024.614138505114;11226.214165008698;11429.371384573928;11458.255213411101;11423.828642570534;11630.88369116298;12268.202566833485;12313.630591082281;12549.811752823898;9577.808443830945;10232;10305.690829274834;10367.63713270032;10442.477876106317;8902.465852048897;9064.74820143885;9141.817163656557;9784.315097943361;9815.607375704893 14:30:42 INFO - PROCESS | 29599 | __end_tp_report 14:30:42 INFO - PROCESS | 29599 | __start_cc_report 14:30:42 INFO - PROCESS | 29599 | _x_x_mozilla_cycle_collect,337 14:30:42 INFO - PROCESS | 29599 | __end_cc_report 14:30:42 INFO - PROCESS | 29599 | __startTimestamp1482964242609__endTimestamp 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | ------- Summary: start ------- 14:30:42 INFO - PROCESS | 29599 | Number of tests: 6 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#0] dojo.html Cycles:165 Average:4796.05 Median:4910.63 stddev:500.25 (10.2%) stddev-sans-first:471.52 14:30:42 INFO - PROCESS | 29599 | Values: 2611.9 2624.1 2631.4 2653.5 2667.0 4764.5 4833.1 4865.1 4870.0 4872.6 4785.9 4813.9 4833.0 4841.5 4918.9 4417.0 4482.6 4512.8 4590.8 4627.9 4145.4 4598.7 4601.5 4617.8 4618.9 4380.3 4448.9 4462.0 4531.9 4574.1 4414.9 4422.6 4454.9 4470.7 4586.6 4447.8 4491.2 4497.3 4509.3 4547.5 4847.5 4889.1 4902.0 4910.6 4959.9 5114.2 5142.8 5161.2 5168.2 5173.4 5267.2 5267.9 5269.6 5273.5 5318.3 4885.6 4899.0 4910.1 4913.0 4957.7 5175.4 5210.6 5211.5 5247.0 5356.5 5035.0 5048.4 5055.9 5060.6 5073.3 5063.7 5134.2 5137.0 5140.7 5156.9 5046.8 5048.9 5051.5 5056.5 5059.6 5105.2 5105.4 5147.2 5151.9 5260.1 4508.8 4524.6 4535.0 4562.6 4574.8 3894.2 3899.1 3904.5 3905.6 3941.9 4342.0 4382.5 4419.9 4484.0 4514.9 5199.2 5211.9 5272.3 5331.8 5334.9 4420.7 4460.3 4461.6 4463.3 4517.1 4673.1 4683.0 4690.7 4711.2 4734.5 4803.3 4834.2 4859.2 4862.3 4912.0 5211.2 5220.9 5224.3 5234.8 5250.5 4729.0 4845.3 4860.1 4868.5 4875.0 5034.5 5045.4 5125.3 5151.8 5226.1 5240.6 5257.4 5257.6 5257.8 5268.3 5017.1 5019.8 5024.0 5052.9 5059.1 4935.5 4945.8 4959.0 4968.3 5015.1 4940.6 4973.4 4989.4 4998.6 5018.9 4946.1 5063.6 5117.7 5132.2 5146.9 4891.0 4893.3 4897.8 4932.0 4984.4 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#1] ext.html Cycles:180 Average:45566.86 Median:184431.93 stddev:81539.69 (44.2%) stddev-sans-first:81698.28 14:30:42 INFO - PROCESS | 29599 | Values: 518.4 530.7 541.9 547.0 553.6 34590.7 38454.0 38499.0 38545.2 38552.2 38153.2 38729.4 38731.4 38785.8 38805.0 7646.5 7823.0 7831.2 9911.2 10295.9 9664.4 9783.2 9784.3 9786.9 9789.2 9749.6 9753.9 9777.6 9792.8 9818.6 9728.0 9756.6 9757.7 9813.3 9822.0 9691.1 9727.8 9740.7 9743.5 9797.5 33676.8 34158.5 34246.7 34332.1 34413.0 3570.6 3605.5 3662.9 3674.3 3695.3 26076.3 26368.7 26498.0 26634.1 27492.9 3297.1 3369.6 3376.9 3386.3 3403.2 245810.0 247644.0 248703.0 248829.0 249449.0 47933.3 48296.3 48296.8 48392.8 48493.3 49453.8 49476.0 49631.0 49638.8 49680.5 11639.1 11820.8 11823.9 11830.9 11858.9 8112.2 8230.0 9721.9 9735.2 9853.0 15789.4 15811.3 15921.4 15936.2 16088.8 6344.9 6581.4 6641.2 6656.2 6699.4 785.8 805.9 821.7 830.7 833.9 27164.7 27165.5 27298.5 27498.0 27741.7 888.2 950.2 950.8 966.9 967.2 13977.9 14613.3 14691.3 14783.5 14789.0 361203.0 365201.0 367081.0 367112.0 368309.0 49518.5 50291.0 50446.5 50472.2 50612.0 1183.9 1215.7 1228.6 1234.7 1237.1 25132.9 26543.3 26779.9 27504.0 27657.2 40457.0 41750.2 41803.0 41873.4 41970.8 303928.0 305157.0 306108.0 306730.0 306988.0 21080.5 21558.7 22933.2 23019.5 23335.6 40442.8 40447.4 40515.8 40724.0 41100.2 33666.0 34804.7 35486.0 35641.5 35836.3 34382.7 34598.8 35191.0 35263.0 35318.0 34341.0 34913.3 35076.6 35157.5 35214.8 29085.4 31126.8 31951.0 31957.5 31981.2 23677.6 24361.4 24382.0 24470.9 24653.0 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#2] jquery.html Cycles:180 Average:23053.02 Median:49094.89 stddev:58417.31 (119.0%) stddev-sans-first:58556.36 14:30:42 INFO - PROCESS | 29599 | Values: 370.8 370.8 382.4 391.7 396.3 15753.7 16163.0 16337.8 16500.0 16502.2 16534.7 16694.0 16878.8 17067.9 17111.1 4904.7 4972.7 4978.5 4982.2 4985.1 5038.3 5064.0 5136.7 5425.5 5440.3 5400.0 5400.4 5400.5 5410.5 5415.9 5328.3 5352.3 5688.1 5716.3 5752.0 5110.4 5124.6 5143.3 5143.7 5145.4 14570.6 19593.3 19940.7 20285.6 20312.6 2082.4 2111.3 2129.3 2141.2 2156.3 8627.4 9046.4 9258.0 9545.0 9560.3 1711.5 1727.5 1754.6 1762.9 1783.8 68014.0 68072.0 68976.0 69687.7 70070.6 9734.7 9980.3 10006.7 10163.8 10195.2 13739.9 13749.9 13751.1 13756.6 13798.2 6714.4 6840.1 6990.2 7070.0 7106.2 6378.4 6502.3 6674.7 6694.0 6742.7 4179.6 4254.9 4268.8 4348.9 4368.0 1666.0 1776.4 1800.8 1821.0 1848.1 779.1 829.6 831.4 836.9 850.9 16232.6 16277.7 16587.4 16699.7 17018.5 808.8 819.4 821.4 823.4 839.1 9039.5 9112.3 9300.4 9389.2 9513.6 344890.0 348275.0 349162.0 357074.0 360484.0 74854.0 78248.0 78290.0 79242.0 80150.6 873.8 898.3 903.9 921.4 926.8 14381.9 14440.6 14467.9 14842.9 15114.9 35875.8 36018.0 36744.8 37033.8 38122.6 46553.5 49074.5 49115.3 49231.5 49627.8 5407.0 5458.4 7648.8 7734.7 7844.2 10751.8 10922.7 11010.0 11713.5 12057.0 9919.0 9994.9 10195.7 10319.8 10388.9 10030.8 10322.5 10331.4 10646.1 10869.3 9733.3 10706.8 10924.3 10945.9 11000.9 7756.6 7824.8 7999.2 8018.5 8024.0 7983.3 9498.6 10200.5 10581.8 10770.1 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#3] mootools.html Cycles:180 Average:4753.41 Median:4851.09 stddev:2566.64 (52.9%) stddev-sans-first:2560.39 14:30:42 INFO - PROCESS | 29599 | Values: 1256.9 1256.9 1274.3 1278.4 1303.4 6591.8 6796.1 6951.7 7406.5 7435.1 6942.2 7100.3 7116.4 7176.9 7228.0 2110.6 2196.4 2197.3 2197.8 2198.7 2046.7 2138.6 2147.5 2156.4 2195.0 2189.6 2214.4 2215.8 2217.5 2223.3 2126.4 2135.5 2136.8 2138.7 2140.9 2162.6 2165.0 2191.3 2191.9 2193.0 7253.4 7372.8 7408.4 7430.5 7445.1 4478.8 4598.7 4607.1 4639.2 4641.5 2637.8 2803.2 2806.2 2861.4 2903.0 1026.5 1054.3 1054.8 1082.1 1103.0 9617.0 9647.1 9686.3 9686.6 9716.6 3750.4 3932.6 3944.3 4029.7 4030.1 7830.6 7853.9 7856.4 7857.1 7882.3 4525.4 4527.7 4564.2 4566.9 4569.5 4030.8 4115.9 4193.6 4205.8 4207.8 3289.6 3317.3 3357.1 3358.3 3500.7 1011.2 1011.3 1077.6 1098.8 1108.5 786.0 811.1 823.9 832.9 833.2 4662.5 4823.3 4846.6 4871.9 4936.3 795.5 813.1 838.4 838.8 868.0 2995.9 3147.7 3286.0 3291.3 3365.8 8410.7 8588.1 8652.0 8672.0 8695.9 8660.9 8738.5 8758.7 8760.7 8781.2 6567.7 6684.9 6690.1 6720.3 6751.7 4490.5 4642.7 4836.8 4855.6 4976.4 7693.7 7792.0 7805.7 8079.9 8081.1 7943.6 8039.4 8059.7 8165.0 8232.7 6811.1 6928.7 6931.4 6948.7 6974.9 6893.2 6895.6 6926.8 6960.9 6962.8 6242.4 6329.7 6333.6 6346.7 6393.0 6231.0 6236.7 6238.6 6263.9 6272.0 5474.0 5517.3 5520.1 5536.9 5538.9 3911.7 3981.8 4022.6 4047.3 4164.6 3874.0 3926.1 4036.9 4045.7 4088.8 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#4] prototype.html Cycles:180 Average:4230.01 Median:4801.66 stddev:1225.12 (25.5%) stddev-sans-first:1193.42 14:30:42 INFO - PROCESS | 29599 | Values: 349.0 356.9 360.3 361.4 361.7 4877.2 4888.7 4924.0 4951.9 4968.4 4845.3 4852.9 4859.2 4861.9 4895.9 3657.3 3805.5 3823.8 3837.3 3978.2 3830.8 3842.3 3846.0 3856.3 3859.8 3801.7 3820.1 3825.5 3841.5 3850.2 3739.6 3800.1 3853.8 3861.9 3863.9 3314.6 3319.5 3322.4 3334.9 3340.5 4755.2 4775.3 4791.6 4822.3 4823.5 4333.7 4336.8 4352.5 4369.3 4387.3 4977.3 5116.9 5148.7 5151.8 5187.1 3666.7 3667.2 3676.7 3684.2 3684.3 5232.6 5382.3 5425.8 5444.2 5444.5 3720.9 3729.1 3738.3 3751.5 3751.9 3754.6 3770.6 3790.7 3799.0 3803.8 4321.0 4339.2 4379.4 4380.3 4397.1 5098.7 5164.7 5185.7 5200.5 5211.3 1241.7 1252.5 1252.7 1255.7 1258.7 854.8 875.7 882.7 887.6 891.8 4240.7 4307.7 4333.2 4378.9 4401.6 5112.6 5139.8 5158.4 5161.8 5168.4 4192.9 4284.0 4284.3 4333.9 4348.7 2672.8 2731.4 2734.6 2743.9 2755.0 4782.4 4815.8 4866.2 4869.6 4887.5 5124.5 5174.9 5312.1 5314.7 5350.8 4758.6 4758.9 4765.5 4770.2 4822.6 5091.8 5122.8 5133.6 5204.6 5221.5 4857.7 5051.7 5073.8 5119.9 5137.5 4779.3 4792.8 4801.5 4801.9 4837.0 3669.2 3678.2 3695.0 3707.9 3713.9 5327.9 5335.6 5335.8 5349.7 5352.3 4945.3 5141.5 5154.6 5158.5 5177.3 5095.8 5122.9 5132.6 5144.4 5153.8 5087.7 5094.1 5111.2 5117.3 5121.4 5062.7 5180.3 5188.1 5197.2 5208.4 5016.7 5037.4 5051.6 5056.5 5070.2 14:30:42 INFO - PROCESS | 29599 | 14:30:42 INFO - PROCESS | 29599 | [#5] yui.html Cycles:180 Average:14620.67 Median:47594.00 stddev:18480.75 (38.8%) stddev-sans-first:18502.45 14:30:42 INFO - PROCESS | 29599 | Values: 565.6 569.9 696.9 732.9 752.7 11612.2 12322.4 12404.8 12499.8 12515.4 12115.6 12508.2 12555.9 12568.0 12791.6 784.6 785.0 786.0 791.9 796.8 788.2 817.1 817.4 817.5 818.0 866.3 867.0 868.3 870.8 871.6 865.5 865.6 866.7 867.1 868.1 638.9 639.5 641.0 641.4 643.0 13145.4 13291.8 13320.7 13345.7 14299.1 10773.4 11398.3 11453.5 11511.1 11718.9 11647.4 11692.1 11903.2 11906.5 11944.3 4206.3 4209.3 4246.1 4247.4 4258.5 65987.7 66738.7 67446.0 67864.7 68173.7 9492.3 9644.3 9674.6 9749.9 9849.8 16774.1 16814.1 16904.2 17024.1 17080.1 6158.2 6159.7 6182.7 6376.8 6406.6 3559.9 3578.9 3651.5 3665.7 3689.3 2506.2 2534.7 2556.9 2565.5 2567.6 458.8 464.7 465.1 471.7 471.9 521.4 538.0 540.5 542.4 548.9 7023.4 7456.4 7771.2 7774.5 7823.3 529.2 531.9 537.8 538.2 564.3 3640.3 3705.5 3720.5 3765.1 3801.9 54118.5 60819.7 69098.0 72537.3 72820.3 48685.0 52247.5 54504.7 54984.7 58366.1 47463.0 49024.3 49776.5 49983.3 50063.5 7996.8 8019.3 8154.4 8276.6 8610.5 32191.0 32817.5 33333.3 34865.7 35515.3 41465.6 47725.0 49419.0 50101.7 50298.2 10363.2 10417.6 10470.5 10600.8 10792.8 12242.2 12655.0 12714.8 12892.3 13681.0 11630.7 11789.6 12236.7 12529.4 12729.9 10532.2 11024.6 11226.2 11429.4 11458.3 11423.8 11630.9 12268.2 12313.6 12549.8 9577.8 10232.0 10305.7 10367.6 10442.5 8902.5 9064.7 9141.8 9784.3 9815.6 14:30:42 INFO - PROCESS | 29599 | -------- Summary: end -------- 14:30:42 INFO - PROCESS | 29599 | 14:30:43 INFO - TEST-INFO | 29599: exit 0 14:30:43 INFO - TEST-OK | dromaeo_css | took 1120046ms 14:30:43 INFO - TEST-START | kraken 14:30:43 INFO - operating with platform_type : linux_ 14:30:43 INFO - Initialising browser for kraken test... 14:30:43 INFO - TEST-INFO | started process 29957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbPOnQO/profile http://localhost:34951/getInfo.html) 14:30:44 INFO - PROCESS | 29957 | 1482964244016 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:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < 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 14:30:47 INFO - PROCESS | 29957 | __metrics Screen width/height:1600/1200 14:30:47 INFO - PROCESS | 29957 | colorDepth:24 14:30:47 INFO - PROCESS | 29957 | Browser inner width/height: 1024/697 14:30:47 INFO - PROCESS | 29957 | __metrics 14:30:48 ERROR - PROCESS | 29957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 14:30:49 INFO - TEST-INFO | 29957: exit 0 14:30:49 INFO - Browser initialized. 14:30:49 INFO - Running cycle 1/1 for kraken test... 14:30:49 INFO - TEST-INFO | started process 30080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbPOnQO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:01 INFO - PROCESS | 30080 | RSS: Main: 158072832 14:31:01 INFO - PROCESS | 30080 | 14:31:04 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34951/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:05 INFO - PROCESS | 30080 | RSS: Main: 164302848 14:31:05 INFO - PROCESS | 30080 | 14:31:07 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34951/tests/kraken/driver.html?testName=audio-dft) 14:31:08 INFO - PROCESS | 30080 | RSS: Main: 162754560 14:31:08 INFO - PROCESS | 30080 | 14:31:11 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34951/tests/kraken/driver.html?testName=audio-fft) 14:31:12 INFO - PROCESS | 30080 | RSS: Main: 159723520 14:31:12 INFO - PROCESS | 30080 | 14:31:14 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34951/tests/kraken/driver.html?testName=audio-oscillator) 14:31:14 INFO - PROCESS | 30080 | RSS: Main: 160272384 14:31:14 INFO - PROCESS | 30080 | 14:31:17 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34951/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:17 INFO - PROCESS | 30080 | RSS: Main: 160784384 14:31:17 INFO - PROCESS | 30080 | 14:31:20 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34951/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:21 INFO - PROCESS | 30080 | RSS: Main: 165277696 14:31:21 INFO - PROCESS | 30080 | 14:31:24 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34951/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:25 INFO - PROCESS | 30080 | RSS: Main: 162000896 14:31:25 INFO - PROCESS | 30080 | 14:31:28 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34951/tests/kraken/driver.html?testName=json-parse-financial) 14:31:29 INFO - PROCESS | 30080 | RSS: Main: 162447360 14:31:29 INFO - PROCESS | 30080 | 14:31:30 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34951/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:31 INFO - PROCESS | 30080 | RSS: Main: 162234368 14:31:31 INFO - PROCESS | 30080 | 14:31:33 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:34 INFO - PROCESS | 30080 | RSS: Main: 162856960 14:31:34 INFO - PROCESS | 30080 | 14:31:36 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:36 INFO - PROCESS | 30080 | RSS: Main: 162246656 14:31:36 INFO - PROCESS | 30080 | 14:31:39 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:40 INFO - PROCESS | 30080 | RSS: Main: 163827712 14:31:40 INFO - PROCESS | 30080 | 14:31:43 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:44 INFO - PROCESS | 30080 | RSS: Main: 162619392 14:31:44 INFO - PROCESS | 30080 | 14:31:45 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:34951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34951/tests/kraken/driver.html?testName=ai-astar) 14:31:46 INFO - PROCESS | 30080 | RSS: Main: 164753408 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | __start_tp_report 14:31:46 INFO - PROCESS | 30080 | _x_x_mozilla_page_load 14:31:46 INFO - PROCESS | 30080 | _x_x_mozilla_page_load_details 14:31:46 INFO - PROCESS | 30080 | |i|pagename|runs| 14:31:46 INFO - PROCESS | 30080 | |0;ai-astar;107;115;116;116;119;116;117;115;118;116 14:31:46 INFO - PROCESS | 30080 | |1;audio-beat-detection;156;128;131;176;129;128;134;128;149;132 14:31:46 INFO - PROCESS | 30080 | |2;audio-dft;164;165;165;171;164;163;165;165;166;163 14:31:46 INFO - PROCESS | 30080 | |3;audio-fft;78;78;77;113;77;76;76;76;97;78 14:31:46 INFO - PROCESS | 30080 | |4;audio-oscillator;87;87;112;85;87;85;106;86;86;100 14:31:46 INFO - PROCESS | 30080 | |5;imaging-gaussian-blur;118;119;118;119;117;122;118;119;119;118 14:31:46 INFO - PROCESS | 30080 | |6;imaging-darkroom;155;154;150;151;150;151;150;151;155;152 14:31:46 INFO - PROCESS | 30080 | |7;imaging-desaturate;97;98;97;97;97;97;96;96;101;96 14:31:46 INFO - PROCESS | 30080 | |8;json-parse-financial;70;75;72;70;71;72;71;71;70;74 14:31:46 INFO - PROCESS | 30080 | |9;json-stringify-tinderbox;68;69;68;68;70;69;68;69;68;68 14:31:46 INFO - PROCESS | 30080 | |10;stanford-crypto-aes;88;86;85;85;86;88;86;85;83;84 14:31:46 INFO - PROCESS | 30080 | |11;stanford-crypto-ccm;147;134;146;135;139;150;134;145;189;139 14:31:46 INFO - PROCESS | 30080 | |12;stanford-crypto-pbkdf2;180;182;174;176;177;194;180;186;179;176 14:31:46 INFO - PROCESS | 30080 | |13;stanford-crypto-sha256-iterative;74;71;71;76;73;69;70;68;70;68 14:31:46 INFO - PROCESS | 30080 | __end_tp_report 14:31:46 INFO - PROCESS | 30080 | __start_cc_report 14:31:46 INFO - PROCESS | 30080 | _x_x_mozilla_cycle_collect,772 14:31:46 INFO - PROCESS | 30080 | __end_cc_report 14:31:46 INFO - PROCESS | 30080 | __startTimestamp1482964306218__endTimestamp 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | ------- Summary: start ------- 14:31:46 INFO - PROCESS | 30080 | Number of tests: 14 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:3.24 (2.8%) stddev-sans-first:1.33 14:31:46 INFO - PROCESS | 30080 | Values: 107.0 115.0 116.0 116.0 119.0 116.0 117.0 115.0 118.0 116.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:133.00 stddev:16.19 (12.2%) stddev-sans-first:15.97 14:31:46 INFO - PROCESS | 30080 | Values: 156.0 128.0 131.0 176.0 129.0 128.0 134.0 128.0 149.0 132.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.28 (1.4%) stddev-sans-first:2.39 14:31:46 INFO - PROCESS | 30080 | Values: 164.0 165.0 165.0 171.0 164.0 163.0 165.0 165.0 166.0 163.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.50 stddev:12.42 (16.0%) stddev-sans-first:13.06 14:31:46 INFO - PROCESS | 30080 | Values: 78.0 78.0 77.0 113.0 77.0 76.0 76.0 76.0 97.0 78.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:86.00 stddev:10.03 (11.7%) stddev-sans-first:10.46 14:31:46 INFO - PROCESS | 30080 | Values: 87.0 87.0 112.0 85.0 87.0 85.0 106.0 86.0 86.0 100.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:1.34 (1.1%) stddev-sans-first:1.39 14:31:46 INFO - PROCESS | 30080 | Values: 118.0 119.0 118.0 119.0 117.0 122.0 118.0 119.0 119.0 118.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.50 stddev:2.02 (1.3%) stddev-sans-first:1.81 14:31:46 INFO - PROCESS | 30080 | Values: 155.0 154.0 150.0 151.0 150.0 151.0 150.0 151.0 155.0 152.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:1.48 (1.5%) stddev-sans-first:1.56 14:31:46 INFO - PROCESS | 30080 | Values: 97.0 98.0 97.0 97.0 97.0 97.0 96.0 96.0 101.0 96.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.50 stddev:1.71 (2.4%) stddev-sans-first:1.72 14:31:46 INFO - PROCESS | 30080 | Values: 70.0 75.0 72.0 70.0 71.0 72.0 71.0 71.0 70.0 74.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 14:31:46 INFO - PROCESS | 30080 | Values: 68.0 69.0 68.0 68.0 70.0 69.0 68.0 69.0 68.0 68.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.41 14:31:46 INFO - PROCESS | 30080 | Values: 88.0 86.0 85.0 85.0 86.0 88.0 86.0 85.0 83.0 84.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:145.50 stddev:16.24 (11.2%) stddev-sans-first:17.22 14:31:46 INFO - PROCESS | 30080 | Values: 147.0 134.0 146.0 135.0 139.0 150.0 134.0 145.0 189.0 139.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.00 stddev:5.89 (3.3%) stddev-sans-first:6.25 14:31:46 INFO - PROCESS | 30080 | Values: 180.0 182.0 174.0 176.0 177.0 194.0 180.0 186.0 179.0 176.0 14:31:46 INFO - PROCESS | 30080 | 14:31:46 INFO - PROCESS | 30080 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.62 (3.7%) stddev-sans-first:2.55 14:31:46 INFO - PROCESS | 30080 | Values: 74.0 71.0 71.0 76.0 73.0 69.0 70.0 68.0 70.0 68.0 14:31:46 INFO - PROCESS | 30080 | -------- Summary: end -------- 14:31:46 INFO - PROCESS | 30080 | 14:31:47 INFO - TEST-INFO | 30080: exit 0 14:31:47 INFO - TEST-OK | kraken | took 63888ms 14:31:47 INFO - SUITE-END | took 1183s 14:31:47 INFO - Completed test suite (00:19:44) 14:31:47 INFO - javascript benchmark 14:31:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6277.635564895815, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.856347900866, 2624.0815714499927, 2631.44739604683, 2653.535631264529, 2666.973330266697, 4764.475907650156, 4833.130036593408, 4865.148598995175, 4870.0, 4872.561469467747, 4785.856424307268, 4813.927791083137, 4832.951670483294, 4841.467438581753, 4918.926216106761, 4416.955830441687, 4482.618977386926, 4512.842050528232, 4590.770461476929, 4627.8611641650805, 4145.419641250227, 4598.655100867449, 4601.493835678073, 4617.792199351037, 4618.930716039262, 4380.34294855771, 4448.911021779579, 4462.0183559616835, 4531.886702832423, 4574.085182963404, 4414.867553973386, 4422.64618830496, 4454.8886277842985, 4470.664700147469, 4586.633069354443, 4447.8443254486265, 4491.191585514606, 4497.280435130396, 4509.301058335963, 4547.522510136421, 4847.534033025188, 4889.071076495455, 4902.044101400228, 4910.631702622318, 4959.925601115986, 5114.181730923035, 5142.845714628567, 5161.1742121260795, 5168.198929165986, 5173.430922598511, 5267.236250743621, 5267.920981185247, 5269.552088072518, 5273.525382715574, 5318.335208098988, 4885.60915126789, 4899.0, 4910.140725373046, 4913.0, 4957.652964292465, 5175.430702622709, 5210.5831533477985, 5211.530962213419, 5247.0, 5356.517913387814, 5034.974825125924, 5048.419431765321, 5055.924161137512, 5060.5951523878, 5073.315102461194, 5063.746812659352, 5134.229865520202, 5137.0, 5140.717260550631, 5156.948430515647, 5046.77289521965, 5048.873778155502, 5051.4695956924725, 5056.519630635084, 5059.645824792303, 5105.15764898795, 5105.412877519058, 5147.150720131136, 5151.922721159186, 5260.0531904257605, 4508.797104130322, 4524.5701658342405, 4535.047639995638, 4562.634989200856, 4574.839880604163, 3894.162755007687, 3899.064224586079, 3904.492415985904, 3905.5508616508896, 3941.921161576752, 4342.044750155024, 4382.452193475816, 4419.911601767946, 4483.977580112079, 4514.932276015862, 5199.2201169824075, 5211.895762084813, 5272.261883336336, 5331.786728530816, 5334.91997620036, 4420.734755914591, 4460.286354183315, 4461.598456138898, 4463.330500424897, 4517.11916176349, 4673.065386922561, 4683.0, 4690.718556886598, 4711.175544279738, 4734.479207287196, 4803.279508073817, 4834.154023045882, 4859.246816743411, 4862.319275301531, 4911.950880491292, 5211.1922651989, 5220.921686174786, 5224.2947202127225, 5234.764435600483, 5250.527452529291, 4728.976355118202, 4845.2732090185345, 4860.076585448895, 4868.537488938545, 4874.95125048745, 5034.546890779848, 5045.394552653705, 5125.308083408841, 5151.815082530964, 5226.059309324358, 5240.606954478506, 5257.369115706139, 5257.579393648422, 5257.816991176955, 5268.288781014514, 5017.096922553976, 5019.84940451787, 5024.0, 5052.924206136984, 5059.089363914531, 4935.481774413634, 4945.8021679132435, 4958.950410495849, 4968.3292755479, 5015.1223535880345, 4940.580050695731, 4973.35346404965, 4989.426215985208, 4998.60011199096, 5018.8707540803025, 4946.08497427977, 5063.645544811828, 5117.692938423706, 5132.178851383761, 5146.9227961581355, 4890.975545122252, 4893.314935909047, 4897.755112244445, 4932.0, 4984.352034235526], "value": 4763.593284982315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.42972729997, 530.7452422837038, 541.8699512117093, 546.9671819690816, 553.5820455556054, 34590.65409345909, 38454.0, 38499.0, 38545.22909541807, 38552.22895542091, 38153.23693526128, 38729.41905871414, 38731.41902871459, 38785.80607096961, 38805.0, 7646.502977306485, 7822.960885195566, 7831.2168783121515, 9911.157551608087, 10295.948520257425, 9664.420134791935, 9783.217342612574, 9784.315097943147, 9786.902130978706, 9789.216862651007, 9749.561269742842, 9753.853692194623, 9777.560009799541, 9792.804143917117, 9818.607255709763, 9728.027197280215, 9756.609735610567, 9757.658481953169, 9813.313068085272, 9822.01779822012, 9691.07934746198, 9727.805443891153, 9740.659076932274, 9743.512824358824, 9797.510124493818, 33676.831615842006, 34158.48762268568, 34246.65753342459, 34332.14169645754, 34413.0, 3570.626207557609, 3605.513255710498, 3662.853485860562, 3674.3018826423163, 3695.260947810422, 26076.34809129768, 26368.73631263701, 26498.0, 26634.06780762664, 27492.862535687393, 3297.1097803592897, 3369.5619569456057, 3376.864925402981, 3386.255023894739, 3403.217260030207, 245810.0, 247644.0, 248703.0, 248829.0, 249449.0, 47933.28100078501, 48296.27555586669, 48296.75851620719, 48392.758036210296, 48493.27260091101, 49453.75273123611, 49476.0, 49631.0, 49638.75180624074, 49680.50319496831, 11639.06887449002, 11820.82268765952, 11823.940880295544, 11830.940845295718, 11858.881411185777, 8112.18878112184, 8230.0, 9721.902780972241, 9735.221182305399, 9852.950735246279, 15789.36842526309, 15811.288492017657, 15921.442749503944, 15936.203189840693, 16088.839111608968, 6344.904826427607, 6581.3747693969, 6641.169853768279, 6656.201255849329, 6699.397054265042, 785.7917651822272, 805.8630032894422, 821.7370441458795, 830.713403875674, 833.9374546908884, 27164.728352716615, 27165.45669086607, 27298.45403091927, 27498.0, 27741.722582774317, 888.1961824548794, 950.1970834644715, 950.7765675066354, 966.9323147379756, 967.1585720423277, 13977.86022139786, 14613.342399592044, 14691.263668470016, 14783.482578109715, 14789.0, 361203.0, 365201.0, 367081.0, 367112.0, 368309.0, 49518.50481495211, 50291.0, 50446.49553504418, 50472.242916356285, 50612.0, 1183.8824120750305, 1215.6596153077153, 1228.6252692928563, 1234.6542967968983, 1237.1340061956666, 25132.874335628207, 26543.33641658974, 26779.866100669373, 27504.0, 27657.170284891487, 40457.0, 41750.16499670051, 41803.0, 41873.37189942093, 41970.790146049076, 303928.0, 305157.0, 306108.0, 306730.0, 306988.0, 21080.472988175417, 21558.6766198504, 22933.197338093087, 23019.539609207386, 23335.649965250876, 40442.79778601088, 40447.393289101274, 40515.79742101271, 40723.98190045272, 41100.177996439306, 33666.0, 34804.65195348115, 35486.0, 35641.46537801987, 35836.28327433489, 34382.65617343895, 34598.82700586481, 35191.0, 35263.0, 35318.0, 34341.0, 34913.30173396467, 35076.64923350836, 35157.47263790994, 35214.823925880206, 29085.418291634473, 31126.844365778026, 31951.041468755044, 31957.520637190926, 31981.200469988435, 23677.64483532783, 24361.39096522601, 24382.0, 24470.877645611657, 24653.0], "value": 17232.885075156417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.7849447320554, 370.80532720321827, 382.42254196163793, 391.67490982484543, 396.2827282618461, 15753.684926301466, 16163.0, 16337.75493367599, 16500.0, 16502.174891255418, 16534.66930661386, 16694.0, 16878.83121168788, 17067.91466042671, 17111.05889176095, 4904.730239836807, 4972.726500042496, 4978.477259887714, 4982.17794063979, 4985.127602669537, 5038.269450929613, 5064.037832811772, 5136.691798492084, 5425.511703946644, 5440.292761940962, 5399.9730001350135, 5400.405955344929, 5400.513953744162, 5410.458954104578, 5415.918761218585, 5328.333958255218, 5352.277442545265, 5688.118341657029, 5716.3426205986425, 5752.0, 5110.386753589593, 5124.564412024983, 5143.305653736735, 5143.742812859342, 5145.3568303962, 14570.562883113524, 19593.31423400174, 19940.70088948667, 20285.594288114302, 20312.593748125102, 2082.3856962196187, 2111.3138230075133, 2129.2760461443186, 2141.218455263833, 2156.320758960938, 8627.352948528885, 9046.411983221135, 9258.037428023035, 9545.04549545047, 9560.28297877662, 1711.5036639374566, 1727.464486009341, 1754.561359660085, 1762.903040332781, 1783.7502749615064, 68014.0, 68072.0, 68976.0, 69687.65156174237, 70070.64964675195, 9734.707958761248, 9980.301378903407, 10006.69979900604, 10163.847542286872, 10195.235357348229, 13739.862601373858, 13749.862501374859, 13751.106178098591, 13756.587302380945, 13798.17210967345, 6714.429273511806, 6840.082709113519, 6990.196127445307, 7070.0, 7106.2183159852375, 6378.425941665179, 6502.284748677642, 6674.733010679615, 6694.0, 6742.696578653972, 4179.644730197967, 4254.85108021224, 4268.786560671954, 4348.934765978513, 4368.0, 1666.0, 1776.387146434478, 1800.8199180081888, 1821.0, 1848.1498510685235, 779.1351599724302, 829.6473998550592, 831.3515457942814, 836.9204925532065, 850.8853402043343, 16232.594185145466, 16277.674446511004, 16587.419440319532, 16699.6660066798, 17018.489445316412, 808.7552223828468, 819.4468733604793, 821.37575442664, 823.3865770001387, 839.072824528899, 9039.548022598976, 9112.271018318519, 9300.441973481613, 9389.201917836925, 9513.571889265, 344890.0, 348275.0, 349162.0, 357074.0, 360484.0, 74854.0, 78248.0, 78290.0, 79242.0, 80150.59924700456, 873.7946582553095, 898.285862739124, 903.9186473217574, 921.4379228670506, 926.7729406295366, 14381.92809035948, 14440.566782996528, 14467.85532144665, 14842.851571484578, 15114.924425377803, 35875.82062089673, 36018.0, 36744.81627591845, 37033.81483092567, 38122.618773811904, 46553.53446465492, 49074.509254906996, 49115.26327105025, 49231.50768492412, 49627.75186124191, 5406.972965135149, 5458.372287187024, 7648.847023059619, 7734.690612375442, 7844.17636148219, 10751.838722419327, 10922.726931826768, 11010.0, 11713.472893719974, 12056.950318446061, 9919.0, 9994.900050999397, 10195.7451063724, 10319.793604128026, 10388.896111038794, 10030.799384012133, 10322.483875806029, 10331.380117192992, 10646.148308135176, 10869.29349592274, 9733.270004749531, 10706.785864282827, 10924.289921155418, 10945.890541094486, 11000.944995274973, 7756.612169391621, 7824.84350313002, 7999.240072193133, 8018.4787988780545, 8023.959880200561, 7983.32141767933, 9498.572564234764, 10200.489975501343, 10581.841272381074, 10770.138388929023], "value": 8056.966210502779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.8805963433474, 1256.9120161588692, 1274.2672963046246, 1278.4119305119646, 1303.433006642111, 6591.802245932629, 6796.116504854374, 6951.6524173791295, 7406.518576292544, 7435.107787065553, 6942.236354001056, 7100.289971002897, 7116.359527642524, 7176.928230717691, 7228.0, 2110.630639638065, 2196.428928478599, 2197.307848027874, 2197.7802219777973, 2198.7251593550805, 2046.7339245898013, 2138.6364318065966, 2147.5275439403385, 2156.428546435196, 2195.0232146694725, 2189.6168170570168, 2214.3689048621145, 2215.789499997498, 2217.4788924602785, 2223.3441134865175, 2126.36209137259, 2135.4874830040835, 2136.8183704385146, 2138.700581918533, 2140.882251476168, 2162.5566758814407, 2164.9567008659897, 2191.254973309067, 2191.8684878907156, 2192.9561408771897, 7253.383462405649, 7372.815679607999, 7408.407327413794, 7430.479866409353, 7445.106587209515, 4478.753668548228, 4598.701084429501, 4607.055553611502, 4639.188142075123, 4641.466231383401, 2637.762601365867, 2803.215099772067, 2806.2282872210103, 2861.3848022675015, 2902.956455653167, 1026.481626778472, 1054.2936232724094, 1054.8206804843196, 1082.0532034469838, 1103.0238239158323, 9617.0, 9647.1317581418, 9686.32195746298, 9686.612535498572, 9716.562754676057, 3750.437434384864, 3932.6264004919485, 3944.290027794967, 4029.6776257899296, 4030.133521292936, 7830.608469576612, 7853.8821917671285, 7856.371490280764, 7857.096433910059, 7882.290593846581, 4525.434320709911, 4527.728336299832, 4564.246899261585, 4566.908661826811, 4569.474510431343, 4030.7581545107387, 4115.855945041909, 4193.601607847249, 4205.789710514462, 4207.831686732497, 3289.6052473703307, 3317.336532693471, 3357.0600231935096, 3358.328334333143, 3500.7374446916583, 1011.2213595531547, 1011.251673761426, 1077.5797438998798, 1098.763765790359, 1108.467935391017, 785.9842803143905, 811.0915774332667, 823.9382046346548, 832.8792325112825, 833.2292629317857, 4662.533746625379, 4823.252395878644, 4846.61227101831, 4871.902561948741, 4936.308916751657, 795.4590878202878, 813.146196493691, 838.3967780043, 838.8196537744415, 867.9609417576224, 2995.8651860666323, 3147.693707111569, 3286.0, 3291.2923721399534, 3365.764396492271, 8410.663573456994, 8588.098249683693, 8652.04827468978, 8672.0, 8695.869561956575, 8660.913390866011, 8738.519381434082, 8758.693445729368, 8760.693375731818, 8781.165789250012, 6567.704453299518, 6684.899726504106, 6690.063391125246, 6720.260771315249, 6751.729930802811, 4490.461144662661, 4642.698224615389, 4836.758162091811, 4855.562999330077, 4976.353074100344, 7693.692252309845, 7792.0, 7805.726799561988, 8079.87880181786, 8081.070676872235, 7943.642536085775, 8039.356851451753, 8059.677612895419, 8164.959175204086, 8232.670693172206, 6811.114555108003, 6928.7228510859, 6931.410830079298, 6948.687309071003, 6974.895376569254, 6893.241743408322, 6895.586264824126, 6926.792196234121, 6960.8955865663065, 6962.756303529352, 6242.438180563589, 6329.7151628175925, 6333.556651034383, 6346.682665866781, 6392.968035159794, 6230.968845155745, 6236.719347629459, 6238.563300569098, 6263.874722505616, 6272.0, 5474.0, 5517.337919449692, 5520.06158952987, 5536.889262214814, 5538.861528461821, 3911.7457365271166, 3981.7810020449156, 4022.557518672885, 4047.2917239483563, 4164.583541645811, 3874.0, 3926.077371817678, 4036.8990775230855, 4045.676345892263, 4088.8160032798], "value": 3887.8345431124053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9755717099803, 356.8715262505496, 360.2920261685788, 361.3802329005756, 361.7305107694768, 4877.170880950238, 4888.706677599346, 4923.950760492394, 4951.925721114178, 4968.42863070747, 4845.345878306428, 4852.927206091911, 4859.246816743402, 4861.878453038676, 4895.877603059926, 3657.2502636959493, 3805.5052843130356, 3823.7896915669626, 3837.2901013312485, 3978.244133614611, 3830.8276127574327, 3842.289176502342, 3846.0, 3856.325143099946, 3859.8070096495203, 3801.657850793428, 3820.083180036785, 3825.464434979105, 3841.4621952926614, 3850.152966347399, 3739.5886452490204, 3800.1449673823167, 3853.7687738735767, 3861.8841434757, 3863.9374172102616, 3314.6188188358165, 3319.535265062893, 3322.352141332441, 3334.933301333984, 3340.5323254744353, 4755.2153894607345, 4775.2598347256235, 4791.586481987822, 4822.348982887301, 4823.541763532458, 4333.6598236952, 4336.848210312624, 4352.477702675667, 4369.279068953619, 4387.319965405367, 4977.303177555145, 5116.897662046738, 5148.742562871879, 5151.7681704323395, 5187.144121220032, 3666.651668091554, 3667.174885650734, 3676.7058635309377, 3684.207895302496, 3684.2631473705364, 5232.587201455585, 5382.273393091921, 5425.7829686812875, 5444.156155795858, 5444.455554444564, 3720.9069773255887, 3729.1422972716427, 3738.345789486829, 3751.531058617673, 3751.9437208441896, 3754.6433088856515, 3770.6417890300377, 3790.7346485745734, 3798.9620103798607, 3803.839828852171, 4321.0, 4339.175556644227, 4379.386885835986, 4380.3210502372185, 4397.142557201315, 5098.745062746848, 5164.690118592896, 5185.688858668492, 5200.479952004769, 5211.322528071327, 1241.6895776055985, 1252.4927404401233, 1252.680566455548, 1255.736295377981, 1258.6601617563206, 854.7905763088083, 875.7066382761719, 882.7395918204145, 887.5917078144126, 891.839468895605, 4240.703150779415, 4307.7261281426345, 4333.241682705514, 4378.868633940987, 4401.557135789603, 5112.590992720573, 5139.8458046258675, 5158.432572417031, 5161.793528258828, 5168.431472538018, 4192.853250136231, 4284.0, 4284.335927931175, 4333.851529344726, 4348.652107831429, 2672.839629622229, 2731.3581308392513, 2734.589811528247, 2743.885689742157, 2754.9586756198673, 4782.378290822171, 4815.807367705253, 4866.197077482247, 4869.610431165569, 4887.535684110004, 5124.5213052531235, 5174.922376164361, 5312.123499622597, 5314.73426328682, 5350.843002628468, 4758.571728544517, 4758.928616070762, 4765.475797662254, 4770.189067858403, 4822.614190864792, 5091.770870310771, 5122.79508819658, 5133.614978876524, 5204.63567550283, 5221.503957124067, 4857.708537487762, 5051.722155281494, 5073.822416215415, 5119.948800512097, 5137.486251374982, 4779.340143360196, 4792.784324705327, 4801.4718380977365, 4801.855944321676, 4837.0, 3669.229461813049, 3678.172411207564, 3694.9516648765416, 3707.9443808342357, 3713.85144594224, 5327.920081198863, 5335.599830012842, 5335.758981227816, 5349.652272602269, 5352.330958630171, 4945.332380128781, 5141.53726164647, 5154.5824898153305, 5158.4583618721, 5177.301064356414, 5095.796168153232, 5122.923156152586, 5132.563732082665, 5144.434112247575, 5153.845384638467, 5087.694738315713, 5094.108531006985, 5111.233315002779, 5117.283580298836, 5121.385433747974, 5062.746862656926, 5180.274761533313, 5188.143956247328, 5197.22041693749, 5208.401033881, 5016.698998060128, 5037.395512538519, 5051.646384753032, 5056.519630635084, 5070.188769796815], "value": 3854.7663504622687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5786439102869, 569.9458551437615, 696.8780263775321, 732.9267073292672, 752.7440670172142, 11612.24520406173, 12322.383880805946, 12404.81392779109, 12499.812502812465, 12515.374231288444, 12115.575954841583, 12508.186967847107, 12555.937220313908, 12568.0, 12791.552295669653, 784.6312233250363, 784.9803754906144, 786.0371045469311, 791.9208079192092, 796.8485987662355, 788.2157253532743, 817.1093508076225, 817.3502065857657, 817.5299202958294, 818.0224631565281, 866.3415803988951, 866.9653213871437, 868.2923417414818, 870.7735988642967, 871.6426265231256, 865.5109862927426, 865.5888452984844, 866.7053201911349, 867.0808942520916, 868.1362044765435, 638.8913884639622, 639.4500729372736, 641.041642744096, 641.3810672700866, 642.9807105786834, 13145.408456619474, 13291.800622990662, 13320.733585328238, 13345.66635834112, 14299.07056041354, 10773.35359878402, 11398.316101033965, 11453.484593193327, 11511.136664750176, 11718.941405292919, 11647.385331595848, 11692.112022495927, 11903.16677832552, 11906.523739050428, 11944.283342999448, 4206.348016057516, 4209.284421648327, 4246.108317253381, 4247.405363249148, 4258.53156152823, 65987.67006164939, 66738.66630666865, 67446.0, 67864.66067669679, 68173.65913170452, 9492.288078394147, 9644.324897257125, 9674.613015479303, 9749.902500975042, 9849.803003940024, 16774.0774257417, 16814.075225862696, 16904.239309231114, 17024.063676497663, 17080.145992700564, 6158.168647232566, 6159.722812473449, 6182.69086545671, 6376.84057898547, 6406.5515413920575, 3559.9110022249133, 3578.874739384109, 3651.543557055368, 3665.743397962117, 3689.2990331836863, 2506.1729629222677, 2534.7085085215435, 2556.872156392173, 2565.4997275531464, 2567.6405303257557, 458.8394062078246, 464.66079761774097, 465.07218099890935, 471.7263986887597, 471.8631596836879, 521.3587287636228, 538.0166974128467, 540.4730387871872, 542.4304480295752, 548.8655279456559, 7023.438124949992, 7456.403487721078, 7771.242833996494, 7774.533527988338, 7823.2567906048835, 529.208832794974, 531.9069162896556, 537.8278950735805, 538.2276433318123, 564.2749067448309, 3640.2719456108885, 3705.481232627434, 3720.534933133358, 3765.0963768695865, 3801.904952376213, 54118.45881541213, 60819.69590152021, 69098.0, 72537.27462725305, 72820.27179728136, 48685.0, 52247.47752522426, 54504.727476362365, 54984.725076374365, 58366.12450813241, 47463.0, 49024.264636030486, 49776.50223497791, 49983.25025124626, 50063.49936500588, 7996.760097197093, 8019.318357939407, 8154.429189956883, 8276.627551760306, 8610.48337099751, 32191.0, 32817.50773738348, 33333.333333333685, 34865.65134348624, 35515.28969420546, 41465.58534414617, 47725.0, 49419.0, 50101.74949125231, 50298.24552631786, 10363.170946324426, 10417.583296668048, 10470.528826202686, 10600.826830499574, 10792.838107428552, 12242.204256723284, 12655.0, 12714.809277860655, 12892.29092399927, 13681.0, 11630.709232268922, 11789.646310610695, 12236.694082648006, 12529.436175372313, 12729.936350318188, 10532.157427405942, 11024.614138505114, 11226.214165008698, 11429.371384573928, 11458.255213411101, 11423.828642570534, 11630.88369116298, 12268.202566833485, 12313.630591082281, 12549.811752823898, 9577.808443830945, 10232.0, 10305.690829274834, 10367.63713270032, 10442.477876106317, 8902.465852048897, 9064.74820143885, 9141.817163656557, 9784.315097943361, 9815.607375704893], "value": 6173.858514887771, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 116.0, 119.0, 116.0, 117.0, 115.0, 118.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 131.0, 176.0, 129.0, 128.0, 134.0, 128.0, 149.0, 132.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 171.0, 164.0, 163.0, 165.0, 165.0, 166.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 113.0, 77.0, 76.0, 76.0, 76.0, 97.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 112.0, 85.0, 87.0, 85.0, 106.0, 86.0, 86.0, 100.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 117.0, 122.0, 118.0, 119.0, 119.0, 118.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 155.0, 152.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 101.0, 96.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 72.0, 70.0, 71.0, 72.0, 71.0, 71.0, 70.0, 74.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0, 69.0, 68.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 85.0, 86.0, 88.0, 86.0, 85.0, 83.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 134.0, 146.0, 135.0, 139.0, 150.0, 134.0, 145.0, 189.0, 139.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 174.0, 176.0, 177.0, 194.0, 180.0, 186.0, 179.0, 176.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 71.0, 76.0, 73.0, 69.0, 70.0, 68.0, 70.0, 68.0], "value": 71.0, "unit": "score"}]}]} 14:31:47 INFO - Return code: 0 14:31:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:48 ERROR - # TBPL SUCCESS # 14:31:48 INFO - Running post-action listener: _resource_record_post_action 14:31:48 INFO - [mozharness: 2016-12-28 22:31:48.015772Z] Finished run-tests step (success) 14:31:48 INFO - Running post-run listener: _resource_record_post_run 14:31:48 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399994880; Read time: 12; Write time: 252312 14:31:48 INFO - TinderboxPrint: CPU usage
13.5% 14:31:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:31:48 INFO - TinderboxPrint: I/O write bytes / time
399,994,880 / 252,312 14:31:48 INFO - TinderboxPrint: CPU idle
8,288.7 (86.5%) 14:31:48 INFO - TinderboxPrint: CPU user
1,234.2 (12.9%) 14:31:48 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110616576; Read time: 0; Write time: 60264 14:31:48 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 288845824; Read time: 0; Write time: 192048 14:31:48 INFO - Running post-run listener: _upload_blobber_files 14:31:48 INFO - Blob upload gear active. 14:31:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:48 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 14:31:48 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'] 14:31:48 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 14:31:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:49 INFO - (blobuploader) - INFO - Done attempting. 14:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:50 INFO - (blobuploader) - INFO - Done attempting. 14:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:54 INFO - (blobuploader) - INFO - Done attempting. 14:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:54 INFO - (blobuploader) - INFO - Done attempting. 14:31:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:54 INFO - Return code: 0 14:31:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c56bc15c59a52fdd10ab47bdb789fe83d3ec0c851cbdad6d5ccdd4d4a7d153612a87b94402e6622db9460955ce99a8b6d21057a347e7ffd85ca7d8125965806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84562083b8a73b0cbc40ce90f19faf7cda89df9fc6dca6e17b0bb1cfca61e1325790a08d48320f6ed34b0aedf600fae538b1a8a4ddc258003247422f2de4d068", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1b8dbf8f78780f3a0c8dc0e806d6e5a6cf82e5fa23c0033ac9bf5e3ee332f32870220d248b04475767aee114e9a68440ca1fb4c00e4590dcfa1ee2f2566516ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c03de09c1b63e7ae3191ec19ebd744cd8a6ead3afa316afc152e120e4e2b8e765b4e29e64136fbfcd99a7a6ae0240864b5fb99991ffbb8d67cb9e90b1905d5f"} 14:31:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:54 INFO - Contents: 14:31:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c56bc15c59a52fdd10ab47bdb789fe83d3ec0c851cbdad6d5ccdd4d4a7d153612a87b94402e6622db9460955ce99a8b6d21057a347e7ffd85ca7d8125965806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84562083b8a73b0cbc40ce90f19faf7cda89df9fc6dca6e17b0bb1cfca61e1325790a08d48320f6ed34b0aedf600fae538b1a8a4ddc258003247422f2de4d068", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1b8dbf8f78780f3a0c8dc0e806d6e5a6cf82e5fa23c0033ac9bf5e3ee332f32870220d248b04475767aee114e9a68440ca1fb4c00e4590dcfa1ee2f2566516ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c03de09c1b63e7ae3191ec19ebd744cd8a6ead3afa316afc152e120e4e2b8e765b4e29e64136fbfcd99a7a6ae0240864b5fb99991ffbb8d67cb9e90b1905d5f"} 14:31:54 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:54 INFO - Copying logs to upload dir... 14:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.200061 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-28 14:31:52.645907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 14:31:52.650134) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 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/7c56bc15c59a52fdd10ab47bdb789fe83d3ec0c851cbdad6d5ccdd4d4a7d153612a87b94402e6622db9460955ce99a8b6d21057a347e7ffd85ca7d8125965806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84562083b8a73b0cbc40ce90f19faf7cda89df9fc6dca6e17b0bb1cfca61e1325790a08d48320f6ed34b0aedf600fae538b1a8a4ddc258003247422f2de4d068", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1b8dbf8f78780f3a0c8dc0e806d6e5a6cf82e5fa23c0033ac9bf5e3ee332f32870220d248b04475767aee114e9a68440ca1fb4c00e4590dcfa1ee2f2566516ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c03de09c1b63e7ae3191ec19ebd744cd8a6ead3afa316afc152e120e4e2b8e765b4e29e64136fbfcd99a7a6ae0240864b5fb99991ffbb8d67cb9e90b1905d5f"} build_url:https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/dVzrWAaOQvGfsVxFcOYmRw/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/7c56bc15c59a52fdd10ab47bdb789fe83d3ec0c851cbdad6d5ccdd4d4a7d153612a87b94402e6622db9460955ce99a8b6d21057a347e7ffd85ca7d8125965806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84562083b8a73b0cbc40ce90f19faf7cda89df9fc6dca6e17b0bb1cfca61e1325790a08d48320f6ed34b0aedf600fae538b1a8a4ddc258003247422f2de4d068", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1b8dbf8f78780f3a0c8dc0e806d6e5a6cf82e5fa23c0033ac9bf5e3ee332f32870220d248b04475767aee114e9a68440ca1fb4c00e4590dcfa1ee2f2566516ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c03de09c1b63e7ae3191ec19ebd744cd8a6ead3afa316afc152e120e4e2b8e765b4e29e64136fbfcd99a7a6ae0240864b5fb99991ffbb8d67cb9e90b1905d5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 14:31:52.681805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:31:52.682208) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1482959521.701971-1575329470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 14:31:52.767276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 14:31:52.767642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 14:31:52.768091) ========= ========= Total master_lag: 0.17 =========