builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1484305606.05 results: success (0) revision: 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.047646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.048114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.048385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.062864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.063199) ========= 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=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-13 03:06:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.0M=0s 2017-01-13 03:06:46 (51.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.223826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.224135) ========= 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=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.273400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:46.273749) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 --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=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-13 03:06:46,582 truncating revision to first 12 chars 2017-01-13 03:06:46,582 Setting DEBUG logging. 2017-01-13 03:06:46,582 attempt 1/10 2017-01-13 03:06:46,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/1d71945a1e74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 03:06:47,133 unpacking tar archive at: graphics-1d71945a1e74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:47.173077) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:47.173393) ========= script_repo_revision: 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:47.173813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:47.174072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 03:06:47.183292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-13 03:06:47.183649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:47 INFO - MultiFileLogger online at 20170113 03:06:47 in /builds/slave/test 03:06:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 03:06:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:47 INFO - {'append_to_log': False, 03:06:47 INFO - 'base_work_dir': '/builds/slave/test', 03:06:47 INFO - 'blob_upload_branch': 'Graphics', 03:06:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:47 INFO - 'branch': 'Graphics', 03:06:47 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:47 INFO - 'config_files': ('talos/linux_config.py',), 03:06:47 INFO - 'default_actions': ('clobber', 03:06:47 INFO - 'read-buildbot-config', 03:06:47 INFO - 'download-and-extract', 03:06:47 INFO - 'populate-webroot', 03:06:47 INFO - 'create-virtualenv', 03:06:47 INFO - 'install', 03:06:47 INFO - 'run-tests'), 03:06:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:47 INFO - 'download_minidump_stackwalk': True, 03:06:47 INFO - 'download_symbols': 'ondemand', 03:06:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:47 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:47 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:47 INFO - 'installer_path': 'installer.exe', 03:06:47 INFO - 'log_level': 'info', 03:06:47 INFO - 'log_name': 'talos', 03:06:47 INFO - 'log_to_console': True, 03:06:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:47 INFO - 'opt_config_files': (), 03:06:47 INFO - 'pip_index': False, 03:06:47 INFO - 'sps_profile': False, 03:06:47 INFO - 'sps_profile_interval': 0, 03:06:47 INFO - 'suite': 'dromaeojs', 03:06:47 INFO - 'system_bits': '32', 03:06:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:47 INFO - 'title': 'talos-linux64-ix-011', 03:06:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:47 INFO - 'use_talos_json': True, 03:06:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:47 INFO - 'work_dir': 'build'} 03:06:47 INFO - [mozharness: 2017-01-13 11:06:47.594733Z] Running clobber step. 03:06:47 INFO - Running pre-action listener: _resource_record_pre_action 03:06:47 INFO - Running main action method: clobber 03:06:47 INFO - rmtree: /builds/slave/test/build 03:06:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:48 INFO - Running post-action listener: _resource_record_post_action 03:06:48 INFO - [mozharness: 2017-01-13 11:06:48.051910Z] Finished clobber step (success) 03:06:48 INFO - [mozharness: 2017-01-13 11:06:48.052011Z] Running read-buildbot-config step. 03:06:48 INFO - Running pre-action listener: _resource_record_pre_action 03:06:48 INFO - Running main action method: read_buildbot_config 03:06:48 INFO - Using buildbot properties: 03:06:48 INFO - { 03:06:48 INFO - "project": "", 03:06:48 INFO - "product": "firefox", 03:06:48 INFO - "who": "nsilva@mozilla.com", 03:06:48 INFO - "installer_path": "public/build/target.tar.bz2", 03:06:48 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 03:06:48 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 03:06:48 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 03:06:48 INFO - "stage_platform": "linux64", 03:06:48 INFO - "basedir": "/builds/slave/test", 03:06:48 INFO - "buildnumber": 17, 03:06:48 INFO - "platform": "ubuntu64_hw", 03:06:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:06:48 INFO - "slavebuilddir": "test", 03:06:48 INFO - "taskId": "AVXTs9KMStm4ER8QHL-Ppg", 03:06:48 INFO - "branch": "graphics", 03:06:48 INFO - "script_repo_revision": "default", 03:06:48 INFO - "revision": "1d71945a1e748f114cd71d0aa5e0ed1d88bf8055", 03:06:48 INFO - "slavename": "talos-linux64-ix-011", 03:06:48 INFO - "repo_path": "projects/graphics" 03:06:48 INFO - } 03:06:48 INFO - Finding installer, test and symbols from parent task. 03:06:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AVXTs9KMStm4ER8QHL-Ppg'}, attempt #1 03:06:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AVXTs9KMStm4ER8QHL-Ppg'}, attempt #1 03:06:49 INFO - Task dependencies: Ze6eHboWT_yTnWvLwg4oaQ 03:06:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ'}, attempt #1 03:06:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 03:06:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/test_packages.json 03:06:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.crashreporter-symbols.zip 03:06:49 INFO - Running post-action listener: _resource_record_post_action 03:06:49 INFO - [mozharness: 2017-01-13 11:06:49.474617Z] Finished read-buildbot-config step (success) 03:06:49 INFO - [mozharness: 2017-01-13 11:06:49.474838Z] Running download-and-extract step. 03:06:49 INFO - Running pre-action listener: _resource_record_pre_action 03:06:49 INFO - Running main action method: download_and_extract 03:06:49 INFO - mkdir: /builds/slave/test/build/tests 03:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:49 INFO - trying https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.test_packages.json 03:06:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:06:50 INFO - Downloaded 896 bytes. 03:06:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:06:50 INFO - Using the following test package requirements: 03:06:50 INFO - {u'common': [u'target.common.tests.zip'], 03:06:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:06:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:06:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:06:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:06:50 INFO - u'mozbase': [u'target.common.tests.zip'], 03:06:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:06:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:06:50 INFO - u'web-platform': [u'target.common.tests.zip', 03:06:50 INFO - u'target.web-platform.tests.zip'], 03:06:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:06:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:06:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip 03:06:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip into memory 03:06:50 INFO - Expected file size: 20260791 03:06:50 INFO - Obtained file size: 20260791 03:06:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:06:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip 03:06:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.common.tests.zip into memory 03:06:55 INFO - Expected file size: 20260791 03:06:55 INFO - Obtained file size: 20260791 03:06:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.talos.tests.zip 03:06:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:06:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.talos.tests.zip into memory 03:07:00 INFO - Expected file size: 14403532 03:07:00 INFO - Obtained file size: 14403532 03:07:00 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')]} 03:07:00 INFO - trying https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 03:07:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:07:02 INFO - Downloaded 56077950 bytes. 03:07:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 03:07:02 INFO - mkdir: /builds/slave/test/properties 03:07:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:02 INFO - Contents: 03:07:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 03:07:02 INFO - Running post-action listener: _resource_record_post_action 03:07:02 INFO - Running post-action listener: set_extra_try_arguments 03:07:02 INFO - [mozharness: 2017-01-13 11:07:02.073756Z] Finished download-and-extract step (success) 03:07:02 INFO - [mozharness: 2017-01-13 11:07:02.073854Z] Running populate-webroot step. 03:07:02 INFO - Running pre-action listener: _resource_record_pre_action 03:07:02 INFO - Running main action method: populate_webroot 03:07:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:02 INFO - '--tppagecycles', 03:07:02 INFO - '7'], 03:07:02 INFO - 'tests': ['tsvgm']}}, 03:07:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['damp', 'tps']}, 03:07:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'tests': ['damp', 'tps']}, 03:07:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['dromaeo_dom']}, 03:07:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['basic_compositor_video']}, 03:07:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:07:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['tsvgx', 03:07:02 INFO - 'tsvgr_opacity', 03:07:02 INFO - 'tart', 03:07:02 INFO - 'tscrollx', 03:07:02 INFO - 'cart', 03:07:02 INFO - 'tsvg_static']}, 03:07:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:02 INFO - 'tsvgr_opacity', 03:07:02 INFO - 'tart', 03:07:02 INFO - 'tscrollx', 03:07:02 INFO - 'cart', 03:07:02 INFO - 'tsvg_static']}, 03:07:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--disable-e10s'], 03:07:02 INFO - 'tests': ['tp5o']}, 03:07:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:07:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--disable-e10s', 03:07:02 INFO - '--xperf_path', 03:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:02 INFO - 'tests': ['tp5n']}, 03:07:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--xperf_path', 03:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:02 INFO - 'tests': ['tp5n']}}, 03:07:02 INFO - 'talos.zip': {'path': '', 03:07:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:02 INFO - Running post-action listener: _resource_record_post_action 03:07:02 INFO - [mozharness: 2017-01-13 11:07:02.087181Z] Finished populate-webroot step (success) 03:07:02 INFO - [mozharness: 2017-01-13 11:07:02.087276Z] Running create-virtualenv step. 03:07:02 INFO - Running pre-action listener: _resource_record_pre_action 03:07:02 INFO - Running main action method: create_virtualenv 03:07:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:02 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 03:07:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:02 INFO - Using real prefix '/usr' 03:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:04 INFO - Installing pip.................done. 03:07:04 INFO - Return code: 0 03:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:04 INFO - Reading from file tmpfile_stdout 03:07:04 INFO - Output received: 03:07:04 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) 03:07:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07: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', 'pip>=1.5'] in /builds/slave/test/build 03:07: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 pip>=1.5 03:07:04 INFO - Using env: {'DISPLAY': ':0', 03:07:04 INFO - 'HOME': '/home/cltbld', 03:07:04 INFO - 'LANG': 'en_US.UTF-8', 03:07:04 INFO - 'LANGUAGE': 'en_US:en', 03:07:04 INFO - 'LOGNAME': 'cltbld', 03:07:04 INFO - 'MAIL': '/var/mail/cltbld', 03:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:04 INFO - 'MOZ_NO_REMOTE': '1', 03:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:04 INFO - 'NO_EM_RESTART': '1', 03:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:04 INFO - 'PWD': '/builds/slave/test', 03:07:04 INFO - 'SHELL': '/bin/bash', 03:07:04 INFO - 'SHLVL': '1', 03:07:04 INFO - 'TERM': 'linux', 03:07:04 INFO - 'TMOUT': '86400', 03:07:04 INFO - 'USER': 'cltbld', 03:07:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:04 INFO - '_': '/tools/buildbot/bin/python'} 03:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:05 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 03:07:05 INFO - Cleaning up... 03:07:05 INFO - Return code: 0 03:07:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:05 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')]} 03:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:05 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')]} 03:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:05 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:05 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 03:07:05 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 03:07:05 INFO - Using env: {'DISPLAY': ':0', 03:07:05 INFO - 'HOME': '/home/cltbld', 03:07:05 INFO - 'LANG': 'en_US.UTF-8', 03:07:05 INFO - 'LANGUAGE': 'en_US:en', 03:07:05 INFO - 'LOGNAME': 'cltbld', 03:07:05 INFO - 'MAIL': '/var/mail/cltbld', 03:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:05 INFO - 'MOZ_NO_REMOTE': '1', 03:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:05 INFO - 'NO_EM_RESTART': '1', 03:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:05 INFO - 'PWD': '/builds/slave/test', 03:07:05 INFO - 'SHELL': '/bin/bash', 03:07:05 INFO - 'SHLVL': '1', 03:07:05 INFO - 'TERM': 'linux', 03:07:05 INFO - 'TMOUT': '86400', 03:07:05 INFO - 'USER': 'cltbld', 03:07:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:05 INFO - '_': '/tools/buildbot/bin/python'} 03:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:05 INFO - Downloading/unpacking psutil>=3.1.1 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:07 INFO - Installing collected packages: psutil 03:07:07 INFO - Running setup.py install for psutil 03:07:07 INFO - building 'psutil._psutil_linux' extension 03:07:07 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 03:07:07 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 03:07:07 INFO - building 'psutil._psutil_posix' extension 03:07:07 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 03:07:07 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 03:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:07 INFO - Successfully installed psutil 03:07:07 INFO - Cleaning up... 03:07:07 INFO - Return code: 0 03:07:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:07 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')]} 03:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:07 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')]} 03:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:07 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:07 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 03:07:07 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 03:07:07 INFO - Using env: {'DISPLAY': ':0', 03:07:07 INFO - 'HOME': '/home/cltbld', 03:07:07 INFO - 'LANG': 'en_US.UTF-8', 03:07:07 INFO - 'LANGUAGE': 'en_US:en', 03:07:07 INFO - 'LOGNAME': 'cltbld', 03:07:07 INFO - 'MAIL': '/var/mail/cltbld', 03:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:07 INFO - 'MOZ_NO_REMOTE': '1', 03:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:07 INFO - 'NO_EM_RESTART': '1', 03:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:07 INFO - 'PWD': '/builds/slave/test', 03:07:07 INFO - 'SHELL': '/bin/bash', 03:07:07 INFO - 'SHLVL': '1', 03:07:07 INFO - 'TERM': 'linux', 03:07:07 INFO - 'TMOUT': '86400', 03:07:07 INFO - 'USER': 'cltbld', 03:07:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:07 INFO - '_': '/tools/buildbot/bin/python'} 03:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:08 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 03:07:08 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 03:07:08 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 03:07:08 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 03:07:08 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 03:07:08 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 03:07:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:10 INFO - Installing collected packages: mozsystemmonitor 03:07:10 INFO - Running setup.py install for mozsystemmonitor 03:07:10 INFO - Successfully installed mozsystemmonitor 03:07:10 INFO - Cleaning up... 03:07:10 INFO - Return code: 0 03:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:10 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:10 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 03:07:10 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 03:07:10 INFO - Using env: {'DISPLAY': ':0', 03:07:10 INFO - 'HOME': '/home/cltbld', 03:07:10 INFO - 'LANG': 'en_US.UTF-8', 03:07:10 INFO - 'LANGUAGE': 'en_US:en', 03:07:10 INFO - 'LOGNAME': 'cltbld', 03:07:10 INFO - 'MAIL': '/var/mail/cltbld', 03:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:10 INFO - 'MOZ_NO_REMOTE': '1', 03:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:10 INFO - 'NO_EM_RESTART': '1', 03:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:10 INFO - 'PWD': '/builds/slave/test', 03:07:10 INFO - 'SHELL': '/bin/bash', 03:07:10 INFO - 'SHLVL': '1', 03:07:10 INFO - 'TERM': 'linux', 03:07:10 INFO - 'TMOUT': '86400', 03:07:10 INFO - 'USER': 'cltbld', 03:07:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:10 INFO - '_': '/tools/buildbot/bin/python'} 03:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:10 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 03:07:10 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 03:07:10 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 03:07:10 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 03:07:10 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 03:07:10 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 03:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:12 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 03:07:12 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 03:07:12 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 03:07:12 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 03:07:12 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 03:07:12 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 03:07:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:12 INFO - warning: no files found matching '*.txt' 03:07:12 INFO - no previously-included directories found matching 'build' 03:07:12 INFO - no previously-included directories found matching 'dist' 03:07:12 INFO - no previously-included directories found matching '.git*' 03:07:12 INFO - Installing collected packages: jsonschema, functools32 03:07:12 INFO - Running setup.py install for functools32 03:07:13 INFO - warning: no files found matching '*.txt' 03:07:13 INFO - no previously-included directories found matching 'build' 03:07:13 INFO - no previously-included directories found matching 'dist' 03:07:13 INFO - no previously-included directories found matching '.git*' 03:07:13 INFO - Successfully installed jsonschema functools32 03:07:13 INFO - Cleaning up... 03:07:13 INFO - Return code: 0 03:07:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:13 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 03:07:13 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 03:07:13 INFO - Using env: {'DISPLAY': ':0', 03:07:13 INFO - 'HOME': '/home/cltbld', 03:07:13 INFO - 'LANG': 'en_US.UTF-8', 03:07:13 INFO - 'LANGUAGE': 'en_US:en', 03:07:13 INFO - 'LOGNAME': 'cltbld', 03:07:13 INFO - 'MAIL': '/var/mail/cltbld', 03:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:13 INFO - 'MOZ_NO_REMOTE': '1', 03:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:13 INFO - 'NO_EM_RESTART': '1', 03:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:13 INFO - 'PWD': '/builds/slave/test', 03:07:13 INFO - 'SHELL': '/bin/bash', 03:07:13 INFO - 'SHLVL': '1', 03:07:13 INFO - 'TERM': 'linux', 03:07:13 INFO - 'TMOUT': '86400', 03:07:13 INFO - 'USER': 'cltbld', 03:07:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:13 INFO - '_': '/tools/buildbot/bin/python'} 03:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:13 INFO - Cleaning up... 03:07:13 INFO - Return code: 0 03:07:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:13 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 03:07:13 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 03:07:13 INFO - Using env: {'DISPLAY': ':0', 03:07:13 INFO - 'HOME': '/home/cltbld', 03:07:13 INFO - 'LANG': 'en_US.UTF-8', 03:07:13 INFO - 'LANGUAGE': 'en_US:en', 03:07:13 INFO - 'LOGNAME': 'cltbld', 03:07:13 INFO - 'MAIL': '/var/mail/cltbld', 03:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:13 INFO - 'MOZ_NO_REMOTE': '1', 03:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:13 INFO - 'NO_EM_RESTART': '1', 03:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:13 INFO - 'PWD': '/builds/slave/test', 03:07:13 INFO - 'SHELL': '/bin/bash', 03:07:13 INFO - 'SHLVL': '1', 03:07:13 INFO - 'TERM': 'linux', 03:07:13 INFO - 'TMOUT': '86400', 03:07:13 INFO - 'USER': 'cltbld', 03:07:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:13 INFO - '_': '/tools/buildbot/bin/python'} 03:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07: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 03:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:16 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 03:07:16 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 03:07:16 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 03:07:16 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 03:07:16 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 03:07:16 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 03:07:16 INFO - Downloading docopt-0.6.1.tar.gz 03:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:16 INFO - Running setup.py install for blobuploader 03:07:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:16 INFO - Running setup.py install for requests 03:07:16 INFO - Running setup.py install for docopt 03:07:16 INFO - Successfully installed blobuploader requests docopt 03:07:16 INFO - Cleaning up... 03:07:16 INFO - Return code: 0 03:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:16 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')]} 03:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:16 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')]} 03:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:16 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:16 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 03:07:17 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 03:07:17 INFO - Using env: {'DISPLAY': ':0', 03:07:17 INFO - 'HOME': '/home/cltbld', 03:07:17 INFO - 'LANG': 'en_US.UTF-8', 03:07:17 INFO - 'LANGUAGE': 'en_US:en', 03:07:17 INFO - 'LOGNAME': 'cltbld', 03:07:17 INFO - 'MAIL': '/var/mail/cltbld', 03:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:17 INFO - 'MOZ_NO_REMOTE': '1', 03:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:17 INFO - 'NO_EM_RESTART': '1', 03:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:17 INFO - 'PWD': '/builds/slave/test', 03:07:17 INFO - 'SHELL': '/bin/bash', 03:07:17 INFO - 'SHLVL': '1', 03:07:17 INFO - 'TERM': 'linux', 03:07:17 INFO - 'TMOUT': '86400', 03:07:17 INFO - 'USER': 'cltbld', 03:07:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:17 INFO - '_': '/tools/buildbot/bin/python'} 03:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:17 INFO - Running setup.py (path:/tmp/pip-CSpQZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:17 INFO - Running setup.py (path:/tmp/pip-zOlHDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:17 INFO - Running setup.py (path:/tmp/pip-mML64k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:17 INFO - Running setup.py (path:/tmp/pip-CG4B9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:17 INFO - Running setup.py (path:/tmp/pip-ijHHfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:17 INFO - Running setup.py (path:/tmp/pip-0Ali2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:17 INFO - Running setup.py (path:/tmp/pip-CxX5Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:17 INFO - Running setup.py (path:/tmp/pip-pcnjbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:17 INFO - Running setup.py (path:/tmp/pip-JJLpCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:17 INFO - Running setup.py (path:/tmp/pip-13PiNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:17 INFO - Running setup.py (path:/tmp/pip-H32gU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:17 INFO - Running setup.py (path:/tmp/pip-CcsBNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:18 INFO - Running setup.py (path:/tmp/pip-hLvSeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:18 INFO - Running setup.py (path:/tmp/pip-KVbBTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:18 INFO - Running setup.py (path:/tmp/pip-ydt_2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:18 INFO - Running setup.py (path:/tmp/pip-DuCEoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:18 INFO - Running setup.py (path:/tmp/pip-CHTtlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:18 INFO - Running setup.py install for manifestparser 03:07:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:18 INFO - Running setup.py install for mozcrash 03:07:18 INFO - Running setup.py install for mozdebug 03:07:18 INFO - Running setup.py install for mozdevice 03:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:18 INFO - Running setup.py install for mozfile 03:07:18 INFO - Running setup.py install for mozhttpd 03:07:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozinfo 03:07:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozInstall 03:07:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozleak 03:07:19 INFO - Running setup.py install for mozlog 03:07:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for moznetwork 03:07:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozprocess 03:07:19 INFO - Running setup.py install for mozprofile 03:07:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozrunner 03:07:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:19 INFO - Running setup.py install for mozscreenshot 03:07:19 INFO - Running setup.py install for moztest 03:07:20 INFO - Running setup.py install for mozversion 03:07:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:20 INFO - Cleaning up... 03:07:20 INFO - Return code: 0 03:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:20 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')]} 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:20 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')]} 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:20 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:20 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 03:07:20 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 03:07:20 INFO - Using env: {'DISPLAY': ':0', 03:07:20 INFO - 'HOME': '/home/cltbld', 03:07:20 INFO - 'LANG': 'en_US.UTF-8', 03:07:20 INFO - 'LANGUAGE': 'en_US:en', 03:07:20 INFO - 'LOGNAME': 'cltbld', 03:07:20 INFO - 'MAIL': '/var/mail/cltbld', 03:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:20 INFO - 'MOZ_NO_REMOTE': '1', 03:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:20 INFO - 'NO_EM_RESTART': '1', 03:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:20 INFO - 'PWD': '/builds/slave/test', 03:07:20 INFO - 'SHELL': '/bin/bash', 03:07:20 INFO - 'SHLVL': '1', 03:07:20 INFO - 'TERM': 'linux', 03:07:20 INFO - 'TMOUT': '86400', 03:07:20 INFO - 'USER': 'cltbld', 03:07:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:20 INFO - '_': '/tools/buildbot/bin/python'} 03:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:20 INFO - Running setup.py (path:/tmp/pip-qVeF0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:20 INFO - Running setup.py (path:/tmp/pip-bc_gje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:20 INFO - Running setup.py (path:/tmp/pip-RqrWck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:20 INFO - Running setup.py (path:/tmp/pip-t_OvsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:20 INFO - Running setup.py (path:/tmp/pip-ogrSjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:20 INFO - Running setup.py (path:/tmp/pip-QjEkNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:20 INFO - Running setup.py (path:/tmp/pip-xZMWNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:20 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)) 03:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:20 INFO - Running setup.py (path:/tmp/pip-hjYDl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:21 INFO - Running setup.py (path:/tmp/pip-PwnMic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:21 INFO - Running setup.py (path:/tmp/pip-hzy3w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:21 INFO - Running setup.py (path:/tmp/pip-9j0bkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:21 INFO - Running setup.py (path:/tmp/pip-M3vipq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:21 INFO - Running setup.py (path:/tmp/pip-laknsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:21 INFO - Running setup.py (path:/tmp/pip-xiwqb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:21 INFO - Running setup.py (path:/tmp/pip-ZEnqB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:21 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:21 INFO - Running setup.py (path:/tmp/pip-ubbhxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 03:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:21 INFO - Running setup.py (path:/tmp/pip-h4FP6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:21 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)) 03:07:21 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)) 03:07:21 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)) 03:07:21 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)) 03:07:21 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)) 03:07:21 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)) 03:07:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:21 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 03:07:21 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 03:07:21 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 03:07:21 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 03:07:21 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 03:07:21 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 03:07:23 INFO - Downloading blessings-1.6.tar.gz 03:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:23 INFO - Installing collected packages: blessings 03:07:23 INFO - Running setup.py install for blessings 03:07:23 INFO - Successfully installed blessings 03:07:23 INFO - Cleaning up... 03:07:23 INFO - Return code: 0 03:07:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:24 INFO - Reading from file tmpfile_stdout 03:07:24 INFO - Current package versions: 03:07:24 INFO - argparse == 1.2.1 03:07:24 INFO - blessings == 1.6 03:07:24 INFO - blobuploader == 1.2.4 03:07:24 INFO - docopt == 0.6.1 03:07:24 INFO - functools32 == 3.2.3-2 03:07:24 INFO - jsonschema == 2.5.1 03:07:24 INFO - manifestparser == 1.1 03:07:24 INFO - mozInstall == 1.12 03:07:24 INFO - mozcrash == 1.0 03:07:24 INFO - mozdebug == 0.1 03:07:24 INFO - mozdevice == 0.49 03:07:24 INFO - mozfile == 1.2 03:07:24 INFO - mozhttpd == 0.7 03:07:24 INFO - mozinfo == 0.9 03:07:24 INFO - mozleak == 0.1 03:07:24 INFO - mozlog == 3.4 03:07:24 INFO - moznetwork == 0.27 03:07:24 INFO - mozprocess == 0.24 03:07:24 INFO - mozprofile == 0.28 03:07:24 INFO - mozrunner == 6.13 03:07:24 INFO - mozscreenshot == 0.1 03:07:24 INFO - mozsystemmonitor == 0.3 03:07:24 INFO - moztest == 0.8 03:07:24 INFO - mozversion == 1.4 03:07:24 INFO - psutil == 3.1.1 03:07:24 INFO - requests == 1.2.3 03:07:24 INFO - wsgiref == 0.1.2 03:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:24 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 03:07:24 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 03:07:24 INFO - Using env: {'DISPLAY': ':0', 03:07:24 INFO - 'HOME': '/home/cltbld', 03:07:24 INFO - 'LANG': 'en_US.UTF-8', 03:07:24 INFO - 'LANGUAGE': 'en_US:en', 03:07:24 INFO - 'LOGNAME': 'cltbld', 03:07:24 INFO - 'MAIL': '/var/mail/cltbld', 03:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:24 INFO - 'MOZ_NO_REMOTE': '1', 03:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:24 INFO - 'NO_EM_RESTART': '1', 03:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:24 INFO - 'PWD': '/builds/slave/test', 03:07:24 INFO - 'SHELL': '/bin/bash', 03:07:24 INFO - 'SHLVL': '1', 03:07:24 INFO - 'TERM': 'linux', 03:07:24 INFO - 'TMOUT': '86400', 03:07:24 INFO - 'USER': 'cltbld', 03:07:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:24 INFO - '_': '/tools/buildbot/bin/python'} 03:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 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)) 03:07:24 INFO - Cleaning up... 03:07:24 INFO - Return code: 0 03:07:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 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 0x18d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c49c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', '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 03:07:24 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 03:07:24 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 03:07:24 INFO - Using env: {'DISPLAY': ':0', 03:07:24 INFO - 'HOME': '/home/cltbld', 03:07:24 INFO - 'LANG': 'en_US.UTF-8', 03:07:24 INFO - 'LANGUAGE': 'en_US:en', 03:07:24 INFO - 'LOGNAME': 'cltbld', 03:07:24 INFO - 'MAIL': '/var/mail/cltbld', 03:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:24 INFO - 'MOZ_NO_REMOTE': '1', 03:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:24 INFO - 'NO_EM_RESTART': '1', 03:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:24 INFO - 'PWD': '/builds/slave/test', 03:07:24 INFO - 'SHELL': '/bin/bash', 03:07:24 INFO - 'SHLVL': '1', 03:07:24 INFO - 'TERM': 'linux', 03:07:24 INFO - 'TMOUT': '86400', 03:07:24 INFO - 'USER': 'cltbld', 03:07:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:24 INFO - '_': '/tools/buildbot/bin/python'} 03:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:24 INFO - Cleaning up... 03:07:24 INFO - Return code: 0 03:07:24 INFO - Running post-action listener: _resource_record_post_action 03:07:24 INFO - Running post-action listener: _start_resource_monitoring 03:07:24 INFO - Starting resource monitoring. 03:07:24 INFO - [mozharness: 2017-01-13 11:07:24.648817Z] Finished create-virtualenv step (success) 03:07:24 INFO - [mozharness: 2017-01-13 11:07:24.649274Z] Running install step. 03:07:24 INFO - Running pre-action listener: _resource_record_pre_action 03:07:24 INFO - Running main action method: install 03:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:24 INFO - Reading from file tmpfile_stdout 03:07:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:24 INFO - Reading from file tmpfile_stdout 03:07:24 INFO - Output received: 03:07:24 INFO - Usage: mozinstall [options] installer 03:07:24 INFO - Options: 03:07:24 INFO - -h, --help show this help message and exit 03:07:24 INFO - -d DEST, --destination=DEST 03:07:24 INFO - Directory to install application into. [default: 03:07:24 INFO - "/builds/slave/test"] 03:07:24 INFO - --app=APP Application being installed. [default: firefox] 03:07:24 INFO - mkdir: /builds/slave/test/build/application 03:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:07:41 INFO - Reading from file tmpfile_stdout 03:07:41 INFO - Output received: 03:07:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:41 INFO - Running post-action listener: _resource_record_post_action 03:07:41 INFO - [mozharness: 2017-01-13 11:07:41.110570Z] Finished install step (success) 03:07:41 INFO - [mozharness: 2017-01-13 11:07:41.110853Z] Running run-tests step. 03:07:41 INFO - Running pre-action listener: _resource_record_pre_action 03:07:41 INFO - Running main action method: run_tests 03:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:41 INFO - Python 2.7.3 03:07:41 INFO - Return code: 0 03:07:41 INFO - grabbing minidump binary from tooltool 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 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 0x1c473f0>, '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 0x1c47cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c481a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:41 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 03:07:41 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 03:07:41 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 03:07:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:41 INFO - Return code: 0 03:07:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:07:41 INFO - Using env: {'DISPLAY': ':0', 03:07:41 INFO - 'HOME': '/home/cltbld', 03:07:41 INFO - 'LANG': 'en_US.UTF-8', 03:07:41 INFO - 'LANGUAGE': 'en_US:en', 03:07:41 INFO - 'LOGNAME': 'cltbld', 03:07:41 INFO - 'MAIL': '/var/mail/cltbld', 03:07:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:41 INFO - 'MOZ_NO_REMOTE': '1', 03:07:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:41 INFO - 'NO_EM_RESTART': '1', 03:07:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:41 INFO - 'PWD': '/builds/slave/test', 03:07:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:41 INFO - 'SHELL': '/bin/bash', 03:07:41 INFO - 'SHLVL': '1', 03:07:41 INFO - 'TERM': 'linux', 03:07:41 INFO - 'TMOUT': '86400', 03:07:41 INFO - 'USER': 'cltbld', 03:07:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603', 03:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:41 INFO - '_': '/tools/buildbot/bin/python'} 03:07:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:07:41 INFO - mozversion application_buildid: 20170113102520 03:07:41 INFO - mozversion application_changeset: 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 03:07:41 INFO - mozversion application_display_name: Nightly 03:07:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:41 INFO - mozversion application_name: Firefox 03:07:41 INFO - mozversion application_remotingname: firefox 03:07:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 03:07:41 INFO - mozversion application_vendor: Mozilla 03:07:41 INFO - mozversion application_version: 53.0a1 03:07:41 INFO - mozversion platform_buildid: 20170113102520 03:07:41 INFO - mozversion platform_changeset: 1d71945a1e748f114cd71d0aa5e0ed1d88bf8055 03:07:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 03:07:41 INFO - mozversion platform_version: 53.0a1 03:07:41 INFO - using testdate: 1484305661 03:07:41 INFO - actual date: 1484305661 03:07:41 INFO - starting webserver on 'localhost:34336' 03:07:41 INFO - SUITE-START | Running 2 tests 03:07:41 INFO - TEST-START | dromaeo_css 03:07:41 INFO - operating with platform_type : linux_ 03:07:41 INFO - Initialising browser for dromaeo_css test... 03:07:41 INFO - TEST-INFO | started process 32248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpITWNvY/profile http://localhost:34336/getInfo.html) 03:07:45 INFO - PROCESS | 32248 | __metrics Screen width/height:1600/1200 03:07:45 INFO - PROCESS | 32248 | colorDepth:24 03:07:45 INFO - PROCESS | 32248 | Browser inner width/height: 1024/697 03:07:45 INFO - PROCESS | 32248 | __metrics 03:07:46 INFO - PROCESS | 32248 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:07:46 INFO - PROCESS | 32248 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:47 INFO - PROCESS | 32248 | console.error: PushService: 03:07:47 INFO - PROCESS | 32248 | stateChangeProcessEnqueue: Error transitioning state 03:07:47 INFO - PROCESS | 32248 | UnknownError 03:07:48 INFO - TEST-INFO | 32248: exit 0 03:07:48 INFO - Browser initialized. 03:07:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:48 INFO - TEST-INFO | started process 32328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpITWNvY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:00 INFO - PROCESS | 32328 | RSS: Main: 152342528 03:08:00 INFO - PROCESS | 32328 | 03:11:04 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34336/tests/dromaeo/cssquery-ext.html) 03:11:05 INFO - PROCESS | 32328 | RSS: Main: 244207616 03:11:05 INFO - PROCESS | 32328 | 03:12:49 INFO - PROCESS | 32328 | ************************* 03:12:49 INFO - PROCESS | 32328 | A coding exception was thrown and uncaught in a Task. 03:12:49 INFO - PROCESS | 32328 | 03:12:49 INFO - PROCESS | 32328 | Full message: ReferenceError: fetch is not defined 03:12:49 INFO - PROCESS | 32328 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 03:12:49 INFO - PROCESS | 32328 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 03:12:49 INFO - PROCESS | 32328 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 03:12:49 INFO - PROCESS | 32328 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 03:12:49 INFO - PROCESS | 32328 | TaskImpl@resource://gre/modules/Task.jsm:277:3 03:12:49 INFO - PROCESS | 32328 | asyncFunction@resource://gre/modules/Task.jsm:252:14 03:12:49 INFO - PROCESS | 32328 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 03:12:49 INFO - PROCESS | 32328 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 03:12:49 INFO - PROCESS | 32328 | TaskImpl@resource://gre/modules/Task.jsm:277:3 03:12:49 INFO - PROCESS | 32328 | asyncFunction@resource://gre/modules/Task.jsm:252:14 03:12:49 INFO - PROCESS | 32328 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 03:12:49 INFO - PROCESS | 32328 | 03:12:49 INFO - PROCESS | 32328 | ************************* 03:14:07 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-ext.html (next: http://localhost:34336/tests/dromaeo/cssquery-jquery.html) 03:14:08 INFO - PROCESS | 32328 | RSS: Main: 239378432 03:14:08 INFO - PROCESS | 32328 | 03:17:10 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34336/tests/dromaeo/cssquery-mootools.html) 03:17:11 INFO - PROCESS | 32328 | RSS: Main: 185872384 03:17:11 INFO - PROCESS | 32328 | 03:20:13 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34336/tests/dromaeo/cssquery-prototype.html) 03:20:14 INFO - PROCESS | 32328 | RSS: Main: 184147968 03:20:14 INFO - PROCESS | 32328 | 03:23:17 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34336/tests/dromaeo/cssquery-yui.html) 03:23:17 INFO - PROCESS | 32328 | RSS: Main: 184692736 03:23:17 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:34336/tests/dromaeo/cssquery-yui.html (next: http://localhost:34336/tests/dromaeo/cssquery-dojo.html) 03:26:21 INFO - PROCESS | 32328 | RSS: Main: 278130688 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | __start_tp_report 03:26:21 INFO - PROCESS | 32328 | _x_x_mozilla_page_load 03:26:21 INFO - PROCESS | 32328 | _x_x_mozilla_page_load_details 03:26:21 INFO - PROCESS | 32328 | |i|pagename|runs| 03:26:21 INFO - PROCESS | 32328 | |0;dojo.html;2567.730388309227;2582.7933765298776;2600.9349766255855;2630.671166104237;2640.5775075987845;4671.135839869618;4713.670043096985;4744.478107408187;4777.9283310750325;4792.976035119824;4746.715197088177;4758.500357462469;4762.476127625959;4768.880777980552;4774.188387974044;4342.956570434302;4347.93478097828;4365.650747940157;4369.606735393814;4386.627136693385;4351.73889566627;4389.034412429261;4393.319035549495;4416.050549131936;4430.734155950637;4399.67002474814;4415.646748260147;4415.757133357664;4418.293073108303;4472.575105365001;557.1524239379139;4365.476142862845;4375.562443755631;4408.272635015219;4427.9557204427865;3912.2371137628174;4318.82724691012;4329.1558146161515;4333.328334108218;4361.651067914591;4688.085823264465;4688.179568575486;4700.4594471635855;4707.8587642370785;4733.739644319561;4969.726665033421;5043.672161309503;5044.571211447032;5055.292259083732;5096.668716533451;5009.799608015712;5038.395392552917;5054.873628159326;5072.416672082684;5192.039472697563;4793;4802.975985120052;4803.543663351976;4809.807607695688;4851.56335929768;5228.529432351031;5234;5242.842714718565;5242.97378513105;5245.003449344612;4953.603711703127;4954.504549545089;4991.575716064175;4994.600431965434;4995.425526064477;5082.1360368737405;5084.059449001947;5086.516780905808;5090.10923088458;5135.075686376488;5057.544820966057;5058.64589478733;5059.418166910778;5064.544191022752;5089.796408143707;4957.702537847668;5007.4241462231585;5017.874553136201;5034.521720436553;5040.1179793535985;4351.434313539283;4359.476862776487;4396.384506169139;4401.163778882003;4403.383526306319;3729.4405839123806;3770.2836461072307;3773;3776.188119554254;3780.281746468162;4375.824967001285;4403.757793321398;4410.558944105564;4412.558744125562;4423.867283981485;5015.949840501621;5076.771545280471;5104.668196567211;5116.718580478035;5136.0241554104605;4417.491988421372;4429.313456414261;4436.334549817489;4443.333499974965;4445.666575006888;4575.9084818303445;4579.175748365326;4579.748113853703;4589.082183563234;4643.791029403685;4785.856424307276;4787.40157480315;4797.088553174885;4808.08646357191;4845.53967373099;4941.357623508921;4994.450610432922;5100.69395836251;5122.436531981404;5136.640435169502;4851.272309153655;4861.246506791453;4869.610431165569;4887.047025829929;4899.387576552931;5033.546980771748;5038.093143234107;5087.720175390389;5093.159628661378;5095.617828662939;5070.036693028313;5083.364579427572;5136.1268584340005;5137.049645815536;5228.477152284741;5035.723035233097;5041.193409054534;5042.117629414764;5076.492350765042;5089.821856235162;5025.572826309804;5027.622928280321;5032.421271553818;5037.647364684583;5075.543201111917;4821.276808478756;4823.204171311834;4848.733319667452;4975.10448119342;4982;4931.901361972812;4954.727489988085;4969;5009.323741295024;5017.096922553976;4845.466998630078;4850.587700045395;4853.927191092066;4864.805407783649;4918.92621610669 03:26:21 INFO - PROCESS | 32328 | |1;ext.html;538.9730513474326;555.9471850174232;562.308360716319;572.4847637126586;595.431363048289;37887.24225515488;39648.60351396485;39826.2034759305;44786;44837.77581112098;41008.38487422691;41495;41524.58475415245;41558.37662435066;41578;7642.541447513139;7678.539287642731;7840.2159784021715;7848.175941526143;7848.2151784821635;7580.090389153309;7808.336291415237;7810.921890781105;9787.314887957846;10033;10230;10294.794104117913;10295.330803497785;10297.536610852492;10307.63923262686;10073.597056117747;10135.543900524493;10140.290179687425;10142.137918276956;10151.695449136463;10077.44574048427;10149.644762433354;10152.492375381202;10155.28912976092;10184;38717.612823871685;38951.80524097361;39030.219395612214;39032.414513782314;39142;3463.1861512544783;3463.463163209681;3497.6327485613897;3499.7025252853537;3504.56192975878;28589.142325730263;29256.414871702447;29305.85347073251;29316.853415733;29388;3364.2094107884627;3434.5191673165778;3454.360943225511;3486.6687664672068;3532.6114127445962;233906;234141;234213;234910;235275;51576.22635660468;51882.48117518852;52309.2153617696;52436;52451.73774131105;56146.78899082585;56221.156682649795;56221.71889140528;56275.15587266194;56286.43713562812;12648.620541383772;12844.357782110857;12860.549880754128;12867;12874;9595.520223988913;9595.952020239854;9620.422774633544;9633.277504187214;9657.46883921377;14661.19363435;15076.24618769057;16090.678186436206;16524.834751652328;16595.50213493573;5515.393306736256;5833.88332233353;5919.260092488439;5958.225430694069;6022.728977196037;826.8553003224412;835.824476859854;843.3506200225914;859.2095272349453;873.7771868173702;26872;28125;28575.428491430055;28725;28779.712202878123;966.4008314844841;972.9173020293213;978.2125389061873;987.4470296633908;1100.0484580837679;13789;14255.78616320756;14883.404663813542;15178.772318415233;15277.847221527865;317931;321996;322516;322962;323232;44204.778976105554;44338.33492497615;44410.55589444129;44436.11127777491;44455.77772111184;1246.856611489672;1273.4333221716247;1284.537566476068;1286.8327117474669;1291.5156816193928;24203.561428158628;24600.876995615625;25867.22398328053;25988;26009.21972340833;36886.26227475489;37243.813780932;37261;37292.813535932146;37362.2527549442;274742;275468;275587;275664;275711;23208.883955580113;23322.183723569593;23528.882355588114;23544.646830297217;23956;32387.83806081049;33319.50020749642;33334.66665333316;38539.267847216615;38540;30040.3991920156;32299.67700323061;32754.83622581872;33102.172445688084;33409.331813364086;32110.839445802623;32189.678103218666;32211;32845.835770820995;33070.33859322752;31625.683743163194;31734.841325793222;31940;31985.88049418259;32357.35285294328;27863.303417414725;29266;29728.702712972594;29985.250368740082;30057.69942300549;23467.882660586587;23511.41221469477;23845.284641460785;23877.880610596836;24024.15915442951 03:26:21 INFO - PROCESS | 32328 | |2;jquery.html;370.7738279649415;381.91562351563897;386.4705353665479;397.12434082847324;412.3834866874022;12938.288394138319;13360.198388096722;16668.74996875048;18141.7278740819;18153.183106760196;13165.341732913364;15387.230638468087;15614;15646.139462329567;15647.687046259096;5046.192609182541;5286.497782710637;5288.418273989858;5290.418054014055;5300.416954135061;5150.562202212816;5171.674461740975;5204.895902081956;5236.240745091959;5247.632665713401;5218.217267409881;5236.21456781482;5242.55438287746;5246.68519888806;5247.239150323201;5051.722155281458;5214.400343960418;5231.947680523203;5237.79048838046;5281.683099014072;4758.476567577563;4766;4771.618270538349;4771.6898401603785;4773.904521909577;16368;20437;21078.262260820797;21169.153233870627;21413.57172856534;2287.1537531113595;2480.707810113273;2480.7395223501453;2507.4232926426844;2529.8229123961332;9459.337846350758;9704.02959704031;9909.950450247703;11892.87017733314;13460.394282257323;1765.8057613662486;1798.8757026858214;1807.7469154318405;1833.2208811255296;1843.2626949220285;71738;75672.62163689201;75883.24116758817;76882;77757.61121194357;10539.10417614496;10539.736506587396;10738.57701860571;11046.226764126595;11125.221234513669;14618.85381146175;14646.436873547087;14649.707005859824;14650.267486625626;14656.413743450355;6735.292794256533;6852.143482064742;6951.443884489228;7067.5052746307265;7072.646367681596;6179.938200618026;6216.720247588869;6406;6441.227052753606;6454.515911306671;4448.332750087513;4583.54164583539;4612.53874612536;4770.928436073462;4827.95172048275;1884.9623007539772;1903.961920761577;1918.6354592627356;1953.140618128019;1969.4579761057653;779.6959185917497;797.2904115337354;798.7364169823944;823.6499487717816;835.1356346181673;17391.217395217245;17436.65126697459;17711.380101696377;18789.81210187908;18846.623067538574;853.2704537620369;878.0517041595062;885.1679421344045;887.4364778365784;896.7220161749879;9463.242940564738;10083.59665613382;10110.69667909964;10124.13944814699;10240.795184096276;491769;497152;498301;501575;502545;91055.5447222773;92584;95086;96872.51563742277;97214.51392742991;823.8228780812154;845.3828705045352;847.525385783963;848.512105539305;850.5789634131145;15411.69176616439;15514.612134696723;15795.526134215992;15919.363225470852;16133.482624865057;39725.40411893766;40541.7823680998;41006.58993410028;41969;42027.36958945679;54964.72517637386;56713;57114.7144264276;57757.711211443675;58417.12374314474;7736.7292144774665;7902.881456778038;7987.880181797162;8040.798980025546;8291;11357;12535.122541422377;12548.560800371943;12661.366931653565;12932.806007910078;10969.725756856142;11014.889851101707;11031.83452248201;11071.114310855273;11210.27133236337;10751;11012.669619911416;11162.107031437628;11229.71925701864;11348;7371.447141464519;9951.402915825074;10580.841287380541;10593.417362045162;10685.786284274116;7792.6103694816165;7907.762767116996;7963.6814527418255;7997.600119993861;8075.596220189084;8044.839103217786;10513.842292365467;10568.947155264175;10649.680509584725;11120 03:26:21 INFO - PROCESS | 32328 | |3;mootools.html;1360.2042804959099;1365.5630198336532;1379.5516457151427;1387.5975966969581;1396.5461225101844;6966.23371429143;7397.001404810349;7405.259474052599;7407.222241664628;7413.332800047994;6452.516061295398;6637.568558043724;7029.964850175742;7227.819304517389;7287.890681639779;2148.903299351533;2180.901859416322;2185.650295952648;2187.212603462752;2192.473806286496;2127.5106725453156;2163.6105501009893;2178.8039076483115;2179.6730490426403;2181.1057466438765;1865.7201419787004;1937.980620193794;2091.393495886191;2150.2474134053114;2155.4072630026712;2103.8422118341186;2117.3965419855267;2118.936431907045;2120.9787902120934;2122.946926326839;2057.40335302762;2068.503559145809;2069.2757534862826;2069.751629804433;2144.0994782191515;7418.591977441239;7466.365358944497;7486.663100160506;7489.400847932152;7493.737719179857;4266.424032755569;4383.211022016036;4400.44994375703;4414.779261036967;4416.823327066913;2705.3101459127993;2807.3402750353653;2878.29481776966;2879.9856000720074;2923.4737747205495;1023.6570748799161;1050.217587897014;1052.9157667386667;1071.7159952612565;1098.906592939601;9780.55987480565;9833.065858743408;9835.655752048715;9841.803163936753;9846.163076138608;4012.959870401317;4219.894502637459;4281;4283.87148385549;4312.935305970413;8476.406651534333;8476.49141051539;8484.109168537214;8484.618192181244;8486.618102185294;4511.436070491189;4520.50274469808;4530.909381812346;4531.048479819275;4532.546745325507;3609.0616439725336;3734;3923.7449565778134;4016.116454380032;4092.9386059209137;3519.5776506819348;3556.822158892045;3680.5399325084363;3698.5007024051947;3713.294474049922;1207.4928530017414;1221.6029790318182;1231.846019247594;1233.8149277608431;1248.6691026877884;842.5702891525243;846.1707526623943;849.3205435651578;876.1720174435225;876.5923845411914;4755.478246961008;4870.391201099863;4960.975195124001;4965.106280869406;5029.220470827027;539.5225225675227;544.0533471759111;552.2654869024268;563.3718403979533;569.8888716700286;3317.8506967186054;3319.4025075486643;3323.5845519310087;3364.2262279675324;3448.3965306071336;8557.10150434208;8849.070847561043;8874.77813054666;8885.15591018865;8900.510471923977;8725.956370218235;8788.824223515494;8818.95590522056;8829.16122968317;8837.867431988525;6779;6883.965580172067;6959.164900212007;6959.512834101665;6964.199117101497;4626.6298696104905;4642.605378542727;4736.455307639666;4823.1800593898415;4891.437484689306;7917.683292668459;8064.233897779702;8157.918420815716;8163.755087347389;8165.918340816515;8158.143394943446;8159.592020399075;8198.59007049657;8262.42163048581;8266.214709602578;5813.709314534341;6003.909941350796;6353.205849268841;6417.2299324081405;6424.38968298011;6772.492063095189;6971.407430368476;6982.441404687715;7096.2548932363425;7176.4258859290085;6289.276733175743;6411.7755878545895;6419.2296924369375;6467.805965821033;6594.208694956636;6344.460720838596;6376.93623063782;6381.680915954276;6436.678166091583;6459.838504037437;5580;5637.43625637433;5645.40723224072;5647.237622920853;5650.180723795109;4196.878272577694;4277.2087163874785;4355.73865568067;4362.629176519905;4432.312991486325;4455.888602784957;4493.797779100014;4535.455745310584;4633.629309655287;4696.882577935579 03:26:21 INFO - PROCESS | 32328 | |4;prototype.html;343.5842630417195;344.24953601149485;354.89175801380577;357.7442128877852;357.9982100089499;4736.3369128322065;4818.373611430514;4825.855224343267;4832.178529649964;4866.829660961867;4767.879548306154;4783.928241076378;4798.616110711135;4817.108834865552;4818.409924724841;3709.4992176056226;3769.283836071151;3779.659830615244;3807.8857634271017;3841.8463261469506;3841.865534706286;3843.577206507282;3861.5945325740813;3863.729538932276;3878.2437424702193;3838.347480928249;3858.6527212550864;3862.7682339059606;3864.169203621235;3867.5552311484257;3687.9078023049506;3786.772793632391;3810.980180504351;3859.4982652255308;3872.419137129425;3449.448088305859;3457.239407330383;3460.9826950865336;3462.4633181856852;3472.6527347265323;4678.485366609671;4684.695494792828;4685.953140468586;4705.505921878222;4725.243960966229;4231.386448964883;4344.543822898581;4364;4383.561643835623;4386.649068074546;5011.5489605935645;5030.974845125787;5038.901075838369;5044.243363495469;5060.873478163076;3770.8868733938025;3776.847197097655;3792.8862134135743;3798.164403831153;3803.9809800951093;5017.222330538772;5258.316418865523;5264.578833693334;5284.339457567804;5313.468653134656;3499.825008749603;3525.2244506208594;3529.8941031769086;3533.381658209803;3541.734369922266;3568.946465803015;3578;3578.6063533011347;3585.1933315004435;3588.659077387644;4144.295469770086;4155.709100362946;4169.56219596944;4169.8957526062095;4190.224808410393;4877.439094504107;5038.546530812245;5067.822626208139;5069.721165335942;5092.9236061459105;1235.5860786636576;1239.6528971887885;1241.6399244219256;1245.470674963137;1248.6691026877884;804.5936801914995;820.7332616899531;847.5423271433357;849.4308813095241;855.5166331023077;4222.493300803923;4276.550962148992;4444.355568442557;4466.129104824593;4476.843310484182;5130.74296797287;5169.46696118899;5177.378714554277;5188.8962220755375;5190.2214667800135;4412.955870441255;4417.580329868657;4423.933640995388;4435.159408845358;4444.599986001211;2557.808164387641;2673.5454972654697;2724.7275272472593;2728;2728.577070554067;4817.27740838877;4817.662763606514;4823.879403014953;4838.854834354975;4840.540148685869;4971.776270067856;5149.2791009258735;5161.81933632321;5205.590338328401;5213.661112027706;4850.6362022848425;4880.145974454456;4930.457649658463;4938.506149385033;4944.975275123601;5223.242629818579;5226.63413561047;5228.451012643618;5233.816816411408;5235.371755389226;4830.444498882533;5100.566451851634;5145.228215767515;5152.355955505562;5181.715005674724;4877.585500205043;4890.731009794496;4893.339399181065;4906.190478570996;4913.6069114471475;3567.857285708543;3590.533230679995;3597.6582224688614;3607.4949507069555;3609.512715783336;5075.92386114216;5198;5214.504622060898;5241.659292145999;5250.928206998949;5020.899582008413;5023.246513023076;5025.648204625787;5030.924536131888;5033.219850923113;5014.8465852853315;5032.345795046621;5043.621728370314;5059.519345662156;5071.264666623393;4794.232922732346;4947.960928204973;4987.426445958761;5001.1498045331655;5017.896062866163;4783.4738178801;4914.36113305268;4929.827456039022;5044.848654540369;5069.797208111634;4922.72924989129;4939.0243902439315;4958.603311734981;4962.330085438564;4971.477994810638 03:26:21 INFO - PROCESS | 32328 | |5;yui.html;666.5400873397358;687.7764726463901;744.6760659113282;783.8902553642489;803.7789607857836;13166.934165329172;13660.043796934218;13941.512047078355;13955.023148379592;13979.091359061667;13219.272939988297;13399.799003014938;13407.128536645136;13410.73178536431;13419.932900335485;653.9019147127946;669.176912397751;800.7197480881674;803.1125606205132;815.2621877201112;824.575343697996;825.2531459029587;826.0624191542612;828.0270681948716;829.4194064155085;867.6442658510013;870.3254977392509;870.8258348330328;871.5685735560875;874.8993865705462;697.1425147069133;717.0212659719498;719.6509692798988;720.5244538604549;872.7250915961483;619.4672581579838;628.7924984755066;635.0727937211676;635.0854769132435;637.7895294552786;12341.012718982549;12426;12472.376381180904;12485.438155283035;12499.687507812287;12684.175528590613;12749.617511474671;12803.48786048557;12986.740265194738;13083.542076027388;11833.704157396049;11961.401929903557;12048.45781939806;12134.453949572291;12144;4059.1272876331436;4060.4112403701592;4110.547839737626;4121.093359460914;4173.7495750254775;58754.706226469025;59972;60930.695346523426;61156.388436115514;61783.38216617821;10313.896861031444;10364.429956352322;10510.684679459628;10517.582615301439;10693.465326733633;20067.59864802725;20072.69890951637;20088.39734807958;20129.899350503154;20137.194512219347;6347.143135676717;6364.6316042051185;6435.806925792233;6554.639494827735;6660.800175994728;3385.306012267479;3441.397755392796;3490.877819276313;3527.2416430467574;3538.469229615578;2693.097812232924;2731.4810186064583;2752.7109653486496;2778.235985104072;2779.277387879166;463.5272022537061;470.2710798262679;471.6156332588929;473.90521895621015;475.36301356182884;547.8657728856456;553.1481518461604;554.2102503931961;556.3185098254605;567.625367257608;7591.354734847489;7824.647890844925;7853.646585903648;7865.056193256846;7927;534.727289082563;553.6567328256507;554.1410813239463;557.4676184244119;572.7880684146892;3585.4442561403025;3612.1692010837655;3634.3821550336506;3689.723270754704;3827.559830619459;50665.74667126641;51179.232311515356;52271.47728522666;57081.42918570844;64949.67525162344;47898;53753.73123134359;54480.72759636256;54835;56550.151747723816;48249.75875120672;48357;49276.75361623169;50319.74840125776;51135.23297150546;8910.955445222733;9230.307726920373;9400.435973841591;9494.382865113745;9506.28702847303;33916;34164.658353417144;34310;34504;34539;43050.42314347895;43378.783106084265;43405;43778.562214377445;44182.33726494041;11208.27146235492;11249.100071994057;11375.26060806045;11400.201985861242;11814.586489472827;12008;12123.211991220542;12276.693082673004;12645.304508252135;13172.407241673956;11792.823107653221;11836.46735896904;12337.691557711129;12521.248725076524;12545.93727031359;10653.520591573553;11416.714582135513;11645.045556103007;11688.240264382788;12143.453544590338;11617.47721352558;11659.591914282959;12046.156769026084;12096.637100886988;12294.20087694297;9033.457992520469;9094.772630684285;9216.907830921606;9227.492487912961;9465.526723663927;8752.956235219039;9003.54982250898;9260.166585007382;9321.067893210624;9415.011423800403 03:26:21 INFO - PROCESS | 32328 | __end_tp_report 03:26:21 INFO - PROCESS | 32328 | __start_cc_report 03:26:21 INFO - PROCESS | 32328 | _x_x_mozilla_cycle_collect,1153 03:26:21 INFO - PROCESS | 32328 | __end_cc_report 03:26:21 INFO - PROCESS | 32328 | __startTimestamp1484306781303__endTimestamp 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | ------- Summary: start ------- 03:26:21 INFO - PROCESS | 32328 | Number of tests: 6 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#0] dojo.html Cycles:165 Average:4685.72 Median:4850.59 stddev:595.69 (12.3%) stddev-sans-first:573.88 03:26:21 INFO - PROCESS | 32328 | Values: 2567.7 2582.8 2600.9 2630.7 2640.6 4671.1 4713.7 4744.5 4777.9 4793.0 4746.7 4758.5 4762.5 4768.9 4774.2 4343.0 4347.9 4365.7 4369.6 4386.6 4351.7 4389.0 4393.3 4416.1 4430.7 4399.7 4415.6 4415.8 4418.3 4472.6 557.2 4365.5 4375.6 4408.3 4428.0 3912.2 4318.8 4329.2 4333.3 4361.7 4688.1 4688.2 4700.5 4707.9 4733.7 4969.7 5043.7 5044.6 5055.3 5096.7 5009.8 5038.4 5054.9 5072.4 5192.0 4793.0 4803.0 4803.5 4809.8 4851.6 5228.5 5234.0 5242.8 5243.0 5245.0 4953.6 4954.5 4991.6 4994.6 4995.4 5082.1 5084.1 5086.5 5090.1 5135.1 5057.5 5058.6 5059.4 5064.5 5089.8 4957.7 5007.4 5017.9 5034.5 5040.1 4351.4 4359.5 4396.4 4401.2 4403.4 3729.4 3770.3 3773.0 3776.2 3780.3 4375.8 4403.8 4410.6 4412.6 4423.9 5015.9 5076.8 5104.7 5116.7 5136.0 4417.5 4429.3 4436.3 4443.3 4445.7 4575.9 4579.2 4579.7 4589.1 4643.8 4785.9 4787.4 4797.1 4808.1 4845.5 4941.4 4994.5 5100.7 5122.4 5136.6 4851.3 4861.2 4869.6 4887.0 4899.4 5033.5 5038.1 5087.7 5093.2 5095.6 5070.0 5083.4 5136.1 5137.0 5228.5 5035.7 5041.2 5042.1 5076.5 5089.8 5025.6 5027.6 5032.4 5037.6 5075.5 4821.3 4823.2 4848.7 4975.1 4982.0 4931.9 4954.7 4969.0 5009.3 5017.1 4845.5 4850.6 4853.9 4864.8 4918.9 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#1] ext.html Cycles:180 Average:43084.25 Median:177794.68 stddev:73156.81 (41.1%) stddev-sans-first:73292.30 03:26:21 INFO - PROCESS | 32328 | Values: 539.0 555.9 562.3 572.5 595.4 37887.2 39648.6 39826.2 44786.0 44837.8 41008.4 41495.0 41524.6 41558.4 41578.0 7642.5 7678.5 7840.2 7848.2 7848.2 7580.1 7808.3 7810.9 9787.3 10033.0 10230.0 10294.8 10295.3 10297.5 10307.6 10073.6 10135.5 10140.3 10142.1 10151.7 10077.4 10149.6 10152.5 10155.3 10184.0 38717.6 38951.8 39030.2 39032.4 39142.0 3463.2 3463.5 3497.6 3499.7 3504.6 28589.1 29256.4 29305.9 29316.9 29388.0 3364.2 3434.5 3454.4 3486.7 3532.6 233906.0 234141.0 234213.0 234910.0 235275.0 51576.2 51882.5 52309.2 52436.0 52451.7 56146.8 56221.2 56221.7 56275.2 56286.4 12648.6 12844.4 12860.5 12867.0 12874.0 9595.5 9596.0 9620.4 9633.3 9657.5 14661.2 15076.2 16090.7 16524.8 16595.5 5515.4 5833.9 5919.3 5958.2 6022.7 826.9 835.8 843.4 859.2 873.8 26872.0 28125.0 28575.4 28725.0 28779.7 966.4 972.9 978.2 987.4 1100.0 13789.0 14255.8 14883.4 15178.8 15277.8 317931.0 321996.0 322516.0 322962.0 323232.0 44204.8 44338.3 44410.6 44436.1 44455.8 1246.9 1273.4 1284.5 1286.8 1291.5 24203.6 24600.9 25867.2 25988.0 26009.2 36886.3 37243.8 37261.0 37292.8 37362.3 274742.0 275468.0 275587.0 275664.0 275711.0 23208.9 23322.2 23528.9 23544.6 23956.0 32387.8 33319.5 33334.7 38539.3 38540.0 30040.4 32299.7 32754.8 33102.2 33409.3 32110.8 32189.7 32211.0 32845.8 33070.3 31625.7 31734.8 31940.0 31985.9 32357.4 27863.3 29266.0 29728.7 29985.3 30057.7 23467.9 23511.4 23845.3 23877.9 24024.2 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#2] jquery.html Cycles:180 Average:28356.64 Median:4685.51 stddev:82208.59 (1754.5%) stddev-sans-first:82412.35 03:26:21 INFO - PROCESS | 32328 | Values: 370.8 381.9 386.5 397.1 412.4 12938.3 13360.2 16668.7 18141.7 18153.2 13165.3 15387.2 15614.0 15646.1 15647.7 5046.2 5286.5 5288.4 5290.4 5300.4 5150.6 5171.7 5204.9 5236.2 5247.6 5218.2 5236.2 5242.6 5246.7 5247.2 5051.7 5214.4 5231.9 5237.8 5281.7 4758.5 4766.0 4771.6 4771.7 4773.9 16368.0 20437.0 21078.3 21169.2 21413.6 2287.2 2480.7 2480.7 2507.4 2529.8 9459.3 9704.0 9910.0 11892.9 13460.4 1765.8 1798.9 1807.7 1833.2 1843.3 71738.0 75672.6 75883.2 76882.0 77757.6 10539.1 10539.7 10738.6 11046.2 11125.2 14618.9 14646.4 14649.7 14650.3 14656.4 6735.3 6852.1 6951.4 7067.5 7072.6 6179.9 6216.7 6406.0 6441.2 6454.5 4448.3 4583.5 4612.5 4770.9 4828.0 1885.0 1904.0 1918.6 1953.1 1969.5 779.7 797.3 798.7 823.6 835.1 17391.2 17436.7 17711.4 18789.8 18846.6 853.3 878.1 885.2 887.4 896.7 9463.2 10083.6 10110.7 10124.1 10240.8 491769.0 497152.0 498301.0 501575.0 502545.0 91055.5 92584.0 95086.0 96872.5 97214.5 823.8 845.4 847.5 848.5 850.6 15411.7 15514.6 15795.5 15919.4 16133.5 39725.4 40541.8 41006.6 41969.0 42027.4 54964.7 56713.0 57114.7 57757.7 58417.1 7736.7 7902.9 7987.9 8040.8 8291.0 11357.0 12535.1 12548.6 12661.4 12932.8 10969.7 11014.9 11031.8 11071.1 11210.3 10751.0 11012.7 11162.1 11229.7 11348.0 7371.4 9951.4 10580.8 10593.4 10685.8 7792.6 7907.8 7963.7 7997.6 8075.6 8044.8 10513.8 10568.9 10649.7 11120.0 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#3] mootools.html Cycles:180 Average:4821.05 Median:4880.91 stddev:2621.52 (53.7%) stddev-sans-first:2615.97 03:26:21 INFO - PROCESS | 32328 | Values: 1360.2 1365.6 1379.6 1387.6 1396.5 6966.2 7397.0 7405.3 7407.2 7413.3 6452.5 6637.6 7030.0 7227.8 7287.9 2148.9 2180.9 2185.7 2187.2 2192.5 2127.5 2163.6 2178.8 2179.7 2181.1 1865.7 1938.0 2091.4 2150.2 2155.4 2103.8 2117.4 2118.9 2121.0 2122.9 2057.4 2068.5 2069.3 2069.8 2144.1 7418.6 7466.4 7486.7 7489.4 7493.7 4266.4 4383.2 4400.4 4414.8 4416.8 2705.3 2807.3 2878.3 2880.0 2923.5 1023.7 1050.2 1052.9 1071.7 1098.9 9780.6 9833.1 9835.7 9841.8 9846.2 4013.0 4219.9 4281.0 4283.9 4312.9 8476.4 8476.5 8484.1 8484.6 8486.6 4511.4 4520.5 4530.9 4531.0 4532.5 3609.1 3734.0 3923.7 4016.1 4092.9 3519.6 3556.8 3680.5 3698.5 3713.3 1207.5 1221.6 1231.8 1233.8 1248.7 842.6 846.2 849.3 876.2 876.6 4755.5 4870.4 4961.0 4965.1 5029.2 539.5 544.1 552.3 563.4 569.9 3317.9 3319.4 3323.6 3364.2 3448.4 8557.1 8849.1 8874.8 8885.2 8900.5 8726.0 8788.8 8819.0 8829.2 8837.9 6779.0 6884.0 6959.2 6959.5 6964.2 4626.6 4642.6 4736.5 4823.2 4891.4 7917.7 8064.2 8157.9 8163.8 8165.9 8158.1 8159.6 8198.6 8262.4 8266.2 5813.7 6003.9 6353.2 6417.2 6424.4 6772.5 6971.4 6982.4 7096.3 7176.4 6289.3 6411.8 6419.2 6467.8 6594.2 6344.5 6376.9 6381.7 6436.7 6459.8 5580.0 5637.4 5645.4 5647.2 5650.2 4196.9 4277.2 4355.7 4362.6 4432.3 4455.9 4493.8 4535.5 4633.6 4696.9 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#4] prototype.html Cycles:180 Average:4184.74 Median:4807.86 stddev:1209.92 (25.2%) stddev-sans-first:1178.46 03:26:21 INFO - PROCESS | 32328 | Values: 343.6 344.2 354.9 357.7 358.0 4736.3 4818.4 4825.9 4832.2 4866.8 4767.9 4783.9 4798.6 4817.1 4818.4 3709.5 3769.3 3779.7 3807.9 3841.8 3841.9 3843.6 3861.6 3863.7 3878.2 3838.3 3858.7 3862.8 3864.2 3867.6 3687.9 3786.8 3811.0 3859.5 3872.4 3449.4 3457.2 3461.0 3462.5 3472.7 4678.5 4684.7 4686.0 4705.5 4725.2 4231.4 4344.5 4364.0 4383.6 4386.6 5011.5 5031.0 5038.9 5044.2 5060.9 3770.9 3776.8 3792.9 3798.2 3804.0 5017.2 5258.3 5264.6 5284.3 5313.5 3499.8 3525.2 3529.9 3533.4 3541.7 3568.9 3578.0 3578.6 3585.2 3588.7 4144.3 4155.7 4169.6 4169.9 4190.2 4877.4 5038.5 5067.8 5069.7 5092.9 1235.6 1239.7 1241.6 1245.5 1248.7 804.6 820.7 847.5 849.4 855.5 4222.5 4276.6 4444.4 4466.1 4476.8 5130.7 5169.5 5177.4 5188.9 5190.2 4413.0 4417.6 4423.9 4435.2 4444.6 2557.8 2673.5 2724.7 2728.0 2728.6 4817.3 4817.7 4823.9 4838.9 4840.5 4971.8 5149.3 5161.8 5205.6 5213.7 4850.6 4880.1 4930.5 4938.5 4945.0 5223.2 5226.6 5228.5 5233.8 5235.4 4830.4 5100.6 5145.2 5152.4 5181.7 4877.6 4890.7 4893.3 4906.2 4913.6 3567.9 3590.5 3597.7 3607.5 3609.5 5075.9 5198.0 5214.5 5241.7 5250.9 5020.9 5023.2 5025.6 5030.9 5033.2 5014.8 5032.3 5043.6 5059.5 5071.3 4794.2 4948.0 4987.4 5001.1 5017.9 4783.5 4914.4 4929.8 5044.8 5069.8 4922.7 4939.0 4958.6 4962.3 4971.5 03:26:21 INFO - PROCESS | 32328 | 03:26:21 INFO - PROCESS | 32328 | [#5] yui.html Cycles:180 Average:14255.36 Median:466.90 stddev:16952.66 (3630.9%) stddev-sans-first:16969.50 03:26:21 INFO - PROCESS | 32328 | Values: 666.5 687.8 744.7 783.9 803.8 13166.9 13660.0 13941.5 13955.0 13979.1 13219.3 13399.8 13407.1 13410.7 13419.9 653.9 669.2 800.7 803.1 815.3 824.6 825.3 826.1 828.0 829.4 867.6 870.3 870.8 871.6 874.9 697.1 717.0 719.7 720.5 872.7 619.5 628.8 635.1 635.1 637.8 12341.0 12426.0 12472.4 12485.4 12499.7 12684.2 12749.6 12803.5 12986.7 13083.5 11833.7 11961.4 12048.5 12134.5 12144.0 4059.1 4060.4 4110.5 4121.1 4173.7 58754.7 59972.0 60930.7 61156.4 61783.4 10313.9 10364.4 10510.7 10517.6 10693.5 20067.6 20072.7 20088.4 20129.9 20137.2 6347.1 6364.6 6435.8 6554.6 6660.8 3385.3 3441.4 3490.9 3527.2 3538.5 2693.1 2731.5 2752.7 2778.2 2779.3 463.5 470.3 471.6 473.9 475.4 547.9 553.1 554.2 556.3 567.6 7591.4 7824.6 7853.6 7865.1 7927.0 534.7 553.7 554.1 557.5 572.8 3585.4 3612.2 3634.4 3689.7 3827.6 50665.7 51179.2 52271.5 57081.4 64949.7 47898.0 53753.7 54480.7 54835.0 56550.2 48249.8 48357.0 49276.8 50319.7 51135.2 8911.0 9230.3 9400.4 9494.4 9506.3 33916.0 34164.7 34310.0 34504.0 34539.0 43050.4 43378.8 43405.0 43778.6 44182.3 11208.3 11249.1 11375.3 11400.2 11814.6 12008.0 12123.2 12276.7 12645.3 13172.4 11792.8 11836.5 12337.7 12521.2 12545.9 10653.5 11416.7 11645.0 11688.2 12143.5 11617.5 11659.6 12046.2 12096.6 12294.2 9033.5 9094.8 9216.9 9227.5 9465.5 8753.0 9003.5 9260.2 9321.1 9415.0 03:26:21 INFO - PROCESS | 32328 | -------- Summary: end -------- 03:26:21 INFO - PROCESS | 32328 | 03:26:22 INFO - TEST-INFO | 32328: exit 0 03:26:22 INFO - TEST-OK | dromaeo_css | took 1120866ms 03:26:22 INFO - TEST-START | kraken 03:26:22 INFO - operating with platform_type : linux_ 03:26:22 INFO - Initialising browser for kraken test... 03:26:22 INFO - TEST-INFO | started process 32635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_HMkU4/profile http://localhost:34336/getInfo.html) 03:26:26 INFO - PROCESS | 32635 | __metrics Screen width/height:1600/1200 03:26:26 INFO - PROCESS | 32635 | colorDepth:24 03:26:26 INFO - PROCESS | 32635 | Browser inner width/height: 1024/697 03:26:26 INFO - PROCESS | 32635 | __metrics 03:26:27 INFO - PROCESS | 32635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:27 INFO - PROCESS | 32635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:28 INFO - PROCESS | 32635 | console.error: PushService: 03:26:28 INFO - PROCESS | 32635 | stateChangeProcessEnqueue: Error transitioning state 03:26:28 INFO - PROCESS | 32635 | UnknownError 03:26:29 INFO - TEST-INFO | 32635: exit 0 03:26:29 INFO - Browser initialized. 03:26:29 INFO - Running cycle 1/1 for kraken test... 03:26:29 INFO - TEST-INFO | started process 32717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_HMkU4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:41 INFO - PROCESS | 32717 | RSS: Main: 152207360 03:26:41 INFO - PROCESS | 32717 | 03:26:43 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34336/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:44 INFO - PROCESS | 32717 | RSS: Main: 206290944 03:26:44 INFO - PROCESS | 32717 | 03:26:47 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34336/tests/kraken/driver.html?testName=audio-dft) 03:26:48 INFO - PROCESS | 32717 | RSS: Main: 186044416 03:26:48 INFO - PROCESS | 32717 | 03:26:51 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34336/tests/kraken/driver.html?testName=audio-fft) 03:26:51 INFO - PROCESS | 32717 | RSS: Main: 268668928 03:26:51 INFO - PROCESS | 32717 | 03:26:54 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34336/tests/kraken/driver.html?testName=audio-oscillator) 03:26:54 INFO - PROCESS | 32717 | RSS: Main: 179752960 03:26:54 INFO - PROCESS | 32717 | 03:26:56 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:57 INFO - PROCESS | 32717 | RSS: Main: 182591488 03:26:57 INFO - PROCESS | 32717 | 03:27:00 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34336/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:01 INFO - PROCESS | 32717 | RSS: Main: 221855744 03:27:01 INFO - PROCESS | 32717 | 03:27:04 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34336/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:05 INFO - PROCESS | 32717 | RSS: Main: 221470720 03:27:05 INFO - PROCESS | 32717 | 03:27:08 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34336/tests/kraken/driver.html?testName=json-parse-financial) 03:27:08 INFO - PROCESS | 32717 | RSS: Main: 220172288 03:27:08 INFO - PROCESS | 32717 | 03:27:10 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:11 INFO - PROCESS | 32717 | RSS: Main: 183152640 03:27:11 INFO - PROCESS | 32717 | 03:27:12 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:13 INFO - PROCESS | 32717 | RSS: Main: 189472768 03:27:13 INFO - PROCESS | 32717 | 03:27:15 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:16 INFO - PROCESS | 32717 | RSS: Main: 197554176 03:27:16 INFO - PROCESS | 32717 | 03:27:19 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:19 INFO - PROCESS | 32717 | RSS: Main: 206917632 03:27:19 INFO - PROCESS | 32717 | 03:27:22 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:23 INFO - PROCESS | 32717 | RSS: Main: 204353536 03:27:23 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | Cycle 1(1): loaded http://localhost:34336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34336/tests/kraken/driver.html?testName=ai-astar) 03:27:25 INFO - PROCESS | 32717 | RSS: Main: 255164416 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | __start_tp_report 03:27:25 INFO - PROCESS | 32717 | _x_x_mozilla_page_load 03:27:25 INFO - PROCESS | 32717 | _x_x_mozilla_page_load_details 03:27:25 INFO - PROCESS | 32717 | |i|pagename|runs| 03:27:25 INFO - PROCESS | 32717 | |0;ai-astar;111;116;114;114;115;114;114;114;115;113 03:27:25 INFO - PROCESS | 32717 | |1;audio-beat-detection;151;125;124;175;124;128;124;130;157;124 03:27:25 INFO - PROCESS | 32717 | |2;audio-dft;160;162;160;161;160;160;168;160;160;161 03:27:25 INFO - PROCESS | 32717 | |3;audio-fft;77;75;75;106;76;75;75;75;94;76 03:27:25 INFO - PROCESS | 32717 | |4;audio-oscillator;85;85;117;86;85;85;97;84;84;105 03:27:25 INFO - PROCESS | 32717 | |5;imaging-gaussian-blur;117;117;117;117;116;117;124;117;116;117 03:27:25 INFO - PROCESS | 32717 | |6;imaging-darkroom;149;149;149;150;150;151;150;149;149;150 03:27:25 INFO - PROCESS | 32717 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;95 03:27:25 INFO - PROCESS | 32717 | |8;json-parse-financial;60;62;63;62;63;65;64;62;65;61 03:27:25 INFO - PROCESS | 32717 | |9;json-stringify-tinderbox;68;67;67;68;67;67;67;67;68;70 03:27:25 INFO - PROCESS | 32717 | |10;stanford-crypto-aes;85;93;85;84;86;85;85;85;93;83 03:27:25 INFO - PROCESS | 32717 | |11;stanford-crypto-ccm;143;134;142;136;141;131;138;135;176;132 03:27:25 INFO - PROCESS | 32717 | |12;stanford-crypto-pbkdf2;174;174;177;177;178;173;173;172;172;176 03:27:25 INFO - PROCESS | 32717 | |13;stanford-crypto-sha256-iterative;68;69;67;66;66;68;69;66;67;66 03:27:25 INFO - PROCESS | 32717 | __end_tp_report 03:27:25 INFO - PROCESS | 32717 | __start_cc_report 03:27:25 INFO - PROCESS | 32717 | _x_x_mozilla_cycle_collect,1840 03:27:25 INFO - PROCESS | 32717 | __end_cc_report 03:27:25 INFO - PROCESS | 32717 | __startTimestamp1484306845423__endTimestamp 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | ------- Summary: start ------- 03:27:25 INFO - PROCESS | 32717 | Number of tests: 14 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 03:27:25 INFO - PROCESS | 32717 | Values: 111.0 116.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 113.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.00 stddev:18.21 (14.1%) stddev-sans-first:18.51 03:27:25 INFO - PROCESS | 32717 | Values: 151.0 125.0 124.0 175.0 124.0 128.0 124.0 130.0 157.0 124.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#2] audio-dft Cycles:10 Average:161.20 Median:160.50 stddev:2.49 (1.5%) stddev-sans-first:2.60 03:27:25 INFO - PROCESS | 32717 | Values: 160.0 162.0 160.0 161.0 160.0 160.0 168.0 160.0 160.0 161.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.73 (14.2%) stddev-sans-first:11.31 03:27:25 INFO - PROCESS | 32717 | Values: 77.0 75.0 75.0 106.0 76.0 75.0 75.0 75.0 94.0 76.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:85.00 stddev:11.42 (13.4%) stddev-sans-first:11.88 03:27:25 INFO - PROCESS | 32717 | Values: 85.0 85.0 117.0 86.0 85.0 85.0 97.0 84.0 84.0 105.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:2.32 (2.0%) stddev-sans-first:2.46 03:27:25 INFO - PROCESS | 32717 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 124.0 117.0 116.0 117.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 03:27:25 INFO - PROCESS | 32717 | Values: 149.0 149.0 149.0 150.0 150.0 151.0 150.0 149.0 149.0 150.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:27:25 INFO - PROCESS | 32717 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.64 (2.6%) stddev-sans-first:1.41 03:27:25 INFO - PROCESS | 32717 | Values: 60.0 62.0 63.0 62.0 63.0 65.0 64.0 62.0 65.0 61.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:0.97 (1.4%) stddev-sans-first:1.01 03:27:25 INFO - PROCESS | 32717 | Values: 68.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 70.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:3.57 (4.2%) stddev-sans-first:3.75 03:27:25 INFO - PROCESS | 32717 | Values: 85.0 93.0 85.0 84.0 86.0 85.0 85.0 85.0 93.0 83.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.50 stddev:13.04 (9.3%) stddev-sans-first:13.80 03:27:25 INFO - PROCESS | 32717 | Values: 143.0 134.0 142.0 136.0 141.0 131.0 138.0 135.0 176.0 132.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:2.22 (1.3%) stddev-sans-first:2.35 03:27:25 INFO - PROCESS | 32717 | Values: 174.0 174.0 177.0 177.0 178.0 173.0 173.0 172.0 172.0 176.0 03:27:25 INFO - PROCESS | 32717 | 03:27:25 INFO - PROCESS | 32717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 03:27:25 INFO - PROCESS | 32717 | Values: 68.0 69.0 67.0 66.0 66.0 68.0 69.0 66.0 67.0 66.0 03:27:25 INFO - PROCESS | 32717 | -------- Summary: end -------- 03:27:25 INFO - PROCESS | 32717 | 03:27:26 INFO - TEST-INFO | 32717: exit 0 03:27:26 INFO - TEST-OK | kraken | took 64356ms 03:27:26 INFO - SUITE-END | took 1185s 03:27:27 INFO - Completed test suite (00:19:45) 03:27:27 INFO - javascript benchmark 03:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.730388309227, 2582.7933765298776, 2600.9349766255855, 2630.671166104237, 2640.5775075987845, 4671.135839869618, 4713.670043096985, 4744.478107408187, 4777.9283310750325, 4792.976035119824, 4746.715197088177, 4758.500357462469, 4762.476127625959, 4768.880777980552, 4774.188387974044, 4342.956570434302, 4347.93478097828, 4365.650747940157, 4369.606735393814, 4386.627136693385, 4351.73889566627, 4389.034412429261, 4393.319035549495, 4416.050549131936, 4430.734155950637, 4399.67002474814, 4415.646748260147, 4415.757133357664, 4418.293073108303, 4472.575105365001, 557.1524239379139, 4365.476142862845, 4375.562443755631, 4408.272635015219, 4427.9557204427865, 3912.2371137628174, 4318.82724691012, 4329.1558146161515, 4333.328334108218, 4361.651067914591, 4688.085823264465, 4688.179568575486, 4700.4594471635855, 4707.8587642370785, 4733.739644319561, 4969.726665033421, 5043.672161309503, 5044.571211447032, 5055.292259083732, 5096.668716533451, 5009.799608015712, 5038.395392552917, 5054.873628159326, 5072.416672082684, 5192.039472697563, 4793.0, 4802.975985120052, 4803.543663351976, 4809.807607695688, 4851.56335929768, 5228.529432351031, 5234.0, 5242.842714718565, 5242.97378513105, 5245.003449344612, 4953.603711703127, 4954.504549545089, 4991.575716064175, 4994.600431965434, 4995.425526064477, 5082.1360368737405, 5084.059449001947, 5086.516780905808, 5090.10923088458, 5135.075686376488, 5057.544820966057, 5058.64589478733, 5059.418166910778, 5064.544191022752, 5089.796408143707, 4957.702537847668, 5007.4241462231585, 5017.874553136201, 5034.521720436553, 5040.1179793535985, 4351.434313539283, 4359.476862776487, 4396.384506169139, 4401.163778882003, 4403.383526306319, 3729.4405839123806, 3770.2836461072307, 3773.0, 3776.188119554254, 3780.281746468162, 4375.824967001285, 4403.757793321398, 4410.558944105564, 4412.558744125562, 4423.867283981485, 5015.949840501621, 5076.771545280471, 5104.668196567211, 5116.718580478035, 5136.0241554104605, 4417.491988421372, 4429.313456414261, 4436.334549817489, 4443.333499974965, 4445.666575006888, 4575.9084818303445, 4579.175748365326, 4579.748113853703, 4589.082183563234, 4643.791029403685, 4785.856424307276, 4787.40157480315, 4797.088553174885, 4808.08646357191, 4845.53967373099, 4941.357623508921, 4994.450610432922, 5100.69395836251, 5122.436531981404, 5136.640435169502, 4851.272309153655, 4861.246506791453, 4869.610431165569, 4887.047025829929, 4899.387576552931, 5033.546980771748, 5038.093143234107, 5087.720175390389, 5093.159628661378, 5095.617828662939, 5070.036693028313, 5083.364579427572, 5136.1268584340005, 5137.049645815536, 5228.477152284741, 5035.723035233097, 5041.193409054534, 5042.117629414764, 5076.492350765042, 5089.821856235162, 5025.572826309804, 5027.622928280321, 5032.421271553818, 5037.647364684583, 5075.543201111917, 4821.276808478756, 4823.204171311834, 4848.733319667452, 4975.10448119342, 4982.0, 4931.901361972812, 4954.727489988085, 4969.0, 5009.323741295024, 5017.096922553976, 4845.466998630078, 4850.587700045395, 4853.927191092066, 4864.805407783649, 4918.92621610669], "value": 4648.930644958279, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9730513474326, 555.9471850174232, 562.308360716319, 572.4847637126586, 595.431363048289, 37887.24225515488, 39648.60351396485, 39826.2034759305, 44786.0, 44837.77581112098, 41008.38487422691, 41495.0, 41524.58475415245, 41558.37662435066, 41578.0, 7642.541447513139, 7678.539287642731, 7840.2159784021715, 7848.175941526143, 7848.2151784821635, 7580.090389153309, 7808.336291415237, 7810.921890781105, 9787.314887957846, 10033.0, 10230.0, 10294.794104117913, 10295.330803497785, 10297.536610852492, 10307.63923262686, 10073.597056117747, 10135.543900524493, 10140.290179687425, 10142.137918276956, 10151.695449136463, 10077.44574048427, 10149.644762433354, 10152.492375381202, 10155.28912976092, 10184.0, 38717.612823871685, 38951.80524097361, 39030.219395612214, 39032.414513782314, 39142.0, 3463.1861512544783, 3463.463163209681, 3497.6327485613897, 3499.7025252853537, 3504.56192975878, 28589.142325730263, 29256.414871702447, 29305.85347073251, 29316.853415733, 29388.0, 3364.2094107884627, 3434.5191673165778, 3454.360943225511, 3486.6687664672068, 3532.6114127445962, 233906.0, 234141.0, 234213.0, 234910.0, 235275.0, 51576.22635660468, 51882.48117518852, 52309.2153617696, 52436.0, 52451.73774131105, 56146.78899082585, 56221.156682649795, 56221.71889140528, 56275.15587266194, 56286.43713562812, 12648.620541383772, 12844.357782110857, 12860.549880754128, 12867.0, 12874.0, 9595.520223988913, 9595.952020239854, 9620.422774633544, 9633.277504187214, 9657.46883921377, 14661.19363435, 15076.24618769057, 16090.678186436206, 16524.834751652328, 16595.50213493573, 5515.393306736256, 5833.88332233353, 5919.260092488439, 5958.225430694069, 6022.728977196037, 826.8553003224412, 835.824476859854, 843.3506200225914, 859.2095272349453, 873.7771868173702, 26872.0, 28125.0, 28575.428491430055, 28725.0, 28779.712202878123, 966.4008314844841, 972.9173020293213, 978.2125389061873, 987.4470296633908, 1100.0484580837679, 13789.0, 14255.78616320756, 14883.404663813542, 15178.772318415233, 15277.847221527865, 317931.0, 321996.0, 322516.0, 322962.0, 323232.0, 44204.778976105554, 44338.33492497615, 44410.55589444129, 44436.11127777491, 44455.77772111184, 1246.856611489672, 1273.4333221716247, 1284.537566476068, 1286.8327117474669, 1291.5156816193928, 24203.561428158628, 24600.876995615625, 25867.22398328053, 25988.0, 26009.21972340833, 36886.26227475489, 37243.813780932, 37261.0, 37292.813535932146, 37362.2527549442, 274742.0, 275468.0, 275587.0, 275664.0, 275711.0, 23208.883955580113, 23322.183723569593, 23528.882355588114, 23544.646830297217, 23956.0, 32387.83806081049, 33319.50020749642, 33334.66665333316, 38539.267847216615, 38540.0, 30040.3991920156, 32299.67700323061, 32754.83622581872, 33102.172445688084, 33409.331813364086, 32110.839445802623, 32189.678103218666, 32211.0, 32845.835770820995, 33070.33859322752, 31625.683743163194, 31734.841325793222, 31940.0, 31985.88049418259, 32357.35285294328, 27863.303417414725, 29266.0, 29728.702712972594, 29985.250368740082, 30057.69942300549, 23467.882660586587, 23511.41221469477, 23845.284641460785, 23877.880610596836, 24024.15915442951], "value": 17086.778937122323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.7738279649415, 381.91562351563897, 386.4705353665479, 397.12434082847324, 412.3834866874022, 12938.288394138319, 13360.198388096722, 16668.74996875048, 18141.7278740819, 18153.183106760196, 13165.341732913364, 15387.230638468087, 15614.0, 15646.139462329567, 15647.687046259096, 5046.192609182541, 5286.497782710637, 5288.418273989858, 5290.418054014055, 5300.416954135061, 5150.562202212816, 5171.674461740975, 5204.895902081956, 5236.240745091959, 5247.632665713401, 5218.217267409881, 5236.21456781482, 5242.55438287746, 5246.68519888806, 5247.239150323201, 5051.722155281458, 5214.400343960418, 5231.947680523203, 5237.79048838046, 5281.683099014072, 4758.476567577563, 4766.0, 4771.618270538349, 4771.6898401603785, 4773.904521909577, 16368.0, 20437.0, 21078.262260820797, 21169.153233870627, 21413.57172856534, 2287.1537531113595, 2480.707810113273, 2480.7395223501453, 2507.4232926426844, 2529.8229123961332, 9459.337846350758, 9704.02959704031, 9909.950450247703, 11892.87017733314, 13460.394282257323, 1765.8057613662486, 1798.8757026858214, 1807.7469154318405, 1833.2208811255296, 1843.2626949220285, 71738.0, 75672.62163689201, 75883.24116758817, 76882.0, 77757.61121194357, 10539.10417614496, 10539.736506587396, 10738.57701860571, 11046.226764126595, 11125.221234513669, 14618.85381146175, 14646.436873547087, 14649.707005859824, 14650.267486625626, 14656.413743450355, 6735.292794256533, 6852.143482064742, 6951.443884489228, 7067.5052746307265, 7072.646367681596, 6179.938200618026, 6216.720247588869, 6406.0, 6441.227052753606, 6454.515911306671, 4448.332750087513, 4583.54164583539, 4612.53874612536, 4770.928436073462, 4827.95172048275, 1884.9623007539772, 1903.961920761577, 1918.6354592627356, 1953.140618128019, 1969.4579761057653, 779.6959185917497, 797.2904115337354, 798.7364169823944, 823.6499487717816, 835.1356346181673, 17391.217395217245, 17436.65126697459, 17711.380101696377, 18789.81210187908, 18846.623067538574, 853.2704537620369, 878.0517041595062, 885.1679421344045, 887.4364778365784, 896.7220161749879, 9463.242940564738, 10083.59665613382, 10110.69667909964, 10124.13944814699, 10240.795184096276, 491769.0, 497152.0, 498301.0, 501575.0, 502545.0, 91055.5447222773, 92584.0, 95086.0, 96872.51563742277, 97214.51392742991, 823.8228780812154, 845.3828705045352, 847.525385783963, 848.512105539305, 850.5789634131145, 15411.69176616439, 15514.612134696723, 15795.526134215992, 15919.363225470852, 16133.482624865057, 39725.40411893766, 40541.7823680998, 41006.58993410028, 41969.0, 42027.36958945679, 54964.72517637386, 56713.0, 57114.7144264276, 57757.711211443675, 58417.12374314474, 7736.7292144774665, 7902.881456778038, 7987.880181797162, 8040.798980025546, 8291.0, 11357.0, 12535.122541422377, 12548.560800371943, 12661.366931653565, 12932.806007910078, 10969.725756856142, 11014.889851101707, 11031.83452248201, 11071.114310855273, 11210.27133236337, 10751.0, 11012.669619911416, 11162.107031437628, 11229.71925701864, 11348.0, 7371.447141464519, 9951.402915825074, 10580.841287380541, 10593.417362045162, 10685.786284274116, 7792.6103694816165, 7907.762767116996, 7963.6814527418255, 7997.600119993861, 8075.596220189084, 8044.839103217786, 10513.842292365467, 10568.947155264175, 10649.680509584725, 11120.0], "value": 8490.735260529706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.2042804959099, 1365.5630198336532, 1379.5516457151427, 1387.5975966969581, 1396.5461225101844, 6966.23371429143, 7397.001404810349, 7405.259474052599, 7407.222241664628, 7413.332800047994, 6452.516061295398, 6637.568558043724, 7029.964850175742, 7227.819304517389, 7287.890681639779, 2148.903299351533, 2180.901859416322, 2185.650295952648, 2187.212603462752, 2192.473806286496, 2127.5106725453156, 2163.6105501009893, 2178.8039076483115, 2179.6730490426403, 2181.1057466438765, 1865.7201419787004, 1937.980620193794, 2091.393495886191, 2150.2474134053114, 2155.4072630026712, 2103.8422118341186, 2117.3965419855267, 2118.936431907045, 2120.9787902120934, 2122.946926326839, 2057.40335302762, 2068.503559145809, 2069.2757534862826, 2069.751629804433, 2144.0994782191515, 7418.591977441239, 7466.365358944497, 7486.663100160506, 7489.400847932152, 7493.737719179857, 4266.424032755569, 4383.211022016036, 4400.44994375703, 4414.779261036967, 4416.823327066913, 2705.3101459127993, 2807.3402750353653, 2878.29481776966, 2879.9856000720074, 2923.4737747205495, 1023.6570748799161, 1050.217587897014, 1052.9157667386667, 1071.7159952612565, 1098.906592939601, 9780.55987480565, 9833.065858743408, 9835.655752048715, 9841.803163936753, 9846.163076138608, 4012.959870401317, 4219.894502637459, 4281.0, 4283.87148385549, 4312.935305970413, 8476.406651534333, 8476.49141051539, 8484.109168537214, 8484.618192181244, 8486.618102185294, 4511.436070491189, 4520.50274469808, 4530.909381812346, 4531.048479819275, 4532.546745325507, 3609.0616439725336, 3734.0, 3923.7449565778134, 4016.116454380032, 4092.9386059209137, 3519.5776506819348, 3556.822158892045, 3680.5399325084363, 3698.5007024051947, 3713.294474049922, 1207.4928530017414, 1221.6029790318182, 1231.846019247594, 1233.8149277608431, 1248.6691026877884, 842.5702891525243, 846.1707526623943, 849.3205435651578, 876.1720174435225, 876.5923845411914, 4755.478246961008, 4870.391201099863, 4960.975195124001, 4965.106280869406, 5029.220470827027, 539.5225225675227, 544.0533471759111, 552.2654869024268, 563.3718403979533, 569.8888716700286, 3317.8506967186054, 3319.4025075486643, 3323.5845519310087, 3364.2262279675324, 3448.3965306071336, 8557.10150434208, 8849.070847561043, 8874.77813054666, 8885.15591018865, 8900.510471923977, 8725.956370218235, 8788.824223515494, 8818.95590522056, 8829.16122968317, 8837.867431988525, 6779.0, 6883.965580172067, 6959.164900212007, 6959.512834101665, 6964.199117101497, 4626.6298696104905, 4642.605378542727, 4736.455307639666, 4823.1800593898415, 4891.437484689306, 7917.683292668459, 8064.233897779702, 8157.918420815716, 8163.755087347389, 8165.918340816515, 8158.143394943446, 8159.592020399075, 8198.59007049657, 8262.42163048581, 8266.214709602578, 5813.709314534341, 6003.909941350796, 6353.205849268841, 6417.2299324081405, 6424.38968298011, 6772.492063095189, 6971.407430368476, 6982.441404687715, 7096.2548932363425, 7176.4258859290085, 6289.276733175743, 6411.7755878545895, 6419.2296924369375, 6467.805965821033, 6594.208694956636, 6344.460720838596, 6376.93623063782, 6381.680915954276, 6436.678166091583, 6459.838504037437, 5580.0, 5637.43625637433, 5645.40723224072, 5647.237622920853, 5650.180723795109, 4196.878272577694, 4277.2087163874785, 4355.73865568067, 4362.629176519905, 4432.312991486325, 4455.888602784957, 4493.797779100014, 4535.455745310584, 4633.629309655287, 4696.882577935579], "value": 3912.044642160377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5842630417195, 344.24953601149485, 354.89175801380577, 357.7442128877852, 357.9982100089499, 4736.3369128322065, 4818.373611430514, 4825.855224343267, 4832.178529649964, 4866.829660961867, 4767.879548306154, 4783.928241076378, 4798.616110711135, 4817.108834865552, 4818.409924724841, 3709.4992176056226, 3769.283836071151, 3779.659830615244, 3807.8857634271017, 3841.8463261469506, 3841.865534706286, 3843.577206507282, 3861.5945325740813, 3863.729538932276, 3878.2437424702193, 3838.347480928249, 3858.6527212550864, 3862.7682339059606, 3864.169203621235, 3867.5552311484257, 3687.9078023049506, 3786.772793632391, 3810.980180504351, 3859.4982652255308, 3872.419137129425, 3449.448088305859, 3457.239407330383, 3460.9826950865336, 3462.4633181856852, 3472.6527347265323, 4678.485366609671, 4684.695494792828, 4685.953140468586, 4705.505921878222, 4725.243960966229, 4231.386448964883, 4344.543822898581, 4364.0, 4383.561643835623, 4386.649068074546, 5011.5489605935645, 5030.974845125787, 5038.901075838369, 5044.243363495469, 5060.873478163076, 3770.8868733938025, 3776.847197097655, 3792.8862134135743, 3798.164403831153, 3803.9809800951093, 5017.222330538772, 5258.316418865523, 5264.578833693334, 5284.339457567804, 5313.468653134656, 3499.825008749603, 3525.2244506208594, 3529.8941031769086, 3533.381658209803, 3541.734369922266, 3568.946465803015, 3578.0, 3578.6063533011347, 3585.1933315004435, 3588.659077387644, 4144.295469770086, 4155.709100362946, 4169.56219596944, 4169.8957526062095, 4190.224808410393, 4877.439094504107, 5038.546530812245, 5067.822626208139, 5069.721165335942, 5092.9236061459105, 1235.5860786636576, 1239.6528971887885, 1241.6399244219256, 1245.470674963137, 1248.6691026877884, 804.5936801914995, 820.7332616899531, 847.5423271433357, 849.4308813095241, 855.5166331023077, 4222.493300803923, 4276.550962148992, 4444.355568442557, 4466.129104824593, 4476.843310484182, 5130.74296797287, 5169.46696118899, 5177.378714554277, 5188.8962220755375, 5190.2214667800135, 4412.955870441255, 4417.580329868657, 4423.933640995388, 4435.159408845358, 4444.599986001211, 2557.808164387641, 2673.5454972654697, 2724.7275272472593, 2728.0, 2728.577070554067, 4817.27740838877, 4817.662763606514, 4823.879403014953, 4838.854834354975, 4840.540148685869, 4971.776270067856, 5149.2791009258735, 5161.81933632321, 5205.590338328401, 5213.661112027706, 4850.6362022848425, 4880.145974454456, 4930.457649658463, 4938.506149385033, 4944.975275123601, 5223.242629818579, 5226.63413561047, 5228.451012643618, 5233.816816411408, 5235.371755389226, 4830.444498882533, 5100.566451851634, 5145.228215767515, 5152.355955505562, 5181.715005674724, 4877.585500205043, 4890.731009794496, 4893.339399181065, 4906.190478570996, 4913.6069114471475, 3567.857285708543, 3590.533230679995, 3597.6582224688614, 3607.4949507069555, 3609.512715783336, 5075.92386114216, 5198.0, 5214.504622060898, 5241.659292145999, 5250.928206998949, 5020.899582008413, 5023.246513023076, 5025.648204625787, 5030.924536131888, 5033.219850923113, 5014.8465852853315, 5032.345795046621, 5043.621728370314, 5059.519345662156, 5071.264666623393, 4794.232922732346, 4947.960928204973, 4987.426445958761, 5001.1498045331655, 5017.896062866163, 4783.4738178801, 4914.36113305268, 4929.827456039022, 5044.848654540369, 5069.797208111634, 4922.72924989129, 4939.0243902439315, 4958.603311734981, 4962.330085438564, 4971.477994810638], "value": 3810.776377328719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.5400873397358, 687.7764726463901, 744.6760659113282, 783.8902553642489, 803.7789607857836, 13166.934165329172, 13660.043796934218, 13941.512047078355, 13955.023148379592, 13979.091359061667, 13219.272939988297, 13399.799003014938, 13407.128536645136, 13410.73178536431, 13419.932900335485, 653.9019147127946, 669.176912397751, 800.7197480881674, 803.1125606205132, 815.2621877201112, 824.575343697996, 825.2531459029587, 826.0624191542612, 828.0270681948716, 829.4194064155085, 867.6442658510013, 870.3254977392509, 870.8258348330328, 871.5685735560875, 874.8993865705462, 697.1425147069133, 717.0212659719498, 719.6509692798988, 720.5244538604549, 872.7250915961483, 619.4672581579838, 628.7924984755066, 635.0727937211676, 635.0854769132435, 637.7895294552786, 12341.012718982549, 12426.0, 12472.376381180904, 12485.438155283035, 12499.687507812287, 12684.175528590613, 12749.617511474671, 12803.48786048557, 12986.740265194738, 13083.542076027388, 11833.704157396049, 11961.401929903557, 12048.45781939806, 12134.453949572291, 12144.0, 4059.1272876331436, 4060.4112403701592, 4110.547839737626, 4121.093359460914, 4173.7495750254775, 58754.706226469025, 59972.0, 60930.695346523426, 61156.388436115514, 61783.38216617821, 10313.896861031444, 10364.429956352322, 10510.684679459628, 10517.582615301439, 10693.465326733633, 20067.59864802725, 20072.69890951637, 20088.39734807958, 20129.899350503154, 20137.194512219347, 6347.143135676717, 6364.6316042051185, 6435.806925792233, 6554.639494827735, 6660.800175994728, 3385.306012267479, 3441.397755392796, 3490.877819276313, 3527.2416430467574, 3538.469229615578, 2693.097812232924, 2731.4810186064583, 2752.7109653486496, 2778.235985104072, 2779.277387879166, 463.5272022537061, 470.2710798262679, 471.6156332588929, 473.90521895621015, 475.36301356182884, 547.8657728856456, 553.1481518461604, 554.2102503931961, 556.3185098254605, 567.625367257608, 7591.354734847489, 7824.647890844925, 7853.646585903648, 7865.056193256846, 7927.0, 534.727289082563, 553.6567328256507, 554.1410813239463, 557.4676184244119, 572.7880684146892, 3585.4442561403025, 3612.1692010837655, 3634.3821550336506, 3689.723270754704, 3827.559830619459, 50665.74667126641, 51179.232311515356, 52271.47728522666, 57081.42918570844, 64949.67525162344, 47898.0, 53753.73123134359, 54480.72759636256, 54835.0, 56550.151747723816, 48249.75875120672, 48357.0, 49276.75361623169, 50319.74840125776, 51135.23297150546, 8910.955445222733, 9230.307726920373, 9400.435973841591, 9494.382865113745, 9506.28702847303, 33916.0, 34164.658353417144, 34310.0, 34504.0, 34539.0, 43050.42314347895, 43378.783106084265, 43405.0, 43778.562214377445, 44182.33726494041, 11208.27146235492, 11249.100071994057, 11375.26060806045, 11400.201985861242, 11814.586489472827, 12008.0, 12123.211991220542, 12276.693082673004, 12645.304508252135, 13172.407241673956, 11792.823107653221, 11836.46735896904, 12337.691557711129, 12521.248725076524, 12545.93727031359, 10653.520591573553, 11416.714582135513, 11645.045556103007, 11688.240264382788, 12143.453544590338, 11617.47721352558, 11659.591914282959, 12046.156769026084, 12096.637100886988, 12294.20087694297, 9033.457992520469, 9094.772630684285, 9216.907830921606, 9227.492487912961, 9465.526723663927, 8752.956235219039, 9003.54982250898, 9260.166585007382, 9321.067893210624, 9415.011423800403], "value": 6215.319634914849, "unit": "score"}], "name": "dromaeo_css", "value": 6299.630561122222, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 124.0, 175.0, 124.0, 128.0, 124.0, 130.0, 157.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 160.0, 160.0, 168.0, 160.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 106.0, 76.0, 75.0, 75.0, 75.0, 94.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 86.0, 85.0, 85.0, 97.0, 84.0, 84.0, 105.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 124.0, 117.0, 116.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 150.0, 151.0, 150.0, 149.0, 149.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 63.0, 62.0, 63.0, 65.0, 64.0, 62.0, 65.0, 61.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 85.0, 84.0, 86.0, 85.0, 85.0, 85.0, 93.0, 83.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 142.0, 136.0, 141.0, 131.0, 138.0, 135.0, 176.0, 132.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 177.0, 177.0, 178.0, 173.0, 173.0, 172.0, 172.0, 176.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 66.0, 66.0, 68.0, 69.0, 66.0, 67.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1544.7, "alertThreshold": 2.0}]} 03:27:27 INFO - Return code: 0 03:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:27 INFO - # TBPL SUCCESS # 03:27:27 INFO - Running post-action listener: _resource_record_post_action 03:27:27 INFO - [mozharness: 2017-01-13 11:27:27.243451Z] Finished run-tests step (success) 03:27:27 INFO - Running post-run listener: _resource_record_post_run 03:27:27 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403554304; Read time: 28; Write time: 528968 03:27:27 INFO - TinderboxPrint: CPU usage
13.1% 03:27:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 03:27:27 INFO - TinderboxPrint: I/O write bytes / time
403,554,304 / 528,968 03:27:27 INFO - TinderboxPrint: CPU idle
8,339.0 (86.9%) 03:27:27 INFO - TinderboxPrint: CPU user
1,207.2 (12.6%) 03:27:27 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 107569152; Read time: 0; Write time: 189452 03:27:27 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292352000; Read time: 0; Write time: 339340 03:27:27 INFO - Running post-run listener: _upload_blobber_files 03:27:27 INFO - Blob upload gear active. 03:27:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:27 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 03:27:27 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'] 03:27:27 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 03:27:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:29 INFO - (blobuploader) - INFO - Done attempting. 03:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:29 INFO - (blobuploader) - INFO - Done attempting. 03:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:33 INFO - (blobuploader) - INFO - Done attempting. 03:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:34 INFO - (blobuploader) - INFO - Done attempting. 03:27:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:34 INFO - Return code: 0 03:27:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/386fec0ecbc7dc3279cc1de0f9edb095e668ebbb87ddc0e9ff117eb0d65c9952f3d40e084afb85d1edb4ed0e7b197bac22fa1914da1fbcad85d255877198681f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea725c15e9d813d28bedc7517a416fdecc426476d65dcb408392a4a64054d0337970c058f73c23798b4ddcfcb682b71fb2d63ae61ceccaf186f964c899334615", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2301b62c60a51d0496479a242bd5807459a59b7ccc47a8cc69de197799e0169582e2fb80dd51f425888f6548aaf8fb12e7b4b2d3e05eb13bcd6e9adc54eacf18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7250a053f3734fc50da6e500bf3d244503e0c0efdaf1929a9a6ae7a6125b1fb4322a5753205267110d0fea5fd45a09438bb2a25b39d5dd9c116328132ea946a1"} 03:27:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:34 INFO - Contents: 03:27:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/386fec0ecbc7dc3279cc1de0f9edb095e668ebbb87ddc0e9ff117eb0d65c9952f3d40e084afb85d1edb4ed0e7b197bac22fa1914da1fbcad85d255877198681f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea725c15e9d813d28bedc7517a416fdecc426476d65dcb408392a4a64054d0337970c058f73c23798b4ddcfcb682b71fb2d63ae61ceccaf186f964c899334615", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2301b62c60a51d0496479a242bd5807459a59b7ccc47a8cc69de197799e0169582e2fb80dd51f425888f6548aaf8fb12e7b4b2d3e05eb13bcd6e9adc54eacf18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7250a053f3734fc50da6e500bf3d244503e0c0efdaf1929a9a6ae7a6125b1fb4322a5753205267110d0fea5fd45a09438bb2a25b39d5dd9c116328132ea946a1"} 03:27:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:34 INFO - Copying logs to upload dir... 03:27:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.678852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-13 03:27:33.877631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:27:33.880904) ========= 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=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/386fec0ecbc7dc3279cc1de0f9edb095e668ebbb87ddc0e9ff117eb0d65c9952f3d40e084afb85d1edb4ed0e7b197bac22fa1914da1fbcad85d255877198681f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea725c15e9d813d28bedc7517a416fdecc426476d65dcb408392a4a64054d0337970c058f73c23798b4ddcfcb682b71fb2d63ae61ceccaf186f964c899334615", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2301b62c60a51d0496479a242bd5807459a59b7ccc47a8cc69de197799e0169582e2fb80dd51f425888f6548aaf8fb12e7b4b2d3e05eb13bcd6e9adc54eacf18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7250a053f3734fc50da6e500bf3d244503e0c0efdaf1929a9a6ae7a6125b1fb4322a5753205267110d0fea5fd45a09438bb2a25b39d5dd9c116328132ea946a1"} build_url:https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011746 build_url: 'https://queue.taskcluster.net/v1/task/Ze6eHboWT_yTnWvLwg4oaQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/386fec0ecbc7dc3279cc1de0f9edb095e668ebbb87ddc0e9ff117eb0d65c9952f3d40e084afb85d1edb4ed0e7b197bac22fa1914da1fbcad85d255877198681f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea725c15e9d813d28bedc7517a416fdecc426476d65dcb408392a4a64054d0337970c058f73c23798b4ddcfcb682b71fb2d63ae61ceccaf186f964c899334615", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2301b62c60a51d0496479a242bd5807459a59b7ccc47a8cc69de197799e0169582e2fb80dd51f425888f6548aaf8fb12e7b4b2d3e05eb13bcd6e9adc54eacf18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7250a053f3734fc50da6e500bf3d244503e0c0efdaf1929a9a6ae7a6125b1fb4322a5753205267110d0fea5fd45a09438bb2a25b39d5dd9c116328132ea946a1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:27:33.905929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:27:33.906217) ========= 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=5cf47e208febbcd81da23b2e0000026f-1484305605.659413-961530603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:27:33.992155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:27:33.992443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:27:33.992740) ========= ========= Total master_lag: 0.17 =========