builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1482865837.64 results: success (0) buildid: 20161227104237 builduid: 7c1034f8b3d84143af688e91f5ed8229 revision: 545975b950e85f2acf1db2ee9b02a432829bc980 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.638997) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.639436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.639730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.678849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.679105) ========= 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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-27 11:10:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-12-27 11:10:38 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082565 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.798220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.798541) ========= 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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.865446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:37.865793) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 545975b950e85f2acf1db2ee9b02a432829bc980 --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 545975b950e85f2acf1db2ee9b02a432829bc980 --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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-27 11:10:38,818 truncating revision to first 12 chars 2016-12-27 11:10:38,818 Setting DEBUG logging. 2016-12-27 11:10:38,818 attempt 1/10 2016-12-27 11:10:38,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/545975b950e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 11:10:39,269 unpacking tar archive at: graphics-545975b950e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.750701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:38.632923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:38.633249) ========= script_repo_revision: 545975b950e85f2acf1db2ee9b02a432829bc980 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:38.633654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:38.633915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 11:10:38.648379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-27 11:10:38.648810) ========= /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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:39 INFO - MultiFileLogger online at 20161227 11:10:39 in /builds/slave/test 11:10:39 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 11:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:39 INFO - {'append_to_log': False, 11:10:39 INFO - 'base_work_dir': '/builds/slave/test', 11:10:39 INFO - 'blob_upload_branch': 'Graphics', 11:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:39 INFO - 'branch': 'Graphics', 11:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:39 INFO - 'config_files': ('talos/linux_config.py',), 11:10:39 INFO - 'default_actions': ('clobber', 11:10:39 INFO - 'read-buildbot-config', 11:10:39 INFO - 'download-and-extract', 11:10:39 INFO - 'populate-webroot', 11:10:39 INFO - 'create-virtualenv', 11:10:39 INFO - 'install', 11:10:39 INFO - 'run-tests'), 11:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:39 INFO - 'download_minidump_stackwalk': True, 11:10:39 INFO - 'download_symbols': 'ondemand', 11:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:39 INFO - 'installer_path': 'installer.exe', 11:10:39 INFO - 'log_level': 'info', 11:10:39 INFO - 'log_name': 'talos', 11:10:39 INFO - 'log_to_console': True, 11:10:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:39 INFO - 'opt_config_files': (), 11:10:39 INFO - 'pip_index': False, 11:10:39 INFO - 'sps_profile': False, 11:10:39 INFO - 'sps_profile_interval': 0, 11:10:39 INFO - 'suite': 'dromaeojs-e10s', 11:10:39 INFO - 'system_bits': '32', 11:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:39 INFO - 'title': 'talos-linux64-ix-025', 11:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:39 INFO - 'use_talos_json': True, 11:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:39 INFO - 'work_dir': 'build'} 11:10:39 INFO - [mozharness: 2016-12-27 19:10:39.702924Z] Running clobber step. 11:10:39 INFO - Running pre-action listener: _resource_record_pre_action 11:10:39 INFO - Running main action method: clobber 11:10:39 INFO - rmtree: /builds/slave/test/build 11:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:40 INFO - Running post-action listener: _resource_record_post_action 11:10:40 INFO - [mozharness: 2016-12-27 19:10:40.177783Z] Finished clobber step (success) 11:10:40 INFO - [mozharness: 2016-12-27 19:10:40.177884Z] Running read-buildbot-config step. 11:10:40 INFO - Running pre-action listener: _resource_record_pre_action 11:10:40 INFO - Running main action method: read_buildbot_config 11:10:40 INFO - Using buildbot properties: 11:10:40 INFO - { 11:10:40 INFO - "project": "", 11:10:40 INFO - "product": "firefox", 11:10:40 INFO - "script_repo_revision": "default", 11:10:40 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 11:10:40 INFO - "repository": "", 11:10:40 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 11:10:40 INFO - "buildid": "20161227104237", 11:10:40 INFO - "pgo_build": "False", 11:10:40 INFO - "basedir": "/builds/slave/test", 11:10:40 INFO - "buildnumber": 39, 11:10:40 INFO - "slavename": "talos-linux64-ix-025", 11:10:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:10:40 INFO - "platform": "ubuntu64_hw", 11:10:40 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 11:10:40 INFO - "branch": "graphics", 11:10:40 INFO - "repo_path": "projects/graphics", 11:10:40 INFO - "revision": "545975b950e85f2acf1db2ee9b02a432829bc980", 11:10:40 INFO - "stage_platform": "linux64", 11:10:40 INFO - "builduid": "7c1034f8b3d84143af688e91f5ed8229", 11:10:40 INFO - "slavebuilddir": "test" 11:10:40 INFO - } 11:10:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:10:40 INFO - Running post-action listener: _resource_record_post_action 11:10:40 INFO - [mozharness: 2016-12-27 19:10:40.180329Z] Finished read-buildbot-config step (success) 11:10:40 INFO - [mozharness: 2016-12-27 19:10:40.180419Z] Running download-and-extract step. 11:10:40 INFO - Running pre-action listener: _resource_record_pre_action 11:10:40 INFO - Running main action method: download_and_extract 11:10:40 INFO - mkdir: /builds/slave/test/build/tests 11:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:40 INFO - trying https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:10:40 INFO - Downloading https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/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 11:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/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 11:10:40 INFO - Downloaded 1361 bytes. 11:10:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:10:40 INFO - Using the following test package requirements: 11:10:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:10:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:10:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'jsshell-linux-x86_64.zip'], 11:10:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:10:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:10:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:10:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:10:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:10:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:10:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:10:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:40 INFO - Fetch https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:10:41 INFO - Expected file size: 20241804 11:10:41 INFO - Obtained file size: 20241804 11:10:45 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 11:10:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:10:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:45 INFO - Fetch https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:10:46 INFO - Expected file size: 20241804 11:10:46 INFO - Obtained file size: 20241804 11:10:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:10:50 INFO - Fetch https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:10:51 INFO - Expected file size: 14409776 11:10:51 INFO - Obtained file size: 14409776 11:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:51 INFO - trying https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:10:51 INFO - Downloading https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/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 11:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/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 11:10:52 INFO - Downloaded 55913406 bytes. 11:10:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:10:52 INFO - mkdir: /builds/slave/test/properties 11:10:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:10:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:10:52 INFO - Contents: 11:10:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:10:53 INFO - Running post-action listener: _resource_record_post_action 11:10:53 INFO - Running post-action listener: set_extra_try_arguments 11:10:53 INFO - [mozharness: 2016-12-27 19:10:53.532002Z] Finished download-and-extract step (success) 11:10:53 INFO - [mozharness: 2016-12-27 19:10:53.532302Z] Running populate-webroot step. 11:10:53 INFO - Running pre-action listener: _resource_record_pre_action 11:10:53 INFO - Running main action method: populate_webroot 11:10:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:10:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:10:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:10:53 INFO - '--tppagecycles', 11:10:53 INFO - '7'], 11:10:53 INFO - 'tests': ['tsvgm']}}, 11:10:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:10:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:10:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:10:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:10:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['damp', 'tps']}, 11:10:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'tests': ['damp', 'tps']}, 11:10:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['dromaeo_dom']}, 11:10:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:10:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['basic_compositor_video']}, 11:10:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:10:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['a11yr', 11:10:53 INFO - 'ts_paint', 11:10:53 INFO - 'tpaint', 11:10:53 INFO - 'sessionrestore', 11:10:53 INFO - 'sessionrestore_no_auto_restore', 11:10:53 INFO - 'tabpaint']}, 11:10:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['tsvgx', 11:10:53 INFO - 'tsvgr_opacity', 11:10:53 INFO - 'tart', 11:10:53 INFO - 'tscrollx', 11:10:53 INFO - 'cart', 11:10:53 INFO - 'tsvg_static']}, 11:10:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:10:53 INFO - 'tsvgr_opacity', 11:10:53 INFO - 'tart', 11:10:53 INFO - 'tscrollx', 11:10:53 INFO - 'cart', 11:10:53 INFO - 'tsvg_static']}, 11:10:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'talos_options': ['--disable-e10s'], 11:10:53 INFO - 'tests': ['tp5o']}, 11:10:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:10:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'talos_options': ['--disable-e10s', 11:10:53 INFO - '--xperf_path', 11:10:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:53 INFO - 'tests': ['tp5n']}, 11:10:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:10:53 INFO - 'talos_options': ['--xperf_path', 11:10:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:53 INFO - 'tests': ['tp5n']}}, 11:10:53 INFO - 'talos.zip': {'path': '', 11:10:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:10:53 INFO - Running post-action listener: _resource_record_post_action 11:10:53 INFO - [mozharness: 2016-12-27 19:10:53.552926Z] Finished populate-webroot step (success) 11:10:53 INFO - [mozharness: 2016-12-27 19:10:53.553019Z] Running create-virtualenv step. 11:10:53 INFO - Running pre-action listener: _resource_record_pre_action 11:10:53 INFO - Running main action method: create_virtualenv 11:10:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:10:53 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 11:10:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:10:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:10:53 INFO - Using real prefix '/usr' 11:10:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:10:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:10:56 INFO - Installing pip.................done. 11:10:56 INFO - Return code: 0 11:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:10:56 INFO - Reading from file tmpfile_stdout 11:10:56 INFO - Output received: 11:10:56 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) 11:10:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:10:56 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')]} 11:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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')]} 11:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:10:56 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 11:10:56 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 11:10:56 INFO - Using env: {'DISPLAY': ':0', 11:10:56 INFO - 'HOME': '/home/cltbld', 11:10:56 INFO - 'LANG': 'en_US.UTF-8', 11:10:56 INFO - 'LANGUAGE': 'en_US:en', 11:10:56 INFO - 'LOGNAME': 'cltbld', 11:10:56 INFO - 'MAIL': '/var/mail/cltbld', 11:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:56 INFO - 'MOZ_NO_REMOTE': '1', 11:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:56 INFO - 'NO_EM_RESTART': '1', 11:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:56 INFO - 'PWD': '/builds/slave/test', 11:10:56 INFO - 'SHELL': '/bin/bash', 11:10:56 INFO - 'SHLVL': '1', 11:10:56 INFO - 'TERM': 'linux', 11:10:56 INFO - 'TMOUT': '86400', 11:10:56 INFO - 'USER': 'cltbld', 11:10:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:56 INFO - '_': '/tools/buildbot/bin/python'} 11:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:56 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 11:10:56 INFO - Cleaning up... 11:10:56 INFO - Return code: 0 11:10:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:10:56 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')]} 11:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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')]} 11:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:10:56 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 11:10:56 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 11:10:56 INFO - Using env: {'DISPLAY': ':0', 11:10:56 INFO - 'HOME': '/home/cltbld', 11:10:56 INFO - 'LANG': 'en_US.UTF-8', 11:10:56 INFO - 'LANGUAGE': 'en_US:en', 11:10:56 INFO - 'LOGNAME': 'cltbld', 11:10:56 INFO - 'MAIL': '/var/mail/cltbld', 11:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:56 INFO - 'MOZ_NO_REMOTE': '1', 11:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:56 INFO - 'NO_EM_RESTART': '1', 11:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:56 INFO - 'PWD': '/builds/slave/test', 11:10:56 INFO - 'SHELL': '/bin/bash', 11:10:56 INFO - 'SHLVL': '1', 11:10:56 INFO - 'TERM': 'linux', 11:10:56 INFO - 'TMOUT': '86400', 11:10:56 INFO - 'USER': 'cltbld', 11:10:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:56 INFO - '_': '/tools/buildbot/bin/python'} 11:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:56 INFO - Downloading/unpacking psutil>=3.1.1 11:10:56 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 11:10:56 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 11:10:56 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 11:10:56 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 11:10:56 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 11:10:56 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 11:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:58 INFO - Installing collected packages: psutil 11:10:58 INFO - Running setup.py install for psutil 11:10:58 INFO - building 'psutil._psutil_linux' extension 11:10:58 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 11:10:59 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 11:10:59 INFO - building 'psutil._psutil_posix' extension 11:10:59 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 11:10:59 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 11:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:59 INFO - Successfully installed psutil 11:10:59 INFO - Cleaning up... 11:10:59 INFO - Return code: 0 11:10:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:10:59 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')]} 11:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:59 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')]} 11:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:59 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:10:59 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 11:10:59 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 11:10:59 INFO - Using env: {'DISPLAY': ':0', 11:10:59 INFO - 'HOME': '/home/cltbld', 11:10:59 INFO - 'LANG': 'en_US.UTF-8', 11:10:59 INFO - 'LANGUAGE': 'en_US:en', 11:10:59 INFO - 'LOGNAME': 'cltbld', 11:10:59 INFO - 'MAIL': '/var/mail/cltbld', 11:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:59 INFO - 'MOZ_NO_REMOTE': '1', 11:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:59 INFO - 'NO_EM_RESTART': '1', 11:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:59 INFO - 'PWD': '/builds/slave/test', 11:10:59 INFO - 'SHELL': '/bin/bash', 11:10:59 INFO - 'SHLVL': '1', 11:10:59 INFO - 'TERM': 'linux', 11:10:59 INFO - 'TMOUT': '86400', 11:10:59 INFO - 'USER': 'cltbld', 11:10:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:59 INFO - '_': '/tools/buildbot/bin/python'} 11:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:11:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:11:01 INFO - Installing collected packages: mozsystemmonitor 11:11:01 INFO - Running setup.py install for mozsystemmonitor 11:11:01 INFO - Successfully installed mozsystemmonitor 11:11:01 INFO - Cleaning up... 11:11:01 INFO - Return code: 0 11:11:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:11:01 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')]} 11:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:01 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')]} 11:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:01 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:01 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 11:11:01 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 11:11:01 INFO - Using env: {'DISPLAY': ':0', 11:11:01 INFO - 'HOME': '/home/cltbld', 11:11:01 INFO - 'LANG': 'en_US.UTF-8', 11:11:01 INFO - 'LANGUAGE': 'en_US:en', 11:11:01 INFO - 'LOGNAME': 'cltbld', 11:11:01 INFO - 'MAIL': '/var/mail/cltbld', 11:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:01 INFO - 'MOZ_NO_REMOTE': '1', 11:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:01 INFO - 'NO_EM_RESTART': '1', 11:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:01 INFO - 'PWD': '/builds/slave/test', 11:11:01 INFO - 'SHELL': '/bin/bash', 11:11:01 INFO - 'SHLVL': '1', 11:11:01 INFO - 'TERM': 'linux', 11:11:01 INFO - 'TMOUT': '86400', 11:11:01 INFO - 'USER': 'cltbld', 11:11:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:01 INFO - '_': '/tools/buildbot/bin/python'} 11:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:11:02 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 11:11:02 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 11:11:02 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 11:11:02 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 11:11:02 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 11:11:02 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 11:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:11:04 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 11:11:04 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 11:11:04 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 11:11:04 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 11:11:04 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 11:11:04 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 11:11:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:04 INFO - warning: no files found matching '*.txt' 11:11:04 INFO - no previously-included directories found matching 'build' 11:11:04 INFO - no previously-included directories found matching 'dist' 11:11:04 INFO - no previously-included directories found matching '.git*' 11:11:04 INFO - Installing collected packages: jsonschema, functools32 11:11:04 INFO - Running setup.py install for functools32 11:11:04 INFO - warning: no files found matching '*.txt' 11:11:04 INFO - no previously-included directories found matching 'build' 11:11:04 INFO - no previously-included directories found matching 'dist' 11:11:04 INFO - no previously-included directories found matching '.git*' 11:11:04 INFO - Successfully installed jsonschema functools32 11:11:04 INFO - Cleaning up... 11:11:04 INFO - Return code: 0 11:11:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:04 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:04 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 11:11:04 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 11:11:04 INFO - Using env: {'DISPLAY': ':0', 11:11:04 INFO - 'HOME': '/home/cltbld', 11:11:04 INFO - 'LANG': 'en_US.UTF-8', 11:11:04 INFO - 'LANGUAGE': 'en_US:en', 11:11:04 INFO - 'LOGNAME': 'cltbld', 11:11:04 INFO - 'MAIL': '/var/mail/cltbld', 11:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:04 INFO - 'MOZ_NO_REMOTE': '1', 11:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:04 INFO - 'NO_EM_RESTART': '1', 11:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:04 INFO - 'PWD': '/builds/slave/test', 11:11:04 INFO - 'SHELL': '/bin/bash', 11:11:04 INFO - 'SHLVL': '1', 11:11:04 INFO - 'TERM': 'linux', 11:11:04 INFO - 'TMOUT': '86400', 11:11:04 INFO - 'USER': 'cltbld', 11:11:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:04 INFO - '_': '/tools/buildbot/bin/python'} 11:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:11:04 INFO - Cleaning up... 11:11:04 INFO - Return code: 0 11:11:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:04 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:04 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 11:11:04 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 11:11:04 INFO - Using env: {'DISPLAY': ':0', 11:11:04 INFO - 'HOME': '/home/cltbld', 11:11:04 INFO - 'LANG': 'en_US.UTF-8', 11:11:04 INFO - 'LANGUAGE': 'en_US:en', 11:11:04 INFO - 'LOGNAME': 'cltbld', 11:11:04 INFO - 'MAIL': '/var/mail/cltbld', 11:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:04 INFO - 'MOZ_NO_REMOTE': '1', 11:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:04 INFO - 'NO_EM_RESTART': '1', 11:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:04 INFO - 'PWD': '/builds/slave/test', 11:11:04 INFO - 'SHELL': '/bin/bash', 11:11:04 INFO - 'SHLVL': '1', 11:11:04 INFO - 'TERM': 'linux', 11:11:04 INFO - 'TMOUT': '86400', 11:11:04 INFO - 'USER': 'cltbld', 11:11:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:04 INFO - '_': '/tools/buildbot/bin/python'} 11:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:05 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 11:11:05 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 11:11:05 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 11:11:05 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 11:11:05 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 11:11:05 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 11:11:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 INFO - Downloading docopt-0.6.1.tar.gz 11:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:07 INFO - Running setup.py install for blobuploader 11:11:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:07 INFO - Running setup.py install for requests 11:11:08 INFO - Running setup.py install for docopt 11:11:08 INFO - Successfully installed blobuploader requests docopt 11:11:08 INFO - Cleaning up... 11:11:08 INFO - Return code: 0 11:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:08 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 11:11:08 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 11:11:08 INFO - Using env: {'DISPLAY': ':0', 11:11:08 INFO - 'HOME': '/home/cltbld', 11:11:08 INFO - 'LANG': 'en_US.UTF-8', 11:11:08 INFO - 'LANGUAGE': 'en_US:en', 11:11:08 INFO - 'LOGNAME': 'cltbld', 11:11:08 INFO - 'MAIL': '/var/mail/cltbld', 11:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:08 INFO - 'MOZ_NO_REMOTE': '1', 11:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:08 INFO - 'NO_EM_RESTART': '1', 11:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:08 INFO - 'PWD': '/builds/slave/test', 11:11:08 INFO - 'SHELL': '/bin/bash', 11:11:08 INFO - 'SHLVL': '1', 11:11:08 INFO - 'TERM': 'linux', 11:11:08 INFO - 'TMOUT': '86400', 11:11:08 INFO - 'USER': 'cltbld', 11:11:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:08 INFO - '_': '/tools/buildbot/bin/python'} 11:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:08 INFO - Running setup.py (path:/tmp/pip-xbnhbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:08 INFO - Running setup.py (path:/tmp/pip-36thgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:08 INFO - Running setup.py (path:/tmp/pip-0U1pXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:08 INFO - Running setup.py (path:/tmp/pip-YKeyOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:08 INFO - Running setup.py (path:/tmp/pip-6fiW76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:08 INFO - Running setup.py (path:/tmp/pip-J1FER2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:09 INFO - Running setup.py (path:/tmp/pip-2s1fpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:09 INFO - Running setup.py (path:/tmp/pip-TRbde5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:09 INFO - Running setup.py (path:/tmp/pip-UF46i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:09 INFO - Running setup.py (path:/tmp/pip-xY8xtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:09 INFO - Running setup.py (path:/tmp/pip-fnMWA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:09 INFO - Running setup.py (path:/tmp/pip-jfnFG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:09 INFO - Running setup.py (path:/tmp/pip-blO9g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:09 INFO - Running setup.py (path:/tmp/pip-KzArEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:09 INFO - Running setup.py (path:/tmp/pip-cRVp9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:09 INFO - Running setup.py (path:/tmp/pip-gJL_FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:09 INFO - Running setup.py (path:/tmp/pip-kXTJUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:09 INFO - Running setup.py install for manifestparser 11:11:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:09 INFO - Running setup.py install for mozcrash 11:11:10 INFO - Running setup.py install for mozdebug 11:11:10 INFO - Running setup.py install for mozdevice 11:11:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for mozfile 11:11:10 INFO - Running setup.py install for mozhttpd 11:11:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for mozinfo 11:11:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for mozInstall 11:11:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for mozleak 11:11:10 INFO - Running setup.py install for mozlog 11:11:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for moznetwork 11:11:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:10 INFO - Running setup.py install for mozprocess 11:11:11 INFO - Running setup.py install for mozprofile 11:11:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:11 INFO - Running setup.py install for mozrunner 11:11:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:11 INFO - Running setup.py install for mozscreenshot 11:11:11 INFO - Running setup.py install for moztest 11:11:11 INFO - Running setup.py install for mozversion 11:11:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:11 INFO - Cleaning up... 11:11:11 INFO - Return code: 0 11:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:11 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')]} 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:11 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')]} 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:11 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:11 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 11:11:11 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 11:11:11 INFO - Using env: {'DISPLAY': ':0', 11:11:11 INFO - 'HOME': '/home/cltbld', 11:11:11 INFO - 'LANG': 'en_US.UTF-8', 11:11:11 INFO - 'LANGUAGE': 'en_US:en', 11:11:11 INFO - 'LOGNAME': 'cltbld', 11:11:11 INFO - 'MAIL': '/var/mail/cltbld', 11:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:11 INFO - 'MOZ_NO_REMOTE': '1', 11:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:11 INFO - 'NO_EM_RESTART': '1', 11:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:11 INFO - 'PWD': '/builds/slave/test', 11:11:11 INFO - 'SHELL': '/bin/bash', 11:11:11 INFO - 'SHLVL': '1', 11:11:11 INFO - 'TERM': 'linux', 11:11:11 INFO - 'TMOUT': '86400', 11:11:11 INFO - 'USER': 'cltbld', 11:11:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:11 INFO - '_': '/tools/buildbot/bin/python'} 11:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:11 INFO - Running setup.py (path:/tmp/pip-__MkfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:11 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)) 11:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:11 INFO - Running setup.py (path:/tmp/pip-MeFaFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:12 INFO - Running setup.py (path:/tmp/pip-ffhbaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:12 INFO - Running setup.py (path:/tmp/pip-iq2heT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:12 INFO - Running setup.py (path:/tmp/pip-e08eJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:12 INFO - Running setup.py (path:/tmp/pip-3jNeL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:12 INFO - Running setup.py (path:/tmp/pip-r0pkxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:12 INFO - Running setup.py (path:/tmp/pip-eIXwgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:12 INFO - Running setup.py (path:/tmp/pip-L5Xf5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:12 INFO - Running setup.py (path:/tmp/pip-GhCHYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:12 INFO - Running setup.py (path:/tmp/pip-yw_8Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:12 INFO - Running setup.py (path:/tmp/pip-0NIiU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:12 INFO - Running setup.py (path:/tmp/pip-4Oc6OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:12 INFO - Running setup.py (path:/tmp/pip-770L9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:12 INFO - Running setup.py (path:/tmp/pip-8lap1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:12 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)) 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:12 INFO - Running setup.py (path:/tmp/pip-mnypuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:13 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)) 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:13 INFO - Running setup.py (path:/tmp/pip-rbAgdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:13 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)) 11:11:13 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)) 11:11:13 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)) 11:11:13 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)) 11:11:13 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)) 11:11:13 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)) 11:11:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:15 INFO - Downloading blessings-1.6.tar.gz 11:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:15 INFO - Installing collected packages: blessings 11:11:15 INFO - Running setup.py install for blessings 11:11:15 INFO - Successfully installed blessings 11:11:15 INFO - Cleaning up... 11:11:15 INFO - Return code: 0 11:11:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:15 INFO - Reading from file tmpfile_stdout 11:11:15 INFO - Current package versions: 11:11:15 INFO - argparse == 1.2.1 11:11:15 INFO - blessings == 1.6 11:11:15 INFO - blobuploader == 1.2.4 11:11:15 INFO - docopt == 0.6.1 11:11:15 INFO - functools32 == 3.2.3-2 11:11:15 INFO - jsonschema == 2.5.1 11:11:15 INFO - manifestparser == 1.1 11:11:15 INFO - mozInstall == 1.12 11:11:15 INFO - mozcrash == 1.0 11:11:15 INFO - mozdebug == 0.1 11:11:15 INFO - mozdevice == 0.49 11:11:15 INFO - mozfile == 1.2 11:11:15 INFO - mozhttpd == 0.7 11:11:15 INFO - mozinfo == 0.9 11:11:15 INFO - mozleak == 0.1 11:11:15 INFO - mozlog == 3.4 11:11:15 INFO - moznetwork == 0.27 11:11:15 INFO - mozprocess == 0.23 11:11:15 INFO - mozprofile == 0.28 11:11:15 INFO - mozrunner == 6.13 11:11:15 INFO - mozscreenshot == 0.1 11:11:15 INFO - mozsystemmonitor == 0.3 11:11:15 INFO - moztest == 0.7 11:11:15 INFO - mozversion == 1.4 11:11:15 INFO - psutil == 3.1.1 11:11:15 INFO - requests == 1.2.3 11:11:15 INFO - wsgiref == 0.1.2 11:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:15 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 11:11:15 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 11:11:15 INFO - Using env: {'DISPLAY': ':0', 11:11:15 INFO - 'HOME': '/home/cltbld', 11:11:15 INFO - 'LANG': 'en_US.UTF-8', 11:11:15 INFO - 'LANGUAGE': 'en_US:en', 11:11:15 INFO - 'LOGNAME': 'cltbld', 11:11:15 INFO - 'MAIL': '/var/mail/cltbld', 11:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:15 INFO - 'MOZ_NO_REMOTE': '1', 11:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:15 INFO - 'NO_EM_RESTART': '1', 11:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:15 INFO - 'PWD': '/builds/slave/test', 11:11:15 INFO - 'SHELL': '/bin/bash', 11:11:15 INFO - 'SHLVL': '1', 11:11:15 INFO - 'TERM': 'linux', 11:11:15 INFO - 'TMOUT': '86400', 11:11:15 INFO - 'USER': 'cltbld', 11:11:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:15 INFO - '_': '/tools/buildbot/bin/python'} 11:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 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)) 11:11:15 INFO - Cleaning up... 11:11:15 INFO - Return code: 0 11:11:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 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 0x217e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24efc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, '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': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', '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 11:11:15 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 11:11:15 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 11:11:15 INFO - Using env: {'DISPLAY': ':0', 11:11:15 INFO - 'HOME': '/home/cltbld', 11:11:15 INFO - 'LANG': 'en_US.UTF-8', 11:11:15 INFO - 'LANGUAGE': 'en_US:en', 11:11:15 INFO - 'LOGNAME': 'cltbld', 11:11:15 INFO - 'MAIL': '/var/mail/cltbld', 11:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:15 INFO - 'MOZ_NO_REMOTE': '1', 11:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:15 INFO - 'NO_EM_RESTART': '1', 11:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:15 INFO - 'PWD': '/builds/slave/test', 11:11:15 INFO - 'SHELL': '/bin/bash', 11:11:15 INFO - 'SHLVL': '1', 11:11:15 INFO - 'TERM': 'linux', 11:11:15 INFO - 'TMOUT': '86400', 11:11:15 INFO - 'USER': 'cltbld', 11:11:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:15 INFO - '_': '/tools/buildbot/bin/python'} 11:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:11:16 INFO - Cleaning up... 11:11:16 INFO - Return code: 0 11:11:16 INFO - Running post-action listener: _resource_record_post_action 11:11:16 INFO - Running post-action listener: _start_resource_monitoring 11:11:16 INFO - Starting resource monitoring. 11:11:16 INFO - [mozharness: 2016-12-27 19:11:16.077689Z] Finished create-virtualenv step (success) 11:11:16 INFO - [mozharness: 2016-12-27 19:11:16.078269Z] Running install step. 11:11:16 INFO - Running pre-action listener: _resource_record_pre_action 11:11:16 INFO - Running main action method: install 11:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:16 INFO - Reading from file tmpfile_stdout 11:11:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:16 INFO - Reading from file tmpfile_stdout 11:11:16 INFO - Output received: 11:11:16 INFO - Usage: mozinstall [options] installer 11:11:16 INFO - Options: 11:11:16 INFO - -h, --help show this help message and exit 11:11:16 INFO - -d DEST, --destination=DEST 11:11:16 INFO - Directory to install application into. [default: 11:11:16 INFO - "/builds/slave/test"] 11:11:16 INFO - --app=APP Application being installed. [default: firefox] 11:11:16 INFO - mkdir: /builds/slave/test/build/application 11:11:16 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'] 11:11:16 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 11:11:32 INFO - Reading from file tmpfile_stdout 11:11:32 INFO - Output received: 11:11:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:11:32 INFO - Running post-action listener: _resource_record_post_action 11:11:32 INFO - [mozharness: 2016-12-27 19:11:32.488230Z] Finished install step (success) 11:11:32 INFO - [mozharness: 2016-12-27 19:11:32.488476Z] Running run-tests step. 11:11:32 INFO - Running pre-action listener: _resource_record_pre_action 11:11:32 INFO - Running main action method: run_tests 11:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:11:32 INFO - Python 2.7.3 11:11:32 INFO - Return code: 0 11:11:32 INFO - grabbing minidump binary from tooltool 11: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')]} 11:11:32 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 0x24ed3f0>, '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 0x24edcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:11:32 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 11:11:32 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 11:11:32 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 11:11:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:11:32 INFO - Return code: 0 11:11:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:11:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:11:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:11:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:11:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:11:32 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/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:11:32 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/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 11:11:32 INFO - Using env: {'DISPLAY': ':0', 11:11:32 INFO - 'HOME': '/home/cltbld', 11:11:32 INFO - 'LANG': 'en_US.UTF-8', 11:11:32 INFO - 'LANGUAGE': 'en_US:en', 11:11:32 INFO - 'LOGNAME': 'cltbld', 11:11:32 INFO - 'MAIL': '/var/mail/cltbld', 11:11:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:32 INFO - 'MOZ_NO_REMOTE': '1', 11:11:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:32 INFO - 'NO_EM_RESTART': '1', 11:11:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:32 INFO - 'PWD': '/builds/slave/test', 11:11:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:32 INFO - 'SHELL': '/bin/bash', 11:11:32 INFO - 'SHLVL': '1', 11:11:32 INFO - 'TERM': 'linux', 11:11:32 INFO - 'TMOUT': '86400', 11:11:32 INFO - 'USER': 'cltbld', 11:11:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053', 11:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:32 INFO - '_': '/tools/buildbot/bin/python'} 11:11:32 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/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:11:32 INFO - mozversion application_buildid: 20161227104237 11:11:32 INFO - mozversion application_changeset: 545975b950e85f2acf1db2ee9b02a432829bc980 11:11:32 INFO - mozversion application_display_name: Nightly 11:11:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:32 INFO - mozversion application_name: Firefox 11:11:32 INFO - mozversion application_remotingname: firefox 11:11:32 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:11:32 INFO - mozversion application_vendor: Mozilla 11:11:32 INFO - mozversion application_version: 53.0a1 11:11:32 INFO - mozversion platform_buildid: 20161227104237 11:11:32 INFO - mozversion platform_changeset: 545975b950e85f2acf1db2ee9b02a432829bc980 11:11:32 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:11:32 INFO - mozversion platform_version: 53.0a1 11:11:32 INFO - using testdate: 1482865892 11:11:32 INFO - actual date: 1482865892 11:11:32 INFO - starting webserver on 'localhost:60801' 11:11:32 INFO - SUITE-START | Running 2 tests 11:11:32 INFO - TEST-START | dromaeo_css 11:11:32 INFO - operating with platform_type : linux_ 11:11:32 INFO - Initialising browser for dromaeo_css test... 11:11:32 INFO - TEST-INFO | started process 21334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNeITo_/profile http://localhost:60801/getInfo.html) 11:11:33 INFO - PROCESS | 21334 | 1482865893313 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 11:11:37 INFO - PROCESS | 21334 | __metrics Screen width/height:1600/1200 11:11:37 INFO - PROCESS | 21334 | colorDepth:24 11:11:37 INFO - PROCESS | 21334 | Browser inner width/height: 1024/697 11:11:37 INFO - PROCESS | 21334 | __metrics 11:11:37 ERROR - PROCESS | 21334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:11:38 INFO - TEST-INFO | 21334: exit 0 11:11:38 INFO - Browser initialized. 11:11:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:11:38 INFO - TEST-INFO | started process 21455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNeITo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:50 INFO - PROCESS | 21455 | RSS: Main: 158154752 11:11:50 INFO - PROCESS | 21455 | 11:14:54 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60801/tests/dromaeo/cssquery-ext.html) 11:14:55 INFO - PROCESS | 21455 | RSS: Main: 166617088 11:14:55 INFO - PROCESS | 21455 | 11:16:39 INFO - PROCESS | 21455 | ************************* 11:16:39 INFO - PROCESS | 21455 | A coding exception was thrown and uncaught in a Task. 11:16:39 INFO - PROCESS | 21455 | 11:16:39 INFO - PROCESS | 21455 | Full message: ReferenceError: fetch is not defined 11:16:39 INFO - PROCESS | 21455 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:16:39 INFO - PROCESS | 21455 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:16:39 INFO - PROCESS | 21455 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:16:39 INFO - PROCESS | 21455 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:16:39 INFO - PROCESS | 21455 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:16:39 INFO - PROCESS | 21455 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:16:39 INFO - PROCESS | 21455 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:16:39 INFO - PROCESS | 21455 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:16:39 INFO - PROCESS | 21455 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:16:39 INFO - PROCESS | 21455 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:16:39 INFO - PROCESS | 21455 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:16:39 INFO - PROCESS | 21455 | 11:16:39 INFO - PROCESS | 21455 | ************************* 11:17:58 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-ext.html (next: http://localhost:60801/tests/dromaeo/cssquery-jquery.html) 11:17:58 INFO - PROCESS | 21455 | RSS: Main: 162484224 11:17:58 INFO - PROCESS | 21455 | 11:21:00 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60801/tests/dromaeo/cssquery-mootools.html) 11:21:01 INFO - PROCESS | 21455 | RSS: Main: 168001536 11:21:01 INFO - PROCESS | 21455 | 11:24:03 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60801/tests/dromaeo/cssquery-prototype.html) 11:24:04 INFO - PROCESS | 21455 | RSS: Main: 162603008 11:24:04 INFO - PROCESS | 21455 | 11:27:07 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60801/tests/dromaeo/cssquery-yui.html) 11:27:07 INFO - PROCESS | 21455 | RSS: Main: 166281216 11:27:07 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | Cycle 1(1): loaded http://localhost:60801/tests/dromaeo/cssquery-yui.html (next: http://localhost:60801/tests/dromaeo/cssquery-dojo.html) 11:30:11 INFO - PROCESS | 21455 | RSS: Main: 166592512 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | __start_tp_report 11:30:11 INFO - PROCESS | 21455 | _x_x_mozilla_page_load 11:30:11 INFO - PROCESS | 21455 | _x_x_mozilla_page_load_details 11:30:11 INFO - PROCESS | 21455 | |i|pagename|runs| 11:30:11 INFO - PROCESS | 21455 | |0;dojo.html;2622.881970311336;2623.7900967922565;2634.091238522709;2642.220544939243;2664.547027005409;4745.976270118645;4849;4903.705777653339;4907.190313598257;4914.164592019356;4778.68938518996;4845.127876982142;4874.317595536628;4905.043516514281;4945.43127540333;4433.467983841935;4493.865184044484;4516.570925762047;4534.251848445003;4585.977070114662;4128.277551428503;4593.839215627454;4594.081183763244;4594.517575654559;4617.676762626617;4404.537523560044;4469.597736203725;4493.752843593601;4522.6155776759015;4581.221192397301;4410.647148228134;4435.8225670973125;4441.844535441276;4498.572635599646;4539.546045395467;4416.712913660602;4420.602145806861;4448.33275008748;4462.732236065846;4465.888352791206;4793.448753393334;4809.687370320953;4813.3983252093485;4820.156472617278;4835.6131509479155;5038.244263360525;5083.415407228179;5124.564412024983;5134.614903882224;5151.742412879378;5214.035403450336;5215.947840521584;5220;5227.451117632631;5256.973715131438;4865.5864251538305;4888;4891.51084891508;4897.191963326011;4928.901421971541;5168.2764412982215;5229.6600720953775;5237.895242095136;5284.630075894727;5324.334458192726;5015.27278544609;5026.597872170218;5031.74841257943;5069.44236134025;5077.289179514797;5026.79892804291;5121.769520371592;5166.535011848951;5199.844004679866;5212.218167274863;4995.25071239317;5004.399472063303;5009;5020.974895125574;5065.062963351792;5035.84892453227;5049.31834202378;5063.873403164876;5066.670666406671;5067.366579177603;4370.950971766753;4396.868093957187;4400.163968845973;4433.268510695699;4518.051209246029;3799.4490798834013;3825.445310429972;3844.0966372902344;3851.7496362736333;3854.2676891390547;4400.9559904401185;4411.669124815651;4417.359482874966;4434.490033646108;4455.933161002587;5160.148575485078;5160.329157209539;5165;5167.483251674803;5171.172612382001;4334.718243314174;4376.190404775127;4396.648268138541;4426.092651006536;4456.019675671347;4705.811767529329;4754.405699287589;4761.738104404291;4776.068666609977;4811.013742182844;4884;4886.3647725796845;4891.5353041461;4903.583195428429;4938.6789858659795;5092.955944031391;5158.252053452304;5240.633155679066;5258.1849813279005;5302.522772950453;4730.905381892274;4764.618830493621;4769.356136921471;4782.832600858953;4821.614270858253;4968.701877887338;5010.073136469765;5020.748962551785;5021.1213037717525;5045.5459008689395;5026.673266237683;5070.721110338966;5110.97444512775;5111.437741848319;5140.485951404829;4879.463259041431;4945.975270123627;4963.503649635008;4971.9254211186135;5048.873778155428;4963.230699241623;4966.106100901872;4975.353204083591;4978.651494395358;5022.84931452057;4798.928016079832;4849.80600775965;4856.805727770849;4867.561919427269;4890.657653964188;4965.528274813887;4970.8757281068265;4979.576735977337;5040.243963405372;5042.546170844642;4833.419989601271;4835.758212089311;4837.9032419350715;4852.708837469763;4908.803647854189 11:30:11 INFO - PROCESS | 21455 | |1;ext.html;505.8870484933147;514.6217530115365;535.8874636326374;538.3996843519476;546.2025442853434;34133.14667133323;37971.670991515304;37983.96128309736;38068;38084.42873356902;38180.23639527215;38251.42622860652;38712.41931371025;38776;38925.22149557007;7470.402367810576;7648.885266721004;7673.155952845183;9273.350865439388;9619.711408657717;9483.81032379352;9596.424214547114;9604.223218704527;9604.615815367377;9605.66380176694;9598.616055357777;9606.663766768164;9644.08381203788;9682.322237443383;9682.6444297798;9455.43267403951;9500.144986951138;9531.18984886282;9535.189508891717;9575.664851730226;9437.952810235905;9541.666041688508;9544.713658590184;9567.904320956772;9573.904260957372;32106.839465802754;32765.180870478427;32767.50848737271;32822.507662385084;32925.6707432925;3634.582023067355;3683.2817600567632;3695.113172838526;3713.832877520518;3765.435184722286;25040.624390634155;25840;26492.470150597073;26534.07130750434;26629.600555991674;3109.455845227076;3156.0216332936634;3266.591676040495;3287.1124796305103;3291.687289707474;249429;250876;251504;251577;252827;45825.312620310724;46231.5376846234;46251.76874115675;46470.30294545584;46535.767321163854;47866.28200576994;47913;47948.7602561985;47949;48093.5190648096;12498.687532811753;12882.420291086924;12889.355532223539;12890;12943.741125177443;8966.148215919477;9124.224440922464;9770.41377517337;10075.345102568455;10095.949520252352;15505.689886202214;15591.376344946075;15611.074802447854;15687.843121568638;15805.446809361618;6428.907085795426;6544.672766361663;6632.767853125118;6640.667966601651;6854.862902742017;774.5933384972934;789.4710543935462;810.3922058456158;812.1837553259055;822.9094799572042;27241.86379068092;27316.863415682794;27671.169864904085;27675.169744907686;27737.167884963485;925.546482223719;935.1910597333393;942.9717108486757;942.9717108486757;949.6723630347519;14057.578272651837;14653.689205337181;14770.70458590822;14779.408823647149;14842.18367989771;361099;380968;381916;385918;591866;43405.78297108557;44080.559194407644;44248.55751442509;44248.77875610601;44261.77869110634;1193.0694058634278;1212.1636071110904;1221.993890030562;1223.2293654997472;1232.8458942632171;25152.11967581126;25703;26157.346066348495;26161.607575885995;26458;37927.24145517019;38021;38066.42900356552;38385.616143838204;38466.42300365553;335868;337707;338757;339274;339490;22533.43666408353;23041.539169216856;23629.409264768517;23685.64471532894;23754.168604099465;36665.633343666224;36741.26517469689;36968.81515592405;36973.445398319585;37264.25471490501;31254.21864453407;31291.84354078215;31375.117492950496;31586.52620210653;31726.52410213895;30251.697483025768;30831.845840770653;30973.69026309708;31287.217819554695;31905.36189276155;29804.850975744983;29855.402891942475;30276.69723302739;30440.238994025327;30649.846750766104;25600.35999099963;28280.43439131247;28434.715652843206;28589.714102858707;28865.567016495188;21020.47448813792;21465;21554;21638.783612163676;21691.240806571695 11:30:11 INFO - PROCESS | 21455 | |2;jquery.html;365.4189838157331;375.69756346141355;379.2755836352566;383.8694843753123;391.44805823788465;15731.134787586692;16804.159792010396;17334;17355.69832262579;17381.391651292208;15336;15453.45912893049;15488.767668484954;15503.302351394186;15822.129782861937;4848.97575512122;5126.179811230185;5151.922721159186;5156.2781210630355;5170.172772356424;3958;4132.5454200037975;5073.949260507403;5919.141724449953;6205.81382558524;6159.630422174661;6166.599171053889;6179.721912513925;6181.134641150243;6190.442860142586;5928.258967629046;6060.090986352038;6071.969640151771;6083.330833608299;6085.6348619083;4662.696924699918;5339.652922560022;5363.892722145535;5367.06076436626;5369.355677318707;12094.334811585359;12451.93774031133;12485.188462749893;12494.562690305796;12504.124711270215;2141.860779049357;2157.5792720419527;2192.320380681994;2229.5317983223545;2442.829001969863;8860.512671803048;8913.153250441197;9141.771455713593;9248.676296329664;9505.097015783489;1544.482598329561;1585.6670099279165;1589.5867074560697;1609.139110575848;1626.6014826367498;62784.97720182374;64101;66557.66721166363;66631.0005349925;70181.64909175472;9807.605816800731;9871.963443838436;9962.601495940082;10152.73090863642;10200.948995254976;13787.586372408843;13788.862111378958;13807.930960345135;13809.378577964017;13834.861651383559;6760.005798289516;6932.6533673316135;6987.475939304572;7127.786166415016;7208.783736487913;6553.082568440422;6600.405963463215;6626.337366263335;6646.767363142267;6821.488388370892;4301.591348821857;4346.521882592975;4353.06409122034;4379.846705365297;4406.9779651101535;1482.1551715522264;1588.7299159142974;1606.3895719626466;1836.6234921841258;1890.3005887821319;933.355984370782;940.3041749105613;984.4437892590663;988.3822610868208;990.1089019882164;15892.443764468188;16041.278142483616;16375.672486550202;16527.586810329838;16820;932.3333816321363;939.8966113727485;963.4989805301344;967.3953778888194;971.13568923658;8847.46915185091;9189.81620367589;9255.490947997925;9262.814743705088;9454.57454414553;341015;345065;347215;347940;349015;69831;71582;72105.55788884193;72984.63507682427;73410.26589734034;893.6738090596886;895.9552022398854;915.1397686174975;926.6478738079621;928.461492334458;14352.712945740817;14496.855031449972;14565;14788.408463661333;14916;33436.66563334336;33779.831100845324;34537.48193777146;34737.1315717099;35058;47548;48906.5109348902;48957.51042489529;48995;49224.261636076204;6853.314668533107;6973.860522789414;7021.929780702332;7077;7183.640817959185;7471.40228781707;9309.581068852054;9934;11095.278806877526;11526.538938442369;10450.738731531468;10682.732931676459;10709.785804284027;10807.189460790314;11004.944975275072;10178.745531361776;10465.790684186426;10797.29817561856;10820.837687434538;10839.891601083888;10287.53706083243;10670.89329106699;10680.679579612624;10801.783964320512;10953.34279943206;7742.8451430969935;7838.843223135391;7871.48835325702;7948.205179482236;8029.7189598363775;9321.394109382869;10145.746356340855;10313.793724125626;10601.25791194609;10757.408342541235 11:30:11 INFO - PROCESS | 21455 | |3;mootools.html;1298.1886321049344;1313.9934300328503;1315.217445619857;1324.3047400114938;1334.3595074364305;6454.483641308696;6652.567583107095;6907.516473846833;7311.086114235721;7315.817104572388;7053.541519801222;7272.527285726424;7280.890786638205;7515.887261691079;7557.319841214304;2113.651247544153;2122.1829595605727;2145.5279838435517;2146.8389870759756;2148.838837087225;2113.693514440405;2147.6671115977047;2167.902444390006;2171.4028642123462;2226.955460890781;2154.5475450155486;2192.572448372568;2203.2729199364253;2204.2946257197705;2208.5803697297542;2114.968275475877;2120.130746393979;2127.117246342766;2133.28534940795;2137.6472881974455;2158.557495713391;2166.2526428382184;2172.0660116150048;2184.6176919039103;2191.41927389242;7404;7503.099628044615;7554.546727196386;7556.093268807724;7561.432892533082;4516.909661806778;4656.138614356355;4657.208274593293;4657.836975705834;4670.743109129031;2687.852168130752;2819.8590070496393;2898.0581311073984;2917.897873574415;2968.421157874215;1049.7690508088208;1062.7024433158729;1082.4966390628394;1089.929154604956;1111.4664960818852;9802.803943921082;9817;9871.309008369417;9879.80240395188;9886.653967111188;3863.74885632433;3993.5207775066597;4038.212548553004;4101.1387608601935;4113.218488487178;7671.578063206577;7685.42359323053;7714.652840622185;7760.146383897767;7786.922130778733;4461.107778444324;4530.456345238593;4553.453585569687;4555.63554915606;4574.359589657451;4133.46264985556;4160.625543701021;4176.373543968429;4238.830446782094;4245.57544245573;3014.9397012059635;3019.04899956513;3077.461444247248;3095.845207739604;3173.8571764270664;984.7735020945223;1013;1022.9539670714836;1030.9381437113798;1054.4411461925192;773.6441237030916;791.2641243643467;791.4578513718121;792.5878543157526;800.1518390505965;4718.88202794926;4724.763761811896;4777.211760059621;4864.80540778372;4897.436794768576;843.6372359885186;843.9409241353169;848.8854004709409;850.8043150075517;852.4672079950032;3125.312431265118;3263.0863358259726;3332.7333813294877;3344.916377090592;3375.8480868360984;8671.479711217347;8840.469571825583;8937.910620893708;8953.552322383855;8992.910070899206;8113.634886430124;8451.492910425393;8877.378583499092;8879.179768147515;8915.55422228886;6652.900206496906;6758.155230596176;6835.93164068353;6843.076184715;6868.175818901764;4583.564561366665;4724.1732696777235;4781.545753153445;4805.831795887128;4822.7829747660735;7992;8011.83976320482;8032.598370081356;8102.959485202537;8130.390220733587;8259.132791056853;8414.579271036302;8425.410221284452;8474.449160804528;8476.406651534333;6391.296957334783;6583.769568065095;6609.074729537965;6623.635700036544;6628.668566571749;6560.147180866456;6863.897041544481;6941.895871561829;6942.444604431533;6945.027696122446;6310.6844657766005;6367.90448143269;6500.28496865335;6516.869662606816;6600.537962342782;6299.685015749103;6352.047192921099;6375.968120159555;6399.968000159969;6403.359664033559;5241.921371179359;5360.490753378423;5419.214213939035;5564.777408903598;5600.411956744483;3935.3309937311296;3951.881443556583;3957.9313585331224;3969.4045893116263;3988.0827409695353;3992.301347264275;4003.2393845169327;4041.81811818463;4067.1865626875333;4087.9560219890054 11:30:11 INFO - PROCESS | 21455 | |4;prototype.html;343.27568829769183;354.09881850689993;354.6790154909804;354.91127218195453;359.84526653538984;4998.500149985004;5019.723915184663;5020.799168033279;5035.9748201259035;5039.924401133986;4967.230079337708;4991.700497970124;4991.800327986885;4998.400191976968;5023.648344615878;3832.030176613126;3904.9804750976205;3922.8038598070125;4009.83960641574;4017.9754162688473;3999.520057593093;4012.996750812297;4015.1969606078756;4022.135240923201;4027.154297597508;4000.359942409215;4001.9399709004388;4006.9599304007024;4019.296623090962;4035.515738111431;3925.4308125321954;3976.926229917906;4013.237484877893;4035.7287454451753;4046.9797651011704;3574.8748793792092;3590.964090359089;3597.399157374969;3602.8018458984743;3603.765755225902;4823.879403014917;4836.492168322346;4851.830185943475;4862.562369386772;4866.812237984091;4497.5952164305045;4589.967257367099;4597.494275629678;4604.631629469634;4621.607163391116;5189.949969761923;5192.766325515361;5244.554212891909;5246.606504512177;5268.894622107575;3953.7348048624453;3961.2671655743493;3970.5235371755284;3981.30327192743;3992.321305378093;5327.561558379216;5530.336359636829;5536.252605898233;5555.2500412444615;5559.6664200148125;3970.960290397059;3973.5297939761895;3981.960180398159;4021.7586944783407;4039.131586708813;4014.157027024299;4063.313724804232;4074.898127546835;4081.1429599783783;4094.5905409458815;4535.727856328631;4541.818327266872;4544;4547.545245475492;4567.269236922077;5090.720010399389;5206.895862082737;5212.4266330703595;5249.737513124329;5274.868128296824;1387.4519564771858;1387.5213051497217;1387.8195834541445;1394.316784775473;1397.5807257822612;957.8419560772395;982.8918818929913;1013.4848401639596;1015.2030655935056;1021.2902033087082;4351.673624478177;4432.689711720213;4465.486469056035;4541.137183935041;4542.659300552472;5376.843978544632;5381.354237491526;5383.865403364947;5385.219143224211;5388.164834450667;4529.207388706963;4536.183486972311;4542.31865220213;4567.1779079765965;4568.771561421916;2655.694595121547;2763.392053748172;2763.5301998660275;2774.597683335905;2783.4711404833015;4833.637477189225;4834.323194752737;4838.854834354975;4849.515048495122;4871.585915197248;5190.896182076337;5322.604827827493;5334.199870019528;5341.973290133525;5366.6243362964215;4978.5270399312;4999.600031997432;5008.874778130576;5010.824621138243;5011.924821127686;5359.276497672764;5398.78404863801;5418.512333889968;5437.592180586393;5452.537638599597;5154.123798954111;5167.534921857051;5188.403333616682;5315.255864179096;5321.536577441235;4919.458859525521;4931.901361972812;4947.356843610308;4981.71207003376;5008.148614735431;3765.8493660253284;3795.2409518095938;3795.4306853972125;3819.3264714699267;3838.6353296436796;5091.87270318245;5360.839174824761;5375.489328513785;5390.4879036491475;5467.72661366938;5188.818391356435;5191.22131680251;5207.71357575337;5210.525000624673;5215.217717342277;5151.330327057459;5205.193195054772;5205.245239440335;5208.192730126836;5212.582993360446;4878.463369029475;5091;5094.497123348695;5094.923576146287;5095.337606111182;5054.848354549369;5183.867970708896;5215.426303106731;5218.973905130602;5235.921461178162;5091.516305950929;5108.897822043613;5112.233165025276;5119.180931051014;5126.871828204325 11:30:11 INFO - PROCESS | 21455 | |5;yui.html;662.9469642428603;676.4689718570922;735.8528294341133;742.1317059040922;770.9831776444724;12627.431765570549;12878.484860605588;13470.12444191128;13484.528041518537;13486.932565337183;14902.627434314147;15895.602609934758;15930.840691593081;15945.362185512595;15986.840131598681;674.231376231097;803.9276465118153;820.1798201798201;822.3955392786297;828.8176601147737;684.7911387026954;792.2908996448205;812.5368539932211;825.9876101858476;829.9626516806758;867.0679020053436;868.8479516084692;868.9869651955225;869.1786261982429;871.0505548951674;862.965481380744;869.7825543614097;870.0951010948637;870.634333579898;871.094062175337;635.0727937211631;637.971291291893;638.1831255992337;638.2277444292412;638.6647010319573;13410.329483525784;13693.452261909511;13717.382717777724;13760.380782864795;13986.230757308344;12360.876391236063;12755.872441275655;12870.420831062625;13070;13182.802257966137;10166.796664066751;10209.89790102097;10304.845427318596;10424.061834434937;10429.113525350354;3238.1095198820512;3243.4486137356707;3251.6910893465083;3286.293446908926;3336.966630333714;65524.672376638286;66097;67345.66327168333;67489.3251067488;69070.65464672695;9618.903810961801;9701.70894873155;9712.028797120372;9859;10185.134263587677;19004.80995190058;19050.61898762017;19066.428007159808;19079.236830526625;19102.33141840029;6087.726052327567;6265.65538895356;6349;6519.348065193538;6519.706613202417;3658.7987660678386;3731.458938453963;3758.8684396046006;3792.810359482015;3799.4680744695765;2728.890844366203;2776.6667999840147;2795.0915952315577;2797.720227977186;2814.8592570371397;473.6684320975331;477.095903263321;482.17788670317026;487.26666367117264;487.7488093631782;478.55494390216734;503.4361515103108;506.35186960690373;509.72220140023774;515.3146315400509;7703.422243331773;8065.556394398247;8106.432549721463;8357.540335281496;8636.265917396966;550.7081246939129;571.6141604417085;572.853922249832;579.3771695427432;579.4755746049832;3638.508801311842;3834.731568790158;3844.3272427325105;3906.199229158016;3934.6852251819787;52891.20663190055;53586;54041.18938215851;54951.72524137354;61403;53192;56085.43914560802;56241.15638265429;57061;57881;41207;46721.29918051232;48968.75515622399;49761.50238497568;49927.500724992286;8504.489730616182;9111.407758495676;9113.908860911572;9129.45223286605;9171.954140229524;36289.45565816568;36704.63295367012;37786.62213377831;37889;38076.809615951744;34317.48523772195;44171;44464.11071778611;45349.319760204286;46496.53503465057;11114.610988615359;11135.33188008722;11286.943565282121;11286.943565282121;11625.418729063682;11933.28400295985;11977.341246231541;12161.33112678811;12241.938790305992;12371.381430928237;11073.501692423699;11940.940295298467;11973;11992.340421276913;12100.878991209975;10192.541335640062;10732.302400343953;10819.621313253998;11127.944360278147;11134.33194008362;10359.482025898524;10924.344539327349;11034.503447345049;11167.441627918734;11283;9482.309383545788;10228.846567301645;10364.481775911023;10371;10371.636992705218;8869.955650221707;9459.858102128612;9472.384295020802;9521.952390238004;9599.760005999626 11:30:11 INFO - PROCESS | 21455 | __end_tp_report 11:30:11 INFO - PROCESS | 21455 | __start_cc_report 11:30:11 INFO - PROCESS | 21455 | _x_x_mozilla_cycle_collect,339 11:30:11 INFO - PROCESS | 21455 | __end_cc_report 11:30:11 INFO - PROCESS | 21455 | __startTimestamp1482867011350__endTimestamp 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | ------- Summary: start ------- 11:30:11 INFO - PROCESS | 21455 | Number of tests: 6 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#0] dojo.html Cycles:165 Average:4757.45 Median:4888.00 stddev:491.29 (10.1%) stddev-sans-first:463.38 11:30:11 INFO - PROCESS | 21455 | Values: 2622.9 2623.8 2634.1 2642.2 2664.5 4746.0 4849.0 4903.7 4907.2 4914.2 4778.7 4845.1 4874.3 4905.0 4945.4 4433.5 4493.9 4516.6 4534.3 4586.0 4128.3 4593.8 4594.1 4594.5 4617.7 4404.5 4469.6 4493.8 4522.6 4581.2 4410.6 4435.8 4441.8 4498.6 4539.5 4416.7 4420.6 4448.3 4462.7 4465.9 4793.4 4809.7 4813.4 4820.2 4835.6 5038.2 5083.4 5124.6 5134.6 5151.7 5214.0 5215.9 5220.0 5227.5 5257.0 4865.6 4888.0 4891.5 4897.2 4928.9 5168.3 5229.7 5237.9 5284.6 5324.3 5015.3 5026.6 5031.7 5069.4 5077.3 5026.8 5121.8 5166.5 5199.8 5212.2 4995.3 5004.4 5009.0 5021.0 5065.1 5035.8 5049.3 5063.9 5066.7 5067.4 4371.0 4396.9 4400.2 4433.3 4518.1 3799.4 3825.4 3844.1 3851.7 3854.3 4401.0 4411.7 4417.4 4434.5 4455.9 5160.1 5160.3 5165.0 5167.5 5171.2 4334.7 4376.2 4396.6 4426.1 4456.0 4705.8 4754.4 4761.7 4776.1 4811.0 4884.0 4886.4 4891.5 4903.6 4938.7 5093.0 5158.3 5240.6 5258.2 5302.5 4730.9 4764.6 4769.4 4782.8 4821.6 4968.7 5010.1 5020.7 5021.1 5045.5 5026.7 5070.7 5111.0 5111.4 5140.5 4879.5 4946.0 4963.5 4971.9 5048.9 4963.2 4966.1 4975.4 4978.7 5022.8 4798.9 4849.8 4856.8 4867.6 4890.7 4965.5 4970.9 4979.6 5040.2 5042.5 4833.4 4835.8 4837.9 4852.7 4908.8 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#1] ext.html Cycles:180 Average:47028.35 Median:36703.45 stddev:92022.52 (250.7%) stddev-sans-first:92214.37 11:30:11 INFO - PROCESS | 21455 | Values: 505.9 514.6 535.9 538.4 546.2 34133.1 37971.7 37984.0 38068.0 38084.4 38180.2 38251.4 38712.4 38776.0 38925.2 7470.4 7648.9 7673.2 9273.4 9619.7 9483.8 9596.4 9604.2 9604.6 9605.7 9598.6 9606.7 9644.1 9682.3 9682.6 9455.4 9500.1 9531.2 9535.2 9575.7 9438.0 9541.7 9544.7 9567.9 9573.9 32106.8 32765.2 32767.5 32822.5 32925.7 3634.6 3683.3 3695.1 3713.8 3765.4 25040.6 25840.0 26492.5 26534.1 26629.6 3109.5 3156.0 3266.6 3287.1 3291.7 249429.0 250876.0 251504.0 251577.0 252827.0 45825.3 46231.5 46251.8 46470.3 46535.8 47866.3 47913.0 47948.8 47949.0 48093.5 12498.7 12882.4 12889.4 12890.0 12943.7 8966.1 9124.2 9770.4 10075.3 10095.9 15505.7 15591.4 15611.1 15687.8 15805.4 6428.9 6544.7 6632.8 6640.7 6854.9 774.6 789.5 810.4 812.2 822.9 27241.9 27316.9 27671.2 27675.2 27737.2 925.5 935.2 943.0 943.0 949.7 14057.6 14653.7 14770.7 14779.4 14842.2 361099.0 380968.0 381916.0 385918.0 591866.0 43405.8 44080.6 44248.6 44248.8 44261.8 1193.1 1212.2 1222.0 1223.2 1232.8 25152.1 25703.0 26157.3 26161.6 26458.0 37927.2 38021.0 38066.4 38385.6 38466.4 335868.0 337707.0 338757.0 339274.0 339490.0 22533.4 23041.5 23629.4 23685.6 23754.2 36665.6 36741.3 36968.8 36973.4 37264.3 31254.2 31291.8 31375.1 31586.5 31726.5 30251.7 30831.8 30973.7 31287.2 31905.4 29804.9 29855.4 30276.7 30440.2 30649.8 25600.4 28280.4 28434.7 28589.7 28865.6 21020.5 21465.0 21554.0 21638.8 21691.2 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#2] jquery.html Cycles:180 Average:22400.47 Median:26105.35 stddev:57255.14 (219.3%) stddev-sans-first:57391.85 11:30:11 INFO - PROCESS | 21455 | Values: 365.4 375.7 379.3 383.9 391.4 15731.1 16804.2 17334.0 17355.7 17381.4 15336.0 15453.5 15488.8 15503.3 15822.1 4849.0 5126.2 5151.9 5156.3 5170.2 3958.0 4132.5 5073.9 5919.1 6205.8 6159.6 6166.6 6179.7 6181.1 6190.4 5928.3 6060.1 6072.0 6083.3 6085.6 4662.7 5339.7 5363.9 5367.1 5369.4 12094.3 12451.9 12485.2 12494.6 12504.1 2141.9 2157.6 2192.3 2229.5 2442.8 8860.5 8913.2 9141.8 9248.7 9505.1 1544.5 1585.7 1589.6 1609.1 1626.6 62785.0 64101.0 66557.7 66631.0 70181.6 9807.6 9872.0 9962.6 10152.7 10200.9 13787.6 13788.9 13807.9 13809.4 13834.9 6760.0 6932.7 6987.5 7127.8 7208.8 6553.1 6600.4 6626.3 6646.8 6821.5 4301.6 4346.5 4353.1 4379.8 4407.0 1482.2 1588.7 1606.4 1836.6 1890.3 933.4 940.3 984.4 988.4 990.1 15892.4 16041.3 16375.7 16527.6 16820.0 932.3 939.9 963.5 967.4 971.1 8847.5 9189.8 9255.5 9262.8 9454.6 341015.0 345065.0 347215.0 347940.0 349015.0 69831.0 71582.0 72105.6 72984.6 73410.3 893.7 896.0 915.1 926.6 928.5 14352.7 14496.9 14565.0 14788.4 14916.0 33436.7 33779.8 34537.5 34737.1 35058.0 47548.0 48906.5 48957.5 48995.0 49224.3 6853.3 6973.9 7021.9 7077.0 7183.6 7471.4 9309.6 9934.0 11095.3 11526.5 10450.7 10682.7 10709.8 10807.2 11004.9 10178.7 10465.8 10797.3 10820.8 10839.9 10287.5 10670.9 10680.7 10801.8 10953.3 7742.8 7838.8 7871.5 7948.2 8029.7 9321.4 10145.7 10313.8 10601.3 10757.4 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#3] mootools.html Cycles:180 Average:4772.52 Median:4814.31 stddev:2605.16 (54.1%) stddev-sans-first:2599.38 11:30:11 INFO - PROCESS | 21455 | Values: 1298.2 1314.0 1315.2 1324.3 1334.4 6454.5 6652.6 6907.5 7311.1 7315.8 7053.5 7272.5 7280.9 7515.9 7557.3 2113.7 2122.2 2145.5 2146.8 2148.8 2113.7 2147.7 2167.9 2171.4 2227.0 2154.5 2192.6 2203.3 2204.3 2208.6 2115.0 2120.1 2127.1 2133.3 2137.6 2158.6 2166.3 2172.1 2184.6 2191.4 7404.0 7503.1 7554.5 7556.1 7561.4 4516.9 4656.1 4657.2 4657.8 4670.7 2687.9 2819.9 2898.1 2917.9 2968.4 1049.8 1062.7 1082.5 1089.9 1111.5 9802.8 9817.0 9871.3 9879.8 9886.7 3863.7 3993.5 4038.2 4101.1 4113.2 7671.6 7685.4 7714.7 7760.1 7786.9 4461.1 4530.5 4553.5 4555.6 4574.4 4133.5 4160.6 4176.4 4238.8 4245.6 3014.9 3019.0 3077.5 3095.8 3173.9 984.8 1013.0 1023.0 1030.9 1054.4 773.6 791.3 791.5 792.6 800.2 4718.9 4724.8 4777.2 4864.8 4897.4 843.6 843.9 848.9 850.8 852.5 3125.3 3263.1 3332.7 3344.9 3375.8 8671.5 8840.5 8937.9 8953.6 8992.9 8113.6 8451.5 8877.4 8879.2 8915.6 6652.9 6758.2 6835.9 6843.1 6868.2 4583.6 4724.2 4781.5 4805.8 4822.8 7992.0 8011.8 8032.6 8103.0 8130.4 8259.1 8414.6 8425.4 8474.4 8476.4 6391.3 6583.8 6609.1 6623.6 6628.7 6560.1 6863.9 6941.9 6942.4 6945.0 6310.7 6367.9 6500.3 6516.9 6600.5 6299.7 6352.0 6376.0 6400.0 6403.4 5241.9 5360.5 5419.2 5564.8 5600.4 3935.3 3951.9 3957.9 3969.4 3988.1 3992.3 4003.2 4041.8 4067.2 4088.0 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#4] prototype.html Cycles:180 Average:4362.75 Median:4864.69 stddev:1223.01 (25.1%) stddev-sans-first:1188.65 11:30:11 INFO - PROCESS | 21455 | Values: 343.3 354.1 354.7 354.9 359.8 4998.5 5019.7 5020.8 5036.0 5039.9 4967.2 4991.7 4991.8 4998.4 5023.6 3832.0 3905.0 3922.8 4009.8 4018.0 3999.5 4013.0 4015.2 4022.1 4027.2 4000.4 4001.9 4007.0 4019.3 4035.5 3925.4 3976.9 4013.2 4035.7 4047.0 3574.9 3591.0 3597.4 3602.8 3603.8 4823.9 4836.5 4851.8 4862.6 4866.8 4497.6 4590.0 4597.5 4604.6 4621.6 5189.9 5192.8 5244.6 5246.6 5268.9 3953.7 3961.3 3970.5 3981.3 3992.3 5327.6 5530.3 5536.3 5555.3 5559.7 3971.0 3973.5 3982.0 4021.8 4039.1 4014.2 4063.3 4074.9 4081.1 4094.6 4535.7 4541.8 4544.0 4547.5 4567.3 5090.7 5206.9 5212.4 5249.7 5274.9 1387.5 1387.5 1387.8 1394.3 1397.6 957.8 982.9 1013.5 1015.2 1021.3 4351.7 4432.7 4465.5 4541.1 4542.7 5376.8 5381.4 5383.9 5385.2 5388.2 4529.2 4536.2 4542.3 4567.2 4568.8 2655.7 2763.4 2763.5 2774.6 2783.5 4833.6 4834.3 4838.9 4849.5 4871.6 5190.9 5322.6 5334.2 5342.0 5366.6 4978.5 4999.6 5008.9 5010.8 5011.9 5359.3 5398.8 5418.5 5437.6 5452.5 5154.1 5167.5 5188.4 5315.3 5321.5 4919.5 4931.9 4947.4 4981.7 5008.1 3765.8 3795.2 3795.4 3819.3 3838.6 5091.9 5360.8 5375.5 5390.5 5467.7 5188.8 5191.2 5207.7 5210.5 5215.2 5151.3 5205.2 5205.2 5208.2 5212.6 4878.5 5091.0 5094.5 5094.9 5095.3 5054.8 5183.9 5215.4 5219.0 5235.9 5091.5 5108.9 5112.2 5119.2 5126.9 11:30:11 INFO - PROCESS | 21455 | 11:30:11 INFO - PROCESS | 21455 | [#5] yui.html Cycles:180 Average:14466.69 Median:46608.92 stddev:17631.47 (37.8%) stddev-sans-first:17650.46 11:30:11 INFO - PROCESS | 21455 | Values: 662.9 676.5 735.9 742.1 771.0 12627.4 12878.5 13470.1 13484.5 13486.9 14902.6 15895.6 15930.8 15945.4 15986.8 674.2 803.9 820.2 822.4 828.8 684.8 792.3 812.5 826.0 830.0 867.1 868.8 869.0 869.2 871.1 863.0 869.8 870.1 870.6 871.1 635.1 638.0 638.2 638.2 638.7 13410.3 13693.5 13717.4 13760.4 13986.2 12360.9 12755.9 12870.4 13070.0 13182.8 10166.8 10209.9 10304.8 10424.1 10429.1 3238.1 3243.4 3251.7 3286.3 3337.0 65524.7 66097.0 67345.7 67489.3 69070.7 9618.9 9701.7 9712.0 9859.0 10185.1 19004.8 19050.6 19066.4 19079.2 19102.3 6087.7 6265.7 6349.0 6519.3 6519.7 3658.8 3731.5 3758.9 3792.8 3799.5 2728.9 2776.7 2795.1 2797.7 2814.9 473.7 477.1 482.2 487.3 487.7 478.6 503.4 506.4 509.7 515.3 7703.4 8065.6 8106.4 8357.5 8636.3 550.7 571.6 572.9 579.4 579.5 3638.5 3834.7 3844.3 3906.2 3934.7 52891.2 53586.0 54041.2 54951.7 61403.0 53192.0 56085.4 56241.2 57061.0 57881.0 41207.0 46721.3 48968.8 49761.5 49927.5 8504.5 9111.4 9113.9 9129.5 9172.0 36289.5 36704.6 37786.6 37889.0 38076.8 34317.5 44171.0 44464.1 45349.3 46496.5 11114.6 11135.3 11286.9 11286.9 11625.4 11933.3 11977.3 12161.3 12241.9 12371.4 11073.5 11940.9 11973.0 11992.3 12100.9 10192.5 10732.3 10819.6 11127.9 11134.3 10359.5 10924.3 11034.5 11167.4 11283.0 9482.3 10228.8 10364.5 10371.0 10371.6 8870.0 9459.9 9472.4 9522.0 9599.8 11:30:11 INFO - PROCESS | 21455 | -------- Summary: end -------- 11:30:11 INFO - PROCESS | 21455 | 11:30:12 INFO - TEST-INFO | 21455: exit 0 11:30:12 INFO - TEST-OK | dromaeo_css | took 1119458ms 11:30:12 INFO - TEST-START | kraken 11:30:12 INFO - operating with platform_type : linux_ 11:30:12 INFO - Initialising browser for kraken test... 11:30:12 INFO - TEST-INFO | started process 21808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIOuHLc/profile http://localhost:60801/getInfo.html) 11:30:12 INFO - PROCESS | 21808 | 1482867012721 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 11:30:16 INFO - PROCESS | 21808 | __metrics Screen width/height:1600/1200 11:30:16 INFO - PROCESS | 21808 | colorDepth:24 11:30:16 INFO - PROCESS | 21808 | Browser inner width/height: 1024/697 11:30:16 INFO - PROCESS | 21808 | __metrics 11:30:17 ERROR - PROCESS | 21808 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:30:18 INFO - TEST-INFO | 21808: exit 0 11:30:18 INFO - Browser initialized. 11:30:18 INFO - Running cycle 1/1 for kraken test... 11:30:18 INFO - TEST-INFO | started process 21930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIOuHLc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:30 INFO - PROCESS | 21930 | RSS: Main: 158580736 11:30:30 INFO - PROCESS | 21930 | 11:30:32 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60801/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:33 INFO - PROCESS | 21930 | RSS: Main: 164577280 11:30:33 INFO - PROCESS | 21930 | 11:30:36 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60801/tests/kraken/driver.html?testName=audio-dft) 11:30:37 INFO - PROCESS | 21930 | RSS: Main: 162988032 11:30:37 INFO - PROCESS | 21930 | 11:30:40 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60801/tests/kraken/driver.html?testName=audio-fft) 11:30:40 INFO - PROCESS | 21930 | RSS: Main: 159715328 11:30:40 INFO - PROCESS | 21930 | 11:30:42 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60801/tests/kraken/driver.html?testName=audio-oscillator) 11:30:43 INFO - PROCESS | 21930 | RSS: Main: 160182272 11:30:43 INFO - PROCESS | 21930 | 11:30:45 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:46 INFO - PROCESS | 21930 | RSS: Main: 160354304 11:30:46 INFO - PROCESS | 21930 | 11:30:49 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60801/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:50 INFO - PROCESS | 21930 | RSS: Main: 164827136 11:30:50 INFO - PROCESS | 21930 | 11:30:53 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60801/tests/kraken/driver.html?testName=imaging-desaturate) 11:30:54 INFO - PROCESS | 21930 | RSS: Main: 162033664 11:30:54 INFO - PROCESS | 21930 | 11:30:57 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60801/tests/kraken/driver.html?testName=json-parse-financial) 11:30:57 INFO - PROCESS | 21930 | RSS: Main: 162430976 11:30:57 INFO - PROCESS | 21930 | 11:30:59 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:00 INFO - PROCESS | 21930 | RSS: Main: 162885632 11:31:00 INFO - PROCESS | 21930 | 11:31:02 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:02 INFO - PROCESS | 21930 | RSS: Main: 162799616 11:31:02 INFO - PROCESS | 21930 | 11:31:04 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:05 INFO - PROCESS | 21930 | RSS: Main: 163528704 11:31:05 INFO - PROCESS | 21930 | 11:31:08 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:09 INFO - PROCESS | 21930 | RSS: Main: 163471360 11:31:09 INFO - PROCESS | 21930 | 11:31:12 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:12 INFO - PROCESS | 21930 | RSS: Main: 163688448 11:31:12 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | Cycle 1(1): loaded http://localhost:60801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60801/tests/kraken/driver.html?testName=ai-astar) 11:31:14 INFO - PROCESS | 21930 | RSS: Main: 165715968 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | __start_tp_report 11:31:14 INFO - PROCESS | 21930 | _x_x_mozilla_page_load 11:31:14 INFO - PROCESS | 21930 | _x_x_mozilla_page_load_details 11:31:14 INFO - PROCESS | 21930 | |i|pagename|runs| 11:31:14 INFO - PROCESS | 21930 | |0;ai-astar;107;118;116;115;117;118;117;115;115;115 11:31:14 INFO - PROCESS | 21930 | |1;audio-beat-detection;150;128;137;174;129;133;132;127;151;125 11:31:14 INFO - PROCESS | 21930 | |2;audio-dft;164;164;171;166;163;165;164;172;163;164 11:31:14 INFO - PROCESS | 21930 | |3;audio-fft;77;76;76;116;78;78;76;78;94;78 11:31:14 INFO - PROCESS | 21930 | |4;audio-oscillator;86;86;112;86;85;86;102;86;85;107 11:31:14 INFO - PROCESS | 21930 | |5;imaging-gaussian-blur;119;119;117;118;118;121;118;119;119;118 11:31:14 INFO - PROCESS | 21930 | |6;imaging-darkroom;151;151;152;149;151;150;151;150;151;151 11:31:14 INFO - PROCESS | 21930 | |7;imaging-desaturate;96;95;96;96;96;97;96;97;103;96 11:31:14 INFO - PROCESS | 21930 | |8;json-parse-financial;73;71;71;71;71;74;71;73;72;70 11:31:14 INFO - PROCESS | 21930 | |9;json-stringify-tinderbox;68;69;69;69;68;69;69;68;68;69 11:31:14 INFO - PROCESS | 21930 | |10;stanford-crypto-aes;85;86;85;89;84;90;85;86;86;85 11:31:14 INFO - PROCESS | 21930 | |11;stanford-crypto-ccm;136;133;133;139;144;138;135;145;186;139 11:31:14 INFO - PROCESS | 21930 | |12;stanford-crypto-pbkdf2;176;176;178;176;177;177;181;178;178;175 11:31:14 INFO - PROCESS | 21930 | |13;stanford-crypto-sha256-iterative;70;70;71;69;70;70;69;72;69;68 11:31:14 INFO - PROCESS | 21930 | __end_tp_report 11:31:14 INFO - PROCESS | 21930 | __start_cc_report 11:31:14 INFO - PROCESS | 21930 | _x_x_mozilla_cycle_collect,794 11:31:14 INFO - PROCESS | 21930 | __end_cc_report 11:31:14 INFO - PROCESS | 21930 | __startTimestamp1482867074864__endTimestamp 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | ------- Summary: start ------- 11:31:14 INFO - PROCESS | 21930 | Number of tests: 14 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.50 stddev:3.16 (2.7%) stddev-sans-first:1.30 11:31:14 INFO - PROCESS | 21930 | Values: 107.0 118.0 116.0 115.0 117.0 118.0 117.0 115.0 115.0 115.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:135.00 stddev:15.41 (11.4%) stddev-sans-first:15.79 11:31:14 INFO - PROCESS | 21930 | Values: 150.0 128.0 137.0 174.0 129.0 133.0 132.0 127.0 151.0 125.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:3.24 (2.0%) stddev-sans-first:3.38 11:31:14 INFO - PROCESS | 21930 | Values: 164.0 164.0 171.0 166.0 163.0 165.0 164.0 172.0 163.0 164.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#3] audio-fft Cycles:10 Average:82.70 Median:78.00 stddev:12.88 (16.5%) stddev-sans-first:13.49 11:31:14 INFO - PROCESS | 21930 | Values: 77.0 76.0 76.0 116.0 78.0 78.0 76.0 78.0 94.0 78.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:86.00 stddev:10.56 (12.3%) stddev-sans-first:10.96 11:31:14 INFO - PROCESS | 21930 | Values: 86.0 86.0 112.0 86.0 85.0 86.0 102.0 86.0 85.0 107.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 11:31:14 INFO - PROCESS | 21930 | Values: 119.0 119.0 117.0 118.0 118.0 121.0 118.0 119.0 119.0 118.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 11:31:14 INFO - PROCESS | 21930 | Values: 151.0 151.0 152.0 149.0 151.0 150.0 151.0 150.0 151.0 151.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.25 (2.3%) stddev-sans-first:2.37 11:31:14 INFO - PROCESS | 21930 | Values: 96.0 95.0 96.0 96.0 96.0 97.0 96.0 97.0 103.0 96.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.50 stddev:1.25 (1.8%) stddev-sans-first:1.24 11:31:14 INFO - PROCESS | 21930 | Values: 73.0 71.0 71.0 71.0 71.0 74.0 71.0 73.0 72.0 70.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 11:31:14 INFO - PROCESS | 21930 | Values: 68.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 68.0 69.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:1.99 11:31:14 INFO - PROCESS | 21930 | Values: 85.0 86.0 85.0 89.0 84.0 90.0 85.0 86.0 86.0 85.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:139.00 stddev:15.72 (11.3%) stddev-sans-first:16.48 11:31:14 INFO - PROCESS | 21930 | Values: 136.0 133.0 133.0 139.0 144.0 138.0 135.0 145.0 186.0 139.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:177.50 stddev:1.69 (1.0%) stddev-sans-first:1.73 11:31:14 INFO - PROCESS | 21930 | Values: 176.0 176.0 178.0 176.0 177.0 177.0 181.0 178.0 178.0 175.0 11:31:14 INFO - PROCESS | 21930 | 11:31:14 INFO - PROCESS | 21930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 11:31:14 INFO - PROCESS | 21930 | Values: 70.0 70.0 71.0 69.0 70.0 70.0 69.0 72.0 69.0 68.0 11:31:14 INFO - PROCESS | 21930 | -------- Summary: end -------- 11:31:14 INFO - PROCESS | 21930 | 11:31:15 INFO - TEST-INFO | 21930: exit 0 11:31:16 INFO - TEST-OK | kraken | took 63798ms 11:31:16 INFO - SUITE-END | took 1183s 11:31:16 INFO - Completed test suite (00:19:43) 11:31:16 INFO - javascript benchmark 11:31:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6282.095928165949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.881970311336, 2623.7900967922565, 2634.091238522709, 2642.220544939243, 2664.547027005409, 4745.976270118645, 4849.0, 4903.705777653339, 4907.190313598257, 4914.164592019356, 4778.68938518996, 4845.127876982142, 4874.317595536628, 4905.043516514281, 4945.43127540333, 4433.467983841935, 4493.865184044484, 4516.570925762047, 4534.251848445003, 4585.977070114662, 4128.277551428503, 4593.839215627454, 4594.081183763244, 4594.517575654559, 4617.676762626617, 4404.537523560044, 4469.597736203725, 4493.752843593601, 4522.6155776759015, 4581.221192397301, 4410.647148228134, 4435.8225670973125, 4441.844535441276, 4498.572635599646, 4539.546045395467, 4416.712913660602, 4420.602145806861, 4448.33275008748, 4462.732236065846, 4465.888352791206, 4793.448753393334, 4809.687370320953, 4813.3983252093485, 4820.156472617278, 4835.6131509479155, 5038.244263360525, 5083.415407228179, 5124.564412024983, 5134.614903882224, 5151.742412879378, 5214.035403450336, 5215.947840521584, 5220.0, 5227.451117632631, 5256.973715131438, 4865.5864251538305, 4888.0, 4891.51084891508, 4897.191963326011, 4928.901421971541, 5168.2764412982215, 5229.6600720953775, 5237.895242095136, 5284.630075894727, 5324.334458192726, 5015.27278544609, 5026.597872170218, 5031.74841257943, 5069.44236134025, 5077.289179514797, 5026.79892804291, 5121.769520371592, 5166.535011848951, 5199.844004679866, 5212.218167274863, 4995.25071239317, 5004.399472063303, 5009.0, 5020.974895125574, 5065.062963351792, 5035.84892453227, 5049.31834202378, 5063.873403164876, 5066.670666406671, 5067.366579177603, 4370.950971766753, 4396.868093957187, 4400.163968845973, 4433.268510695699, 4518.051209246029, 3799.4490798834013, 3825.445310429972, 3844.0966372902344, 3851.7496362736333, 3854.2676891390547, 4400.9559904401185, 4411.669124815651, 4417.359482874966, 4434.490033646108, 4455.933161002587, 5160.148575485078, 5160.329157209539, 5165.0, 5167.483251674803, 5171.172612382001, 4334.718243314174, 4376.190404775127, 4396.648268138541, 4426.092651006536, 4456.019675671347, 4705.811767529329, 4754.405699287589, 4761.738104404291, 4776.068666609977, 4811.013742182844, 4884.0, 4886.3647725796845, 4891.5353041461, 4903.583195428429, 4938.6789858659795, 5092.955944031391, 5158.252053452304, 5240.633155679066, 5258.1849813279005, 5302.522772950453, 4730.905381892274, 4764.618830493621, 4769.356136921471, 4782.832600858953, 4821.614270858253, 4968.701877887338, 5010.073136469765, 5020.748962551785, 5021.1213037717525, 5045.5459008689395, 5026.673266237683, 5070.721110338966, 5110.97444512775, 5111.437741848319, 5140.485951404829, 4879.463259041431, 4945.975270123627, 4963.503649635008, 4971.9254211186135, 5048.873778155428, 4963.230699241623, 4966.106100901872, 4975.353204083591, 4978.651494395358, 5022.84931452057, 4798.928016079832, 4849.80600775965, 4856.805727770849, 4867.561919427269, 4890.657653964188, 4965.528274813887, 4970.8757281068265, 4979.576735977337, 5040.243963405372, 5042.546170844642, 4833.419989601271, 4835.758212089311, 4837.9032419350715, 4852.708837469763, 4908.803647854189], "value": 4725.887797449212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.8870484933147, 514.6217530115365, 535.8874636326374, 538.3996843519476, 546.2025442853434, 34133.14667133323, 37971.670991515304, 37983.96128309736, 38068.0, 38084.42873356902, 38180.23639527215, 38251.42622860652, 38712.41931371025, 38776.0, 38925.22149557007, 7470.402367810576, 7648.885266721004, 7673.155952845183, 9273.350865439388, 9619.711408657717, 9483.81032379352, 9596.424214547114, 9604.223218704527, 9604.615815367377, 9605.66380176694, 9598.616055357777, 9606.663766768164, 9644.08381203788, 9682.322237443383, 9682.6444297798, 9455.43267403951, 9500.144986951138, 9531.18984886282, 9535.189508891717, 9575.664851730226, 9437.952810235905, 9541.666041688508, 9544.713658590184, 9567.904320956772, 9573.904260957372, 32106.839465802754, 32765.180870478427, 32767.50848737271, 32822.507662385084, 32925.6707432925, 3634.582023067355, 3683.2817600567632, 3695.113172838526, 3713.832877520518, 3765.435184722286, 25040.624390634155, 25840.0, 26492.470150597073, 26534.07130750434, 26629.600555991674, 3109.455845227076, 3156.0216332936634, 3266.591676040495, 3287.1124796305103, 3291.687289707474, 249429.0, 250876.0, 251504.0, 251577.0, 252827.0, 45825.312620310724, 46231.5376846234, 46251.76874115675, 46470.30294545584, 46535.767321163854, 47866.28200576994, 47913.0, 47948.7602561985, 47949.0, 48093.5190648096, 12498.687532811753, 12882.420291086924, 12889.355532223539, 12890.0, 12943.741125177443, 8966.148215919477, 9124.224440922464, 9770.41377517337, 10075.345102568455, 10095.949520252352, 15505.689886202214, 15591.376344946075, 15611.074802447854, 15687.843121568638, 15805.446809361618, 6428.907085795426, 6544.672766361663, 6632.767853125118, 6640.667966601651, 6854.862902742017, 774.5933384972934, 789.4710543935462, 810.3922058456158, 812.1837553259055, 822.9094799572042, 27241.86379068092, 27316.863415682794, 27671.169864904085, 27675.169744907686, 27737.167884963485, 925.546482223719, 935.1910597333393, 942.9717108486757, 942.9717108486757, 949.6723630347519, 14057.578272651837, 14653.689205337181, 14770.70458590822, 14779.408823647149, 14842.18367989771, 361099.0, 380968.0, 381916.0, 385918.0, 591866.0, 43405.78297108557, 44080.559194407644, 44248.55751442509, 44248.77875610601, 44261.77869110634, 1193.0694058634278, 1212.1636071110904, 1221.993890030562, 1223.2293654997472, 1232.8458942632171, 25152.11967581126, 25703.0, 26157.346066348495, 26161.607575885995, 26458.0, 37927.24145517019, 38021.0, 38066.42900356552, 38385.616143838204, 38466.42300365553, 335868.0, 337707.0, 338757.0, 339274.0, 339490.0, 22533.43666408353, 23041.539169216856, 23629.409264768517, 23685.64471532894, 23754.168604099465, 36665.633343666224, 36741.26517469689, 36968.81515592405, 36973.445398319585, 37264.25471490501, 31254.21864453407, 31291.84354078215, 31375.117492950496, 31586.52620210653, 31726.52410213895, 30251.697483025768, 30831.845840770653, 30973.69026309708, 31287.217819554695, 31905.36189276155, 29804.850975744983, 29855.402891942475, 30276.69723302739, 30440.238994025327, 30649.846750766104, 25600.35999099963, 28280.43439131247, 28434.715652843206, 28589.714102858707, 28865.567016495188, 21020.47448813792, 21465.0, 21554.0, 21638.783612163676, 21691.240806571695], "value": 16818.14145776227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4189838157331, 375.69756346141355, 379.2755836352566, 383.8694843753123, 391.44805823788465, 15731.134787586692, 16804.159792010396, 17334.0, 17355.69832262579, 17381.391651292208, 15336.0, 15453.45912893049, 15488.767668484954, 15503.302351394186, 15822.129782861937, 4848.97575512122, 5126.179811230185, 5151.922721159186, 5156.2781210630355, 5170.172772356424, 3958.0, 4132.5454200037975, 5073.949260507403, 5919.141724449953, 6205.81382558524, 6159.630422174661, 6166.599171053889, 6179.721912513925, 6181.134641150243, 6190.442860142586, 5928.258967629046, 6060.090986352038, 6071.969640151771, 6083.330833608299, 6085.6348619083, 4662.696924699918, 5339.652922560022, 5363.892722145535, 5367.06076436626, 5369.355677318707, 12094.334811585359, 12451.93774031133, 12485.188462749893, 12494.562690305796, 12504.124711270215, 2141.860779049357, 2157.5792720419527, 2192.320380681994, 2229.5317983223545, 2442.829001969863, 8860.512671803048, 8913.153250441197, 9141.771455713593, 9248.676296329664, 9505.097015783489, 1544.482598329561, 1585.6670099279165, 1589.5867074560697, 1609.139110575848, 1626.6014826367498, 62784.97720182374, 64101.0, 66557.66721166363, 66631.0005349925, 70181.64909175472, 9807.605816800731, 9871.963443838436, 9962.601495940082, 10152.73090863642, 10200.948995254976, 13787.586372408843, 13788.862111378958, 13807.930960345135, 13809.378577964017, 13834.861651383559, 6760.005798289516, 6932.6533673316135, 6987.475939304572, 7127.786166415016, 7208.783736487913, 6553.082568440422, 6600.405963463215, 6626.337366263335, 6646.767363142267, 6821.488388370892, 4301.591348821857, 4346.521882592975, 4353.06409122034, 4379.846705365297, 4406.9779651101535, 1482.1551715522264, 1588.7299159142974, 1606.3895719626466, 1836.6234921841258, 1890.3005887821319, 933.355984370782, 940.3041749105613, 984.4437892590663, 988.3822610868208, 990.1089019882164, 15892.443764468188, 16041.278142483616, 16375.672486550202, 16527.586810329838, 16820.0, 932.3333816321363, 939.8966113727485, 963.4989805301344, 967.3953778888194, 971.13568923658, 8847.46915185091, 9189.81620367589, 9255.490947997925, 9262.814743705088, 9454.57454414553, 341015.0, 345065.0, 347215.0, 347940.0, 349015.0, 69831.0, 71582.0, 72105.55788884193, 72984.63507682427, 73410.26589734034, 893.6738090596886, 895.9552022398854, 915.1397686174975, 926.6478738079621, 928.461492334458, 14352.712945740817, 14496.855031449972, 14565.0, 14788.408463661333, 14916.0, 33436.66563334336, 33779.831100845324, 34537.48193777146, 34737.1315717099, 35058.0, 47548.0, 48906.5109348902, 48957.51042489529, 48995.0, 49224.261636076204, 6853.314668533107, 6973.860522789414, 7021.929780702332, 7077.0, 7183.640817959185, 7471.40228781707, 9309.581068852054, 9934.0, 11095.278806877526, 11526.538938442369, 10450.738731531468, 10682.732931676459, 10709.785804284027, 10807.189460790314, 11004.944975275072, 10178.745531361776, 10465.790684186426, 10797.29817561856, 10820.837687434538, 10839.891601083888, 10287.53706083243, 10670.89329106699, 10680.679579612624, 10801.783964320512, 10953.34279943206, 7742.8451430969935, 7838.843223135391, 7871.48835325702, 7948.205179482236, 8029.7189598363775, 9321.394109382869, 10145.746356340855, 10313.793724125626, 10601.25791194609, 10757.408342541235], "value": 8003.758848678408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.1886321049344, 1313.9934300328503, 1315.217445619857, 1324.3047400114938, 1334.3595074364305, 6454.483641308696, 6652.567583107095, 6907.516473846833, 7311.086114235721, 7315.817104572388, 7053.541519801222, 7272.527285726424, 7280.890786638205, 7515.887261691079, 7557.319841214304, 2113.651247544153, 2122.1829595605727, 2145.5279838435517, 2146.8389870759756, 2148.838837087225, 2113.693514440405, 2147.6671115977047, 2167.902444390006, 2171.4028642123462, 2226.955460890781, 2154.5475450155486, 2192.572448372568, 2203.2729199364253, 2204.2946257197705, 2208.5803697297542, 2114.968275475877, 2120.130746393979, 2127.117246342766, 2133.28534940795, 2137.6472881974455, 2158.557495713391, 2166.2526428382184, 2172.0660116150048, 2184.6176919039103, 2191.41927389242, 7404.0, 7503.099628044615, 7554.546727196386, 7556.093268807724, 7561.432892533082, 4516.909661806778, 4656.138614356355, 4657.208274593293, 4657.836975705834, 4670.743109129031, 2687.852168130752, 2819.8590070496393, 2898.0581311073984, 2917.897873574415, 2968.421157874215, 1049.7690508088208, 1062.7024433158729, 1082.4966390628394, 1089.929154604956, 1111.4664960818852, 9802.803943921082, 9817.0, 9871.309008369417, 9879.80240395188, 9886.653967111188, 3863.74885632433, 3993.5207775066597, 4038.212548553004, 4101.1387608601935, 4113.218488487178, 7671.578063206577, 7685.42359323053, 7714.652840622185, 7760.146383897767, 7786.922130778733, 4461.107778444324, 4530.456345238593, 4553.453585569687, 4555.63554915606, 4574.359589657451, 4133.46264985556, 4160.625543701021, 4176.373543968429, 4238.830446782094, 4245.57544245573, 3014.9397012059635, 3019.04899956513, 3077.461444247248, 3095.845207739604, 3173.8571764270664, 984.7735020945223, 1013.0, 1022.9539670714836, 1030.9381437113798, 1054.4411461925192, 773.6441237030916, 791.2641243643467, 791.4578513718121, 792.5878543157526, 800.1518390505965, 4718.88202794926, 4724.763761811896, 4777.211760059621, 4864.80540778372, 4897.436794768576, 843.6372359885186, 843.9409241353169, 848.8854004709409, 850.8043150075517, 852.4672079950032, 3125.312431265118, 3263.0863358259726, 3332.7333813294877, 3344.916377090592, 3375.8480868360984, 8671.479711217347, 8840.469571825583, 8937.910620893708, 8953.552322383855, 8992.910070899206, 8113.634886430124, 8451.492910425393, 8877.378583499092, 8879.179768147515, 8915.55422228886, 6652.900206496906, 6758.155230596176, 6835.93164068353, 6843.076184715, 6868.175818901764, 4583.564561366665, 4724.1732696777235, 4781.545753153445, 4805.831795887128, 4822.7829747660735, 7992.0, 8011.83976320482, 8032.598370081356, 8102.959485202537, 8130.390220733587, 8259.132791056853, 8414.579271036302, 8425.410221284452, 8474.449160804528, 8476.406651534333, 6391.296957334783, 6583.769568065095, 6609.074729537965, 6623.635700036544, 6628.668566571749, 6560.147180866456, 6863.897041544481, 6941.895871561829, 6942.444604431533, 6945.027696122446, 6310.6844657766005, 6367.90448143269, 6500.28496865335, 6516.869662606816, 6600.537962342782, 6299.685015749103, 6352.047192921099, 6375.968120159555, 6399.968000159969, 6403.359664033559, 5241.921371179359, 5360.490753378423, 5419.214213939035, 5564.777408903598, 5600.411956744483, 3935.3309937311296, 3951.881443556583, 3957.9313585331224, 3969.4045893116263, 3988.0827409695353, 3992.301347264275, 4003.2393845169327, 4041.81811818463, 4067.1865626875333, 4087.9560219890054], "value": 3891.806210436916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.27568829769183, 354.09881850689993, 354.6790154909804, 354.91127218195453, 359.84526653538984, 4998.500149985004, 5019.723915184663, 5020.799168033279, 5035.9748201259035, 5039.924401133986, 4967.230079337708, 4991.700497970124, 4991.800327986885, 4998.400191976968, 5023.648344615878, 3832.030176613126, 3904.9804750976205, 3922.8038598070125, 4009.83960641574, 4017.9754162688473, 3999.520057593093, 4012.996750812297, 4015.1969606078756, 4022.135240923201, 4027.154297597508, 4000.359942409215, 4001.9399709004388, 4006.9599304007024, 4019.296623090962, 4035.515738111431, 3925.4308125321954, 3976.926229917906, 4013.237484877893, 4035.7287454451753, 4046.9797651011704, 3574.8748793792092, 3590.964090359089, 3597.399157374969, 3602.8018458984743, 3603.765755225902, 4823.879403014917, 4836.492168322346, 4851.830185943475, 4862.562369386772, 4866.812237984091, 4497.5952164305045, 4589.967257367099, 4597.494275629678, 4604.631629469634, 4621.607163391116, 5189.949969761923, 5192.766325515361, 5244.554212891909, 5246.606504512177, 5268.894622107575, 3953.7348048624453, 3961.2671655743493, 3970.5235371755284, 3981.30327192743, 3992.321305378093, 5327.561558379216, 5530.336359636829, 5536.252605898233, 5555.2500412444615, 5559.6664200148125, 3970.960290397059, 3973.5297939761895, 3981.960180398159, 4021.7586944783407, 4039.131586708813, 4014.157027024299, 4063.313724804232, 4074.898127546835, 4081.1429599783783, 4094.5905409458815, 4535.727856328631, 4541.818327266872, 4544.0, 4547.545245475492, 4567.269236922077, 5090.720010399389, 5206.895862082737, 5212.4266330703595, 5249.737513124329, 5274.868128296824, 1387.4519564771858, 1387.5213051497217, 1387.8195834541445, 1394.316784775473, 1397.5807257822612, 957.8419560772395, 982.8918818929913, 1013.4848401639596, 1015.2030655935056, 1021.2902033087082, 4351.673624478177, 4432.689711720213, 4465.486469056035, 4541.137183935041, 4542.659300552472, 5376.843978544632, 5381.354237491526, 5383.865403364947, 5385.219143224211, 5388.164834450667, 4529.207388706963, 4536.183486972311, 4542.31865220213, 4567.1779079765965, 4568.771561421916, 2655.694595121547, 2763.392053748172, 2763.5301998660275, 2774.597683335905, 2783.4711404833015, 4833.637477189225, 4834.323194752737, 4838.854834354975, 4849.515048495122, 4871.585915197248, 5190.896182076337, 5322.604827827493, 5334.199870019528, 5341.973290133525, 5366.6243362964215, 4978.5270399312, 4999.600031997432, 5008.874778130576, 5010.824621138243, 5011.924821127686, 5359.276497672764, 5398.78404863801, 5418.512333889968, 5437.592180586393, 5452.537638599597, 5154.123798954111, 5167.534921857051, 5188.403333616682, 5315.255864179096, 5321.536577441235, 4919.458859525521, 4931.901361972812, 4947.356843610308, 4981.71207003376, 5008.148614735431, 3765.8493660253284, 3795.2409518095938, 3795.4306853972125, 3819.3264714699267, 3838.6353296436796, 5091.87270318245, 5360.839174824761, 5375.489328513785, 5390.4879036491475, 5467.72661366938, 5188.818391356435, 5191.22131680251, 5207.71357575337, 5210.525000624673, 5215.217717342277, 5151.330327057459, 5205.193195054772, 5205.245239440335, 5208.192730126836, 5212.582993360446, 4878.463369029475, 5091.0, 5094.497123348695, 5094.923576146287, 5095.337606111182, 5054.848354549369, 5183.867970708896, 5215.426303106731, 5218.973905130602, 5235.921461178162, 5091.516305950929, 5108.897822043613, 5112.233165025276, 5119.180931051014, 5126.871828204325], "value": 3991.725375059564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.9469642428603, 676.4689718570922, 735.8528294341133, 742.1317059040922, 770.9831776444724, 12627.431765570549, 12878.484860605588, 13470.12444191128, 13484.528041518537, 13486.932565337183, 14902.627434314147, 15895.602609934758, 15930.840691593081, 15945.362185512595, 15986.840131598681, 674.231376231097, 803.9276465118153, 820.1798201798201, 822.3955392786297, 828.8176601147737, 684.7911387026954, 792.2908996448205, 812.5368539932211, 825.9876101858476, 829.9626516806758, 867.0679020053436, 868.8479516084692, 868.9869651955225, 869.1786261982429, 871.0505548951674, 862.965481380744, 869.7825543614097, 870.0951010948637, 870.634333579898, 871.094062175337, 635.0727937211631, 637.971291291893, 638.1831255992337, 638.2277444292412, 638.6647010319573, 13410.329483525784, 13693.452261909511, 13717.382717777724, 13760.380782864795, 13986.230757308344, 12360.876391236063, 12755.872441275655, 12870.420831062625, 13070.0, 13182.802257966137, 10166.796664066751, 10209.89790102097, 10304.845427318596, 10424.061834434937, 10429.113525350354, 3238.1095198820512, 3243.4486137356707, 3251.6910893465083, 3286.293446908926, 3336.966630333714, 65524.672376638286, 66097.0, 67345.66327168333, 67489.3251067488, 69070.65464672695, 9618.903810961801, 9701.70894873155, 9712.028797120372, 9859.0, 10185.134263587677, 19004.80995190058, 19050.61898762017, 19066.428007159808, 19079.236830526625, 19102.33141840029, 6087.726052327567, 6265.65538895356, 6349.0, 6519.348065193538, 6519.706613202417, 3658.7987660678386, 3731.458938453963, 3758.8684396046006, 3792.810359482015, 3799.4680744695765, 2728.890844366203, 2776.6667999840147, 2795.0915952315577, 2797.720227977186, 2814.8592570371397, 473.6684320975331, 477.095903263321, 482.17788670317026, 487.26666367117264, 487.7488093631782, 478.55494390216734, 503.4361515103108, 506.35186960690373, 509.72220140023774, 515.3146315400509, 7703.422243331773, 8065.556394398247, 8106.432549721463, 8357.540335281496, 8636.265917396966, 550.7081246939129, 571.6141604417085, 572.853922249832, 579.3771695427432, 579.4755746049832, 3638.508801311842, 3834.731568790158, 3844.3272427325105, 3906.199229158016, 3934.6852251819787, 52891.20663190055, 53586.0, 54041.18938215851, 54951.72524137354, 61403.0, 53192.0, 56085.43914560802, 56241.15638265429, 57061.0, 57881.0, 41207.0, 46721.29918051232, 48968.75515622399, 49761.50238497568, 49927.500724992286, 8504.489730616182, 9111.407758495676, 9113.908860911572, 9129.45223286605, 9171.954140229524, 36289.45565816568, 36704.63295367012, 37786.62213377831, 37889.0, 38076.809615951744, 34317.48523772195, 44171.0, 44464.11071778611, 45349.319760204286, 46496.53503465057, 11114.610988615359, 11135.33188008722, 11286.943565282121, 11286.943565282121, 11625.418729063682, 11933.28400295985, 11977.341246231541, 12161.33112678811, 12241.938790305992, 12371.381430928237, 11073.501692423699, 11940.940295298467, 11973.0, 11992.340421276913, 12100.878991209975, 10192.541335640062, 10732.302400343953, 10819.621313253998, 11127.944360278147, 11134.33194008362, 10359.482025898524, 10924.344539327349, 11034.503447345049, 11167.441627918734, 11283.0, 9482.309383545788, 10228.846567301645, 10364.481775911023, 10371.0, 10371.636992705218, 8869.955650221707, 9459.858102128612, 9472.384295020802, 9521.952390238004, 9599.760005999626], "value": 6218.887771553589, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 116.0, 115.0, 117.0, 118.0, 117.0, 115.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 137.0, 174.0, 129.0, 133.0, 132.0, 127.0, 151.0, 125.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 171.0, 166.0, 163.0, 165.0, 164.0, 172.0, 163.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 116.0, 78.0, 78.0, 76.0, 78.0, 94.0, 78.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 112.0, 86.0, 85.0, 86.0, 102.0, 86.0, 85.0, 107.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 118.0, 121.0, 118.0, 119.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 149.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 103.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 71.0, 71.0, 74.0, 71.0, 73.0, 72.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 89.0, 84.0, 90.0, 85.0, 86.0, 86.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 133.0, 139.0, 144.0, 138.0, 135.0, 145.0, 186.0, 139.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 178.0, 176.0, 177.0, 177.0, 181.0, 178.0, 178.0, 175.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 69.0, 70.0, 70.0, 69.0, 72.0, 69.0, 68.0], "value": 69.8, "unit": "score"}]}]} 11:31:16 INFO - Return code: 0 11:31:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:31:16 ERROR - # TBPL SUCCESS # 11:31:16 INFO - Running post-action listener: _resource_record_post_action 11:31:16 INFO - [mozharness: 2016-12-27 19:31:16.191127Z] Finished run-tests step (success) 11:31:16 INFO - Running post-run listener: _resource_record_post_run 11:31:16 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393613312; Read time: 12; Write time: 247556 11:31:16 INFO - TinderboxPrint: CPU usage
13.5% 11:31:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:31:16 INFO - TinderboxPrint: I/O write bytes / time
393,613,312 / 247,556 11:31:16 INFO - TinderboxPrint: CPU idle
8,285.1 (86.5%) 11:31:16 INFO - TinderboxPrint: CPU user
1,231.3 (12.9%) 11:31:16 INFO - TinderboxPrint: Swap in / out
0 / 0 11:31:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110571520; Read time: 0; Write time: 63776 11:31:16 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283041792; Read time: 0; Write time: 183780 11:31:16 INFO - Running post-run listener: _upload_blobber_files 11:31:16 INFO - Blob upload gear active. 11:31:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:31:17 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:20 INFO - (blobuploader) - INFO - Done attempting. 11:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:21 INFO - (blobuploader) - INFO - Done attempting. 11:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:22 INFO - (blobuploader) - INFO - Done attempting. 11:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:22 INFO - (blobuploader) - INFO - Done attempting. 11:31:22 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:22 INFO - Return code: 0 11:31:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6501b8d87ed1a2a0207223a7d594d1827a646d7e42db383953f44417ef7929267f15055a493c1b6fdd823aee724537d695bd5ef1f90bb0c181debcc14d6ad51f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aba85f6c4c92c64eab237546c94f3a2245072dceca72b45a4e88b2d6123c584c174b257b6d75ba3adf7eccb020e831bdc6d345affdeaa242abd79775320b59f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f0f60a28b03ccd5f1fceda75e402a3cfe621533484ec245ff7c1f7ad7c8c31b163ce8aad38e42fca942f566c94c6402a792ee0af8466261bfd6bf89cef00f89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad694b95f8170cadd4c81d55699d1e92744bfc9336773ebe963675a553fbd1c0559a0fd04fb88228fe8c7e5b4a00e650c266e27d357c9be31b34514975215917"} 11:31:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:22 INFO - Contents: 11:31:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6501b8d87ed1a2a0207223a7d594d1827a646d7e42db383953f44417ef7929267f15055a493c1b6fdd823aee724537d695bd5ef1f90bb0c181debcc14d6ad51f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aba85f6c4c92c64eab237546c94f3a2245072dceca72b45a4e88b2d6123c584c174b257b6d75ba3adf7eccb020e831bdc6d345affdeaa242abd79775320b59f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f0f60a28b03ccd5f1fceda75e402a3cfe621533484ec245ff7c1f7ad7c8c31b163ce8aad38e42fca942f566c94c6402a792ee0af8466261bfd6bf89cef00f89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad694b95f8170cadd4c81d55699d1e92744bfc9336773ebe963675a553fbd1c0559a0fd04fb88228fe8c7e5b4a00e650c266e27d357c9be31b34514975215917"} 11:31:22 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:22 INFO - Copying logs to upload dir... 11:31:22 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.409676 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-27 11:31:22.075292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 11:31:22.083048) ========= 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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 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/6501b8d87ed1a2a0207223a7d594d1827a646d7e42db383953f44417ef7929267f15055a493c1b6fdd823aee724537d695bd5ef1f90bb0c181debcc14d6ad51f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aba85f6c4c92c64eab237546c94f3a2245072dceca72b45a4e88b2d6123c584c174b257b6d75ba3adf7eccb020e831bdc6d345affdeaa242abd79775320b59f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f0f60a28b03ccd5f1fceda75e402a3cfe621533484ec245ff7c1f7ad7c8c31b163ce8aad38e42fca942f566c94c6402a792ee0af8466261bfd6bf89cef00f89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad694b95f8170cadd4c81d55699d1e92744bfc9336773ebe963675a553fbd1c0559a0fd04fb88228fe8c7e5b4a00e650c266e27d357c9be31b34514975215917"} build_url:https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011591 build_url: 'https://queue.taskcluster.net/v1/task/AtSqGWIzSKSlNBraD7c1Xg/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/6501b8d87ed1a2a0207223a7d594d1827a646d7e42db383953f44417ef7929267f15055a493c1b6fdd823aee724537d695bd5ef1f90bb0c181debcc14d6ad51f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aba85f6c4c92c64eab237546c94f3a2245072dceca72b45a4e88b2d6123c584c174b257b6d75ba3adf7eccb020e831bdc6d345affdeaa242abd79775320b59f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f0f60a28b03ccd5f1fceda75e402a3cfe621533484ec245ff7c1f7ad7c8c31b163ce8aad38e42fca942f566c94c6402a792ee0af8466261bfd6bf89cef00f89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad694b95f8170cadd4c81d55699d1e92744bfc9336773ebe963675a553fbd1c0559a0fd04fb88228fe8c7e5b4a00e650c266e27d357c9be31b34514975215917"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 11:31:22.111213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:31:22.111585) ========= 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=232498196343f89f466a4a9a000001c8-1482865163.98893-2122033053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 11:31:22.192355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 11:31:22.195721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 11:31:22.196041) ========= ========= Total master_lag: 0.21 =========