builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1484305080.09 results: success (0) revision: 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.090088) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.090562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.090851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.105746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.106091) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-13 02:58:00-- 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% 69.4M=0s 2017-01-13 02:58:00 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.219059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.219400) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.269119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.269461) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f --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 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f --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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-13 02:58:00,947 truncating revision to first 12 chars 2017-01-13 02:58:00,947 Setting DEBUG logging. 2017-01-13 02:58:00,947 attempt 1/10 2017-01-13 02:58:00,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/90ff62d4c2b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 02:58:01,276 unpacking tar archive at: graphics-90ff62d4c2b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.906781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.907107) ========= script_repo_revision: 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.907503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.907768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:58:00.915607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-13 02:58:00.915871) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:01 INFO - MultiFileLogger online at 20170113 02:58:01 in /builds/slave/test 02:58:01 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 02:58:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:01 INFO - {'append_to_log': False, 02:58:01 INFO - 'base_work_dir': '/builds/slave/test', 02:58:01 INFO - 'blob_upload_branch': 'Graphics', 02:58:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:01 INFO - 'branch': 'Graphics', 02:58:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:01 INFO - 'config_files': ('talos/linux_config.py',), 02:58:01 INFO - 'default_actions': ('clobber', 02:58:01 INFO - 'read-buildbot-config', 02:58:01 INFO - 'download-and-extract', 02:58:01 INFO - 'populate-webroot', 02:58:01 INFO - 'create-virtualenv', 02:58:01 INFO - 'install', 02:58:01 INFO - 'run-tests'), 02:58:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:01 INFO - 'download_minidump_stackwalk': True, 02:58:01 INFO - 'download_symbols': 'ondemand', 02:58:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:01 INFO - 'installer_path': 'installer.exe', 02:58:01 INFO - 'log_level': 'info', 02:58:01 INFO - 'log_name': 'talos', 02:58:01 INFO - 'log_to_console': True, 02:58:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:01 INFO - 'opt_config_files': (), 02:58:01 INFO - 'pip_index': False, 02:58:01 INFO - 'sps_profile': False, 02:58:01 INFO - 'sps_profile_interval': 0, 02:58:01 INFO - 'suite': 'dromaeojs', 02:58:01 INFO - 'system_bits': '32', 02:58:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:01 INFO - 'title': 'talos-linux64-ix-061', 02:58:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:01 INFO - 'use_talos_json': True, 02:58:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:01 INFO - 'work_dir': 'build'} 02:58:01 INFO - [mozharness: 2017-01-13 10:58:01.686617Z] Running clobber step. 02:58:01 INFO - Running pre-action listener: _resource_record_pre_action 02:58:01 INFO - Running main action method: clobber 02:58:01 INFO - rmtree: /builds/slave/test/build 02:58:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:02 INFO - Running post-action listener: _resource_record_post_action 02:58:02 INFO - [mozharness: 2017-01-13 10:58:02.149424Z] Finished clobber step (success) 02:58:02 INFO - [mozharness: 2017-01-13 10:58:02.149524Z] Running read-buildbot-config step. 02:58:02 INFO - Running pre-action listener: _resource_record_pre_action 02:58:02 INFO - Running main action method: read_buildbot_config 02:58:02 INFO - Using buildbot properties: 02:58:02 INFO - { 02:58:02 INFO - "project": "", 02:58:02 INFO - "product": "firefox", 02:58:02 INFO - "who": "ethlin@mozilla.com", 02:58:02 INFO - "installer_path": "public/build/target.tar.bz2", 02:58:02 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 02:58:02 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 02:58:02 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 02:58:02 INFO - "stage_platform": "linux64", 02:58:02 INFO - "basedir": "/builds/slave/test", 02:58:02 INFO - "buildnumber": 51, 02:58:02 INFO - "platform": "ubuntu64_hw", 02:58:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:58:02 INFO - "slavebuilddir": "test", 02:58:02 INFO - "taskId": "TC4JdjQsRAaYtXJ1wQnd3g", 02:58:02 INFO - "branch": "graphics", 02:58:02 INFO - "script_repo_revision": "default", 02:58:02 INFO - "revision": "90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f", 02:58:02 INFO - "slavename": "talos-linux64-ix-061", 02:58:02 INFO - "repo_path": "projects/graphics" 02:58:02 INFO - } 02:58:02 INFO - Finding installer, test and symbols from parent task. 02:58:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TC4JdjQsRAaYtXJ1wQnd3g'}, attempt #1 02:58:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TC4JdjQsRAaYtXJ1wQnd3g'}, attempt #1 02:58:03 INFO - Task dependencies: CJavl6s2Rpu0ABQRf_rIMA 02:58:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA'}, attempt #1 02:58:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 02:58:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/test_packages.json 02:58:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.crashreporter-symbols.zip 02:58:03 INFO - Running post-action listener: _resource_record_post_action 02:58:03 INFO - [mozharness: 2017-01-13 10:58:03.659082Z] Finished read-buildbot-config step (success) 02:58:03 INFO - [mozharness: 2017-01-13 10:58:03.659301Z] Running download-and-extract step. 02:58:03 INFO - Running pre-action listener: _resource_record_pre_action 02:58:03 INFO - Running main action method: download_and_extract 02:58:03 INFO - mkdir: /builds/slave/test/build/tests 02:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:03 INFO - trying https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.test_packages.json 02:58:03 INFO - Downloading https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:58:04 INFO - Downloaded 896 bytes. 02:58:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:58:04 INFO - Using the following test package requirements: 02:58:04 INFO - {u'common': [u'target.common.tests.zip'], 02:58:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:58:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:58:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:58:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:58:04 INFO - u'mozbase': [u'target.common.tests.zip'], 02:58:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:58:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:58:04 INFO - u'web-platform': [u'target.common.tests.zip', 02:58:04 INFO - u'target.web-platform.tests.zip'], 02:58:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:58:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:58:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip 02:58:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:58:04 INFO - Fetch https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip into memory 02:58:05 INFO - Expected file size: 20260791 02:58:05 INFO - Obtained file size: 20260791 02:58:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:58:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip 02:58:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:58:09 INFO - Fetch https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.common.tests.zip into memory 02:58:09 INFO - Expected file size: 20260791 02:58:09 INFO - Obtained file size: 20260791 02:58:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.talos.tests.zip 02:58:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:58:14 INFO - Fetch https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.talos.tests.zip into memory 02:58:14 INFO - Expected file size: 14403532 02:58:14 INFO - Obtained file size: 14403532 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - trying https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 02:58:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:58:16 INFO - Downloaded 56164226 bytes. 02:58:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 02:58:16 INFO - mkdir: /builds/slave/test/properties 02:58:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:58:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:58:16 INFO - Contents: 02:58:16 INFO - build_url:https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 02:58:16 INFO - Running post-action listener: _resource_record_post_action 02:58:16 INFO - Running post-action listener: set_extra_try_arguments 02:58:16 INFO - [mozharness: 2017-01-13 10:58:16.369788Z] Finished download-and-extract step (success) 02:58:16 INFO - [mozharness: 2017-01-13 10:58:16.369884Z] Running populate-webroot step. 02:58:16 INFO - Running pre-action listener: _resource_record_pre_action 02:58:16 INFO - Running main action method: populate_webroot 02:58:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:58:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:58:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:58:16 INFO - '--tppagecycles', 02:58:16 INFO - '7'], 02:58:16 INFO - 'tests': ['tsvgm']}}, 02:58:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:58:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:58:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:58:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:58:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['damp', 'tps']}, 02:58:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'tests': ['damp', 'tps']}, 02:58:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['dromaeo_dom']}, 02:58:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:58:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['basic_compositor_video']}, 02:58:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:58:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['a11yr', 02:58:16 INFO - 'ts_paint', 02:58:16 INFO - 'tpaint', 02:58:16 INFO - 'sessionrestore', 02:58:16 INFO - 'sessionrestore_no_auto_restore', 02:58:16 INFO - 'tabpaint']}, 02:58:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['tsvgx', 02:58:16 INFO - 'tsvgr_opacity', 02:58:16 INFO - 'tart', 02:58:16 INFO - 'tscrollx', 02:58:16 INFO - 'cart', 02:58:16 INFO - 'tsvg_static']}, 02:58:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:58:16 INFO - 'tsvgr_opacity', 02:58:16 INFO - 'tart', 02:58:16 INFO - 'tscrollx', 02:58:16 INFO - 'cart', 02:58:16 INFO - 'tsvg_static']}, 02:58:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'talos_options': ['--disable-e10s'], 02:58:16 INFO - 'tests': ['tp5o']}, 02:58:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:58:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'talos_options': ['--disable-e10s', 02:58:16 INFO - '--xperf_path', 02:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:16 INFO - 'tests': ['tp5n']}, 02:58:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:58:16 INFO - 'talos_options': ['--xperf_path', 02:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:16 INFO - 'tests': ['tp5n']}}, 02:58:16 INFO - 'talos.zip': {'path': '', 02:58:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:58:16 INFO - Running post-action listener: _resource_record_post_action 02:58:16 INFO - [mozharness: 2017-01-13 10:58:16.383037Z] Finished populate-webroot step (success) 02:58:16 INFO - [mozharness: 2017-01-13 10:58:16.383131Z] Running create-virtualenv step. 02:58:16 INFO - Running pre-action listener: _resource_record_pre_action 02:58:16 INFO - Running main action method: create_virtualenv 02:58:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:58:16 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 02:58:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:58:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:58:16 INFO - Using real prefix '/usr' 02:58:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:58:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:58:18 INFO - Installing pip.................done. 02:58:18 INFO - Return code: 0 02:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:58:19 INFO - Reading from file tmpfile_stdout 02:58:19 INFO - Output received: 02:58:19 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) 02:58:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:58:19 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')]} 02:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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')]} 02:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:19 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 02:58:19 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 02:58:19 INFO - Using env: {'DISPLAY': ':0', 02:58:19 INFO - 'HOME': '/home/cltbld', 02:58:19 INFO - 'LANG': 'en_US.UTF-8', 02:58:19 INFO - 'LANGUAGE': 'en_US:en', 02:58:19 INFO - 'LOGNAME': 'cltbld', 02:58:19 INFO - 'MAIL': '/var/mail/cltbld', 02:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:19 INFO - 'MOZ_NO_REMOTE': '1', 02:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:19 INFO - 'NO_EM_RESTART': '1', 02:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:19 INFO - 'PWD': '/builds/slave/test', 02:58:19 INFO - 'SHELL': '/bin/bash', 02:58:19 INFO - 'SHLVL': '1', 02:58:19 INFO - 'TERM': 'linux', 02:58:19 INFO - 'TMOUT': '86400', 02:58:19 INFO - 'USER': 'cltbld', 02:58:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:19 INFO - '_': '/tools/buildbot/bin/python'} 02:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:19 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 02:58:19 INFO - Cleaning up... 02:58:19 INFO - Return code: 0 02:58:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:58:19 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')]} 02:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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')]} 02:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:19 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 02:58:19 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 02:58:19 INFO - Using env: {'DISPLAY': ':0', 02:58:19 INFO - 'HOME': '/home/cltbld', 02:58:19 INFO - 'LANG': 'en_US.UTF-8', 02:58:19 INFO - 'LANGUAGE': 'en_US:en', 02:58:19 INFO - 'LOGNAME': 'cltbld', 02:58:19 INFO - 'MAIL': '/var/mail/cltbld', 02:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:19 INFO - 'MOZ_NO_REMOTE': '1', 02:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:19 INFO - 'NO_EM_RESTART': '1', 02:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:19 INFO - 'PWD': '/builds/slave/test', 02:58:19 INFO - 'SHELL': '/bin/bash', 02:58:19 INFO - 'SHLVL': '1', 02:58:19 INFO - 'TERM': 'linux', 02:58:19 INFO - 'TMOUT': '86400', 02:58:19 INFO - 'USER': 'cltbld', 02:58:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:19 INFO - '_': '/tools/buildbot/bin/python'} 02:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:19 INFO - Downloading/unpacking psutil>=3.1.1 02:58:19 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 02:58:19 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 02:58:19 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 02:58:19 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 02:58:19 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 02:58:19 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 02:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:21 INFO - Installing collected packages: psutil 02:58:21 INFO - Running setup.py install for psutil 02:58:21 INFO - building 'psutil._psutil_linux' extension 02:58:21 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 02:58:21 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 02:58:22 INFO - building 'psutil._psutil_posix' extension 02:58:22 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 02:58:22 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 02:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:22 INFO - Successfully installed psutil 02:58:22 INFO - Cleaning up... 02:58:22 INFO - Return code: 0 02:58:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:22 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:22 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 02:58:22 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 02:58:22 INFO - Using env: {'DISPLAY': ':0', 02:58:22 INFO - 'HOME': '/home/cltbld', 02:58:22 INFO - 'LANG': 'en_US.UTF-8', 02:58:22 INFO - 'LANGUAGE': 'en_US:en', 02:58:22 INFO - 'LOGNAME': 'cltbld', 02:58:22 INFO - 'MAIL': '/var/mail/cltbld', 02:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:22 INFO - 'MOZ_NO_REMOTE': '1', 02:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:22 INFO - 'NO_EM_RESTART': '1', 02:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:22 INFO - 'PWD': '/builds/slave/test', 02:58:22 INFO - 'SHELL': '/bin/bash', 02:58:22 INFO - 'SHLVL': '1', 02:58:22 INFO - 'TERM': 'linux', 02:58:22 INFO - 'TMOUT': '86400', 02:58:22 INFO - 'USER': 'cltbld', 02:58:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:22 INFO - '_': '/tools/buildbot/bin/python'} 02:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:24 INFO - Installing collected packages: mozsystemmonitor 02:58:24 INFO - Running setup.py install for mozsystemmonitor 02:58:24 INFO - Successfully installed mozsystemmonitor 02:58:24 INFO - Cleaning up... 02:58:24 INFO - Return code: 0 02:58:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58: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==2.5.1'] in /builds/slave/test/build 02:58: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==2.5.1 02:58:24 INFO - Using env: {'DISPLAY': ':0', 02:58:24 INFO - 'HOME': '/home/cltbld', 02:58:24 INFO - 'LANG': 'en_US.UTF-8', 02:58:24 INFO - 'LANGUAGE': 'en_US:en', 02:58:24 INFO - 'LOGNAME': 'cltbld', 02:58:24 INFO - 'MAIL': '/var/mail/cltbld', 02:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:24 INFO - 'MOZ_NO_REMOTE': '1', 02:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:24 INFO - 'NO_EM_RESTART': '1', 02:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:24 INFO - 'PWD': '/builds/slave/test', 02:58:24 INFO - 'SHELL': '/bin/bash', 02:58:24 INFO - 'SHLVL': '1', 02:58:24 INFO - 'TERM': 'linux', 02:58:24 INFO - 'TMOUT': '86400', 02:58:24 INFO - 'USER': 'cltbld', 02:58:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:24 INFO - '_': '/tools/buildbot/bin/python'} 02:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:58:24 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 02:58:24 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 02:58:24 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 02:58:24 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 02:58:24 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 02:58:24 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 02:58:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:58:26 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 02:58:26 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 02:58:26 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 02:58:26 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 02:58:26 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 02:58:26 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 02:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:27 INFO - warning: no files found matching '*.txt' 02:58:27 INFO - no previously-included directories found matching 'build' 02:58:27 INFO - no previously-included directories found matching 'dist' 02:58:27 INFO - no previously-included directories found matching '.git*' 02:58:27 INFO - Installing collected packages: jsonschema, functools32 02:58:27 INFO - Running setup.py install for functools32 02:58:27 INFO - warning: no files found matching '*.txt' 02:58:27 INFO - no previously-included directories found matching 'build' 02:58:27 INFO - no previously-included directories found matching 'dist' 02:58:27 INFO - no previously-included directories found matching '.git*' 02:58:27 INFO - Successfully installed jsonschema functools32 02:58:27 INFO - Cleaning up... 02:58:27 INFO - Return code: 0 02:58:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:58:27 INFO - Using env: {'DISPLAY': ':0', 02:58:27 INFO - 'HOME': '/home/cltbld', 02:58:27 INFO - 'LANG': 'en_US.UTF-8', 02:58:27 INFO - 'LANGUAGE': 'en_US:en', 02:58:27 INFO - 'LOGNAME': 'cltbld', 02:58:27 INFO - 'MAIL': '/var/mail/cltbld', 02:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:27 INFO - 'MOZ_NO_REMOTE': '1', 02:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:27 INFO - 'NO_EM_RESTART': '1', 02:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:27 INFO - 'PWD': '/builds/slave/test', 02:58:27 INFO - 'SHELL': '/bin/bash', 02:58:27 INFO - 'SHLVL': '1', 02:58:27 INFO - 'TERM': 'linux', 02:58:27 INFO - 'TMOUT': '86400', 02:58:27 INFO - 'USER': 'cltbld', 02:58:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:27 INFO - '_': '/tools/buildbot/bin/python'} 02:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:58:27 INFO - Cleaning up... 02:58:27 INFO - Return code: 0 02:58:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:27 INFO - Using env: {'DISPLAY': ':0', 02:58:27 INFO - 'HOME': '/home/cltbld', 02:58:27 INFO - 'LANG': 'en_US.UTF-8', 02:58:27 INFO - 'LANGUAGE': 'en_US:en', 02:58:27 INFO - 'LOGNAME': 'cltbld', 02:58:27 INFO - 'MAIL': '/var/mail/cltbld', 02:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:27 INFO - 'MOZ_NO_REMOTE': '1', 02:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:27 INFO - 'NO_EM_RESTART': '1', 02:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:27 INFO - 'PWD': '/builds/slave/test', 02:58:27 INFO - 'SHELL': '/bin/bash', 02:58:27 INFO - 'SHLVL': '1', 02:58:27 INFO - 'TERM': 'linux', 02:58:27 INFO - 'TMOUT': '86400', 02:58:27 INFO - 'USER': 'cltbld', 02:58:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:27 INFO - '_': '/tools/buildbot/bin/python'} 02:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:27 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:29 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 02:58:29 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 02:58:29 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 02:58:29 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 02:58:29 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 02:58:29 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 02:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:30 INFO - Downloading docopt-0.6.1.tar.gz 02:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:30 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:30 INFO - Running setup.py install for blobuploader 02:58:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:30 INFO - Running setup.py install for requests 02:58:31 INFO - Running setup.py install for docopt 02:58:31 INFO - Successfully installed blobuploader requests docopt 02:58:31 INFO - Cleaning up... 02:58:31 INFO - Return code: 0 02:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:31 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')]} 02:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:31 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')]} 02:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:31 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:31 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 02:58:31 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 02:58:31 INFO - Using env: {'DISPLAY': ':0', 02:58:31 INFO - 'HOME': '/home/cltbld', 02:58:31 INFO - 'LANG': 'en_US.UTF-8', 02:58:31 INFO - 'LANGUAGE': 'en_US:en', 02:58:31 INFO - 'LOGNAME': 'cltbld', 02:58:31 INFO - 'MAIL': '/var/mail/cltbld', 02:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:31 INFO - 'MOZ_NO_REMOTE': '1', 02:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:31 INFO - 'NO_EM_RESTART': '1', 02:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:31 INFO - 'PWD': '/builds/slave/test', 02:58:31 INFO - 'SHELL': '/bin/bash', 02:58:31 INFO - 'SHLVL': '1', 02:58:31 INFO - 'TERM': 'linux', 02:58:31 INFO - 'TMOUT': '86400', 02:58:31 INFO - 'USER': 'cltbld', 02:58:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:31 INFO - '_': '/tools/buildbot/bin/python'} 02:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:31 INFO - Running setup.py (path:/tmp/pip-3_bTO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:31 INFO - Running setup.py (path:/tmp/pip-lxLg4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:31 INFO - Running setup.py (path:/tmp/pip-OuradG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:31 INFO - Running setup.py (path:/tmp/pip-3Fth9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:31 INFO - Running setup.py (path:/tmp/pip-Oh1x3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:31 INFO - Running setup.py (path:/tmp/pip-VRV7KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:31 INFO - Running setup.py (path:/tmp/pip-AsTWWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:32 INFO - Running setup.py (path:/tmp/pip-iiabAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:32 INFO - Running setup.py (path:/tmp/pip-F74pt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:32 INFO - Running setup.py (path:/tmp/pip-NLF04v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:32 INFO - Running setup.py (path:/tmp/pip-AJV_oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:32 INFO - Running setup.py (path:/tmp/pip-42h5UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:32 INFO - Running setup.py (path:/tmp/pip-O4FtZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:32 INFO - Running setup.py (path:/tmp/pip-z7QRhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:32 INFO - Running setup.py (path:/tmp/pip-OOube6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:32 INFO - Running setup.py (path:/tmp/pip-9ibO01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:32 INFO - Running setup.py (path:/tmp/pip-2qlCk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:32 INFO - Running setup.py install for manifestparser 02:58:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:32 INFO - Running setup.py install for mozcrash 02:58:32 INFO - Running setup.py install for mozdebug 02:58:33 INFO - Running setup.py install for mozdevice 02:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for mozfile 02:58:33 INFO - Running setup.py install for mozhttpd 02:58:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for mozinfo 02:58:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for mozInstall 02:58:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for mozleak 02:58:33 INFO - Running setup.py install for mozlog 02:58:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for moznetwork 02:58:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:33 INFO - Running setup.py install for mozprocess 02:58:34 INFO - Running setup.py install for mozprofile 02:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:34 INFO - Running setup.py install for mozrunner 02:58:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:34 INFO - Running setup.py install for mozscreenshot 02:58:34 INFO - Running setup.py install for moztest 02:58:34 INFO - Running setup.py install for mozversion 02:58:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:34 INFO - Cleaning up... 02:58:34 INFO - Return code: 0 02:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:34 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')]} 02:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:34 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')]} 02:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:34 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:34 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 02:58:34 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 02:58:34 INFO - Using env: {'DISPLAY': ':0', 02:58:34 INFO - 'HOME': '/home/cltbld', 02:58:34 INFO - 'LANG': 'en_US.UTF-8', 02:58:34 INFO - 'LANGUAGE': 'en_US:en', 02:58:34 INFO - 'LOGNAME': 'cltbld', 02:58:34 INFO - 'MAIL': '/var/mail/cltbld', 02:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:34 INFO - 'MOZ_NO_REMOTE': '1', 02:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:34 INFO - 'NO_EM_RESTART': '1', 02:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:34 INFO - 'PWD': '/builds/slave/test', 02:58:34 INFO - 'SHELL': '/bin/bash', 02:58:34 INFO - 'SHLVL': '1', 02:58:34 INFO - 'TERM': 'linux', 02:58:34 INFO - 'TMOUT': '86400', 02:58:34 INFO - 'USER': 'cltbld', 02:58:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:34 INFO - '_': '/tools/buildbot/bin/python'} 02:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:34 INFO - Running setup.py (path:/tmp/pip-dm7nSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:34 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)) 02:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:34 INFO - Running setup.py (path:/tmp/pip-91t2E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:34 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)) 02:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:34 INFO - Running setup.py (path:/tmp/pip-3LNURs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:35 INFO - Running setup.py (path:/tmp/pip-WBh0Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:35 INFO - Running setup.py (path:/tmp/pip-uc3_ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:35 INFO - Running setup.py (path:/tmp/pip-2EaFHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:35 INFO - Running setup.py (path:/tmp/pip-zurZoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:35 INFO - Running setup.py (path:/tmp/pip-rtwHE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:35 INFO - Running setup.py (path:/tmp/pip-r0PF7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:35 INFO - Running setup.py (path:/tmp/pip-RBN_7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:35 INFO - Running setup.py (path:/tmp/pip-VcRAmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:35 INFO - Running setup.py (path:/tmp/pip-LXtPf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:35 INFO - Running setup.py (path:/tmp/pip-nFCSyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:35 INFO - Running setup.py (path:/tmp/pip-lwmN_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:35 INFO - Running setup.py (path:/tmp/pip-d9wC7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:35 INFO - Running setup.py (path:/tmp/pip-Ed_uUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:35 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)) 02:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:35 INFO - Running setup.py (path:/tmp/pip-9imt4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:36 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)) 02:58:36 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)) 02:58:36 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)) 02:58:36 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)) 02:58:36 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)) 02:58:36 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)) 02:58:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:38 INFO - Downloading blessings-1.6.tar.gz 02:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:38 INFO - Installing collected packages: blessings 02:58:38 INFO - Running setup.py install for blessings 02:58:38 INFO - Successfully installed blessings 02:58:38 INFO - Cleaning up... 02:58:38 INFO - Return code: 0 02:58:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:38 INFO - Reading from file tmpfile_stdout 02:58:38 INFO - Current package versions: 02:58:38 INFO - argparse == 1.2.1 02:58:38 INFO - blessings == 1.6 02:58:38 INFO - blobuploader == 1.2.4 02:58:38 INFO - docopt == 0.6.1 02:58:38 INFO - functools32 == 3.2.3-2 02:58:38 INFO - jsonschema == 2.5.1 02:58:38 INFO - manifestparser == 1.1 02:58:38 INFO - mozInstall == 1.12 02:58:38 INFO - mozcrash == 1.0 02:58:38 INFO - mozdebug == 0.1 02:58:38 INFO - mozdevice == 0.49 02:58:38 INFO - mozfile == 1.2 02:58:38 INFO - mozhttpd == 0.7 02:58:38 INFO - mozinfo == 0.9 02:58:38 INFO - mozleak == 0.1 02:58:38 INFO - mozlog == 3.4 02:58:38 INFO - moznetwork == 0.27 02:58:38 INFO - mozprocess == 0.24 02:58:38 INFO - mozprofile == 0.28 02:58:38 INFO - mozrunner == 6.13 02:58:38 INFO - mozscreenshot == 0.1 02:58:38 INFO - mozsystemmonitor == 0.3 02:58:38 INFO - moztest == 0.8 02:58:38 INFO - mozversion == 1.4 02:58:38 INFO - psutil == 3.1.1 02:58:38 INFO - requests == 1.2.3 02:58:38 INFO - wsgiref == 0.1.2 02:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:38 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 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:38 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 02:58:38 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 02:58:38 INFO - Using env: {'DISPLAY': ':0', 02:58:38 INFO - 'HOME': '/home/cltbld', 02:58:38 INFO - 'LANG': 'en_US.UTF-8', 02:58:38 INFO - 'LANGUAGE': 'en_US:en', 02:58:38 INFO - 'LOGNAME': 'cltbld', 02:58:38 INFO - 'MAIL': '/var/mail/cltbld', 02:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:38 INFO - 'MOZ_NO_REMOTE': '1', 02:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:38 INFO - 'NO_EM_RESTART': '1', 02:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:38 INFO - 'PWD': '/builds/slave/test', 02:58:38 INFO - 'SHELL': '/bin/bash', 02:58:38 INFO - 'SHLVL': '1', 02:58:38 INFO - 'TERM': 'linux', 02:58:38 INFO - 'TMOUT': '86400', 02:58:38 INFO - 'USER': 'cltbld', 02:58:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:38 INFO - '_': '/tools/buildbot/bin/python'} 02:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 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)) 02:58:38 INFO - Cleaning up... 02:58:38 INFO - Return code: 0 02:58:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', '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 02:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:58:38 INFO - Using env: {'DISPLAY': ':0', 02:58:38 INFO - 'HOME': '/home/cltbld', 02:58:38 INFO - 'LANG': 'en_US.UTF-8', 02:58:38 INFO - 'LANGUAGE': 'en_US:en', 02:58:38 INFO - 'LOGNAME': 'cltbld', 02:58:38 INFO - 'MAIL': '/var/mail/cltbld', 02:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:38 INFO - 'MOZ_NO_REMOTE': '1', 02:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:38 INFO - 'NO_EM_RESTART': '1', 02:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:38 INFO - 'PWD': '/builds/slave/test', 02:58:38 INFO - 'SHELL': '/bin/bash', 02:58:38 INFO - 'SHLVL': '1', 02:58:38 INFO - 'TERM': 'linux', 02:58:38 INFO - 'TMOUT': '86400', 02:58:38 INFO - 'USER': 'cltbld', 02:58:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:38 INFO - '_': '/tools/buildbot/bin/python'} 02:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:39 INFO - Cleaning up... 02:58:39 INFO - Return code: 0 02:58:39 INFO - Running post-action listener: _resource_record_post_action 02:58:39 INFO - Running post-action listener: _start_resource_monitoring 02:58:39 INFO - Starting resource monitoring. 02:58:39 INFO - [mozharness: 2017-01-13 10:58:39.203947Z] Finished create-virtualenv step (success) 02:58:39 INFO - [mozharness: 2017-01-13 10:58:39.204400Z] Running install step. 02:58:39 INFO - Running pre-action listener: _resource_record_pre_action 02:58:39 INFO - Running main action method: install 02:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:39 INFO - Reading from file tmpfile_stdout 02:58:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:39 INFO - Reading from file tmpfile_stdout 02:58:39 INFO - Output received: 02:58:39 INFO - Usage: mozinstall [options] installer 02:58:39 INFO - Options: 02:58:39 INFO - -h, --help show this help message and exit 02:58:39 INFO - -d DEST, --destination=DEST 02:58:39 INFO - Directory to install application into. [default: 02:58:39 INFO - "/builds/slave/test"] 02:58:39 INFO - --app=APP Application being installed. [default: firefox] 02:58:39 INFO - mkdir: /builds/slave/test/build/application 02:58:39 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'] 02:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:58:55 INFO - Reading from file tmpfile_stdout 02:58:55 INFO - Output received: 02:58:55 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:55 INFO - Running post-action listener: _resource_record_post_action 02:58:55 INFO - [mozharness: 2017-01-13 10:58:55.777326Z] Finished install step (success) 02:58:55 INFO - [mozharness: 2017-01-13 10:58:55.777602Z] Running run-tests step. 02:58:55 INFO - Running pre-action listener: _resource_record_pre_action 02:58:55 INFO - Running main action method: run_tests 02:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:55 INFO - Python 2.7.3 02:58:55 INFO - Return code: 0 02:58:55 INFO - grabbing minidump binary from tooltool 02:58:55 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')]} 02:58:55 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 0x1e333f0>, '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 0x1e33cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e341a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:55 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 02:58:55 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 02:58:55 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 02:58:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:55 INFO - Return code: 0 02:58:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:55 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/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:58:55 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/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 02:58:55 INFO - Using env: {'DISPLAY': ':0', 02:58:55 INFO - 'HOME': '/home/cltbld', 02:58:55 INFO - 'LANG': 'en_US.UTF-8', 02:58:55 INFO - 'LANGUAGE': 'en_US:en', 02:58:55 INFO - 'LOGNAME': 'cltbld', 02:58:55 INFO - 'MAIL': '/var/mail/cltbld', 02:58:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:55 INFO - 'MOZ_NO_REMOTE': '1', 02:58:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:55 INFO - 'NO_EM_RESTART': '1', 02:58:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:55 INFO - 'PWD': '/builds/slave/test', 02:58:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:55 INFO - 'SHELL': '/bin/bash', 02:58:55 INFO - 'SHLVL': '1', 02:58:55 INFO - 'TERM': 'linux', 02:58:55 INFO - 'TMOUT': '86400', 02:58:55 INFO - 'USER': 'cltbld', 02:58:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402', 02:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:55 INFO - '_': '/tools/buildbot/bin/python'} 02:58:55 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/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:58:56 INFO - mozversion application_buildid: 20170113100949 02:58:56 INFO - mozversion application_changeset: 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f 02:58:56 INFO - mozversion application_display_name: Nightly 02:58:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:56 INFO - mozversion application_name: Firefox 02:58:56 INFO - mozversion application_remotingname: firefox 02:58:56 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 02:58:56 INFO - mozversion application_vendor: Mozilla 02:58:56 INFO - mozversion application_version: 53.0a1 02:58:56 INFO - mozversion platform_buildid: 20170113100949 02:58:56 INFO - mozversion platform_changeset: 90ff62d4c2b9f0b0acfc7b4eccdf91442c887c2f 02:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 02:58:56 INFO - mozversion platform_version: 53.0a1 02:58:56 INFO - using testdate: 1484305136 02:58:56 INFO - actual date: 1484305136 02:58:56 INFO - starting webserver on 'localhost:37461' 02:58:56 INFO - SUITE-START | Running 2 tests 02:58:56 INFO - TEST-START | dromaeo_css 02:58:56 INFO - operating with platform_type : linux_ 02:58:56 INFO - Initialising browser for dromaeo_css test... 02:58:56 INFO - TEST-INFO | started process 12585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmhngOX/profile http://localhost:37461/getInfo.html) 02:59:00 INFO - PROCESS | 12585 | __metrics Screen width/height:1600/1200 02:59:00 INFO - PROCESS | 12585 | colorDepth:24 02:59:00 INFO - PROCESS | 12585 | Browser inner width/height: 1024/697 02:59:00 INFO - PROCESS | 12585 | __metrics 02:59:01 INFO - PROCESS | 12585 | 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" 02:59:01 INFO - PROCESS | 12585 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:01 INFO - PROCESS | 12585 | console.error: PushService: 02:59:01 INFO - PROCESS | 12585 | stateChangeProcessEnqueue: Error transitioning state 02:59:01 INFO - PROCESS | 12585 | UnknownError 02:59:02 INFO - TEST-INFO | 12585: exit 0 02:59:02 INFO - Browser initialized. 02:59:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:02 INFO - TEST-INFO | started process 12668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmhngOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:14 INFO - PROCESS | 12668 | RSS: Main: 152141824 02:59:14 INFO - PROCESS | 12668 | 03:02:18 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37461/tests/dromaeo/cssquery-ext.html) 03:02:20 INFO - PROCESS | 12668 | RSS: Main: 314720256 03:02:20 INFO - PROCESS | 12668 | 03:04:03 INFO - PROCESS | 12668 | ************************* 03:04:03 INFO - PROCESS | 12668 | A coding exception was thrown and uncaught in a Task. 03:04:03 INFO - PROCESS | 12668 | 03:04:03 INFO - PROCESS | 12668 | Full message: ReferenceError: fetch is not defined 03:04:03 INFO - PROCESS | 12668 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 03:04:03 INFO - PROCESS | 12668 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 03:04:03 INFO - PROCESS | 12668 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 03:04:03 INFO - PROCESS | 12668 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 03:04:03 INFO - PROCESS | 12668 | TaskImpl@resource://gre/modules/Task.jsm:277:3 03:04:03 INFO - PROCESS | 12668 | asyncFunction@resource://gre/modules/Task.jsm:252:14 03:04:03 INFO - PROCESS | 12668 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 03:04:03 INFO - PROCESS | 12668 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 03:04:03 INFO - PROCESS | 12668 | TaskImpl@resource://gre/modules/Task.jsm:277:3 03:04:03 INFO - PROCESS | 12668 | asyncFunction@resource://gre/modules/Task.jsm:252:14 03:04:03 INFO - PROCESS | 12668 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 03:04:03 INFO - PROCESS | 12668 | 03:04:03 INFO - PROCESS | 12668 | ************************* 03:05:22 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-ext.html (next: http://localhost:37461/tests/dromaeo/cssquery-jquery.html) 03:05:23 INFO - PROCESS | 12668 | RSS: Main: 233840640 03:05:23 INFO - PROCESS | 12668 | 03:08:25 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37461/tests/dromaeo/cssquery-mootools.html) 03:08:26 INFO - PROCESS | 12668 | RSS: Main: 185372672 03:08:26 INFO - PROCESS | 12668 | 03:11:28 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37461/tests/dromaeo/cssquery-prototype.html) 03:11:29 INFO - PROCESS | 12668 | RSS: Main: 222076928 03:11:29 INFO - PROCESS | 12668 | 03:14:32 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37461/tests/dromaeo/cssquery-yui.html) 03:14:33 INFO - PROCESS | 12668 | RSS: Main: 188588032 03:14:33 INFO - PROCESS | 12668 | 03:17:35 INFO - PROCESS | 12668 | Cycle 1(1): loaded http://localhost:37461/tests/dromaeo/cssquery-yui.html (next: http://localhost:37461/tests/dromaeo/cssquery-dojo.html) 03:17:36 INFO - PROCESS | 12668 | RSS: Main: 235130880 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | __start_tp_report 03:17:36 INFO - PROCESS | 12668 | _x_x_mozilla_page_load 03:17:36 INFO - PROCESS | 12668 | _x_x_mozilla_page_load_details 03:17:36 INFO - PROCESS | 12668 | |i|pagename|runs| 03:17:36 INFO - PROCESS | 12668 | |0;dojo.html;2538.923832285032;2550.2604244769013;2562.244137979296;2569.832960857544;2571.125817222144;4608.446986361637;4655.860324190276;4663.347131401598;4717.622590192785;4729.172394830899;4730.834420795273;4765.857024289268;4788.521147885219;4823.78292976816;4866.391701037371;4297.93553096703;4310.267254566731;4346.8913277168;4394.890127746816;4402.493713222988;4142.523609784868;4406.493253275882;4450.132224216279;4455.710378825383;4486.8878278042985;4260.573942605745;4371.628411585019;4391.670624703144;4395.824167033315;4491.056878055612;4314.417553630251;4317.589828966243;4349.869503914888;4372.147431250907;4449.3548435477;4352.412424322708;4368.584984426474;4372.737635741865;4402.537733537964;4412.602865742067;4754.453237877654;4759.738214398207;4762.476127625959;4766.952330476685;4773.284007398884;4959.95840873417;4992.87517812054;5066.06277838601;5088.7964481420695;5107.770150343244;5148.485151484859;5191.091558977201;5195.428502864682;5222.686638801684;5241.947580524184;4834.226523756182;4840.854774356775;4842.709437433765;4849.539293767087;4884.706917584886;5034.446210916796;5069.290299358093;5279.472052794767;5293;5296.311479507716;4949.208126699711;4982.327385802942;5003.274525193827;5010.398752149766;5069.518395752398;4932.7286999215385;4948.134076536592;5099.444669375802;5104.69371837691;5113.181890897513;4973.477784832613;5007.849764506997;5045.369328833895;5065.214891691794;5110.361204849394;5063.063333283354;5102.132637451642;5106.693598384109;5112.539871411591;5150.922736158961;4301.612854843079;4315.6763242756915;4328.458942632171;4355.891102722394;4418.403515525363;3781.0169355967646;3784.4512545680723;3810.2189051244427;3812.6568608825337;3828.272628200633;4419.535948725402;4434.800433980478;4437.866863994085;4442.333649952533;4475.686701930834;5054.267131265946;5066.442691303953;5096.770645320969;5107.8723031923755;5204.323437953042;4399.670024748157;4419.11617676466;4432.4237849080055;4457.9331310030375;4460.821567137278;4584.404027476407;4590.885227869263;4596.35651008859;4596.770161491912;4627;4652.651051171108;4688.859334219979;4703.412073490814;4794.856154315376;4798.3042458843975;5012.298278240976;5049.394072711299;5067.239914012927;5120.641555091257;5166.689998600096;4771.427428708577;4773;4777.522247775195;4777.593904518155;4822.204336284473;4962.6774259673;5014.122528557415;5020.648554601289;5023.02051100032;5068.949310506848;5047.091523525801;5094.7962081516325;5137.434882163034;5143.819966301311;5146.588272938231;5000.924986125284;5006.899862002667;5008.273800299009;5010.323606313101;5011.022850544255;4886.584640305614;4923.261510773269;4935.8025678972435;4987.10232158215;5004.324416203912;4836.177849765619;4905.558499735041;4912.214045752662;4939.629527785502;4974.5771609413605;4911.26331050331;4950.084234416644;4952.826651067196;4953.2570114483115;4996.150654388835;4748.026654535743;4794.232922732346;4820.9517904820505;4841.2496063110275;4927.457979622311 03:17:36 INFO - PROCESS | 12668 | |1;ext.html;526.6024151765417;541.7670401727256;544.7875328621836;584.6755050946723;604.2748701558131;28826.855865720667;37157.442638360444;38869.416958745605;38916.22167556647;43829.56170438295;40131.398029029515;40373;40449;40948.59051409485;41073.58926410735;7288.635568221594;7570.129435114977;7746.806329841743;7751.651175697107;7753.302202801747;7295.088113985752;9702.951485242564;9989.250806189528;9990.400575965428;10294.43380614066;10030;10096.646617368393;10122.089011988919;10137;10141.44222067786;9973.05256000686;9978.251631127658;10027.298089133763;10034.799304013879;10045.698629041104;9863.556139973647;9931.354461959949;9935.205183585296;9942.850857237147;9947.20422366209;37240;37430;37535.30808648919;37553;37608.435873461916;3581.4806853006166;3717.237966216946;3717.70258379329;3757.6618104370737;3782.924341513182;28429;28459.715402845915;28680.713192868014;29372.8531357344;29467.11598652044;3229.321842413096;3233.369492948876;3256.6580509046685;3391.8812841550425;3401.4557670772806;226413;227564;230530;230572;231570;51720.741396292775;51891.740541297055;51956;52005;52021.47978520242;54880.72559637176;54942.72528637411;55012.72493637506;55035.44964550303;55041.44958550363;12618.24290542552;12902.35488225585;12911.612651620466;12921.353932303347;12935.417906194243;8610.741677749678;8872.8669069964;9080.772980675536;9181.632734690671;9370.95314523423;14869.256537173098;15408.22958852053;15513.689726205639;15542.145182015098;15546.9222653886;5724.542036637059;5806.274215723035;5826.271716035496;5970.671613061237;5986.551008674367;814.608987685914;827.3463963468912;834.4742812028384;845.3870943565865;854.9016863060704;26568.202953911412;27766.167014989584;27875.581866272023;27877.86061069682;28299.71700283012;951.3150531617224;952.79991201847;957.2533423929347;985.0838719990335;992.692265397729;14016.789748153786;14854.70290594182;15000.474983375529;15007.060913477464;15157.848421515644;325362;327401;327554;327645;327757;48549.757251213516;48887.755561221966;48982;49004.7549762256;49053.509464905605;1177.8527684039495;1194.2237545595433;1208.812634041725;1210.3343161261448;1245.9813102803466;25022.874885625457;25754.87122564375;26622.600660990487;27002.864985674947;27082.593761093995;40198.79900600478;53297.20054199112;54395.45604543904;54498.727506362215;54965.72517137389;255678;320338;320946;321183;323372;39884;39894.60105398909;39921.203545839926;39935;40763;42837.78581107199;42982;43031.7848410756;43100.78449607732;43102.35346469743;36505.63494365022;36864.63135368719;37627.62372376351;37876.43185352277;38706.22587548177;37452.625473746004;37520.62479375171;37776;38519.22961540698;43164.568354316056;36456.453153203256;36926.815365923;37365;37873;37914.43128353132;31699.207519811265;34041.276697863614;34482.65517344794;34764.47853282253;34877.65122348744;25869.435016969004;26250.212493625222;26255.73744262533;26614.201573952814;26748.465030698888 03:17:36 INFO - PROCESS | 12668 | |2;jquery.html;372.98881033569;383.84454296010125;391.9339396840594;394.84995701633386;416.41493701349617;12557.998096975758;14365.928170359146;14970.700585988287;18134.82123661961;18173.45479635613;15302.464413745522;15324.540263792076;15649.530514084567;15731.134787586678;15780.132092734895;5163.7676304566385;5347.973260133694;5359.892802143955;5389.8113566025195;5401.162819762943;3964.385520244367;4162.666986641061;5353.170258609922;5357;6382.4255816976465;6450.6774661266745;6473.122794389621;6473.223213214421;6476.708548115346;6489.675516224193;6149.969250153743;6257.530685198628;6278.937210627881;6292.779752708633;6345;5346.732663366816;5539.113741801292;5569.916451253234;5571.8885622287735;5582.162675598693;19650.80349196504;20409.183632654676;21679.566408671737;21985.23051693199;22011.11955521777;2384.332386931662;2430.442919525889;2441.4994926040117;2467.90128394864;2470.22188010776;9110.362274640778;9202.447853128766;9428.387154834982;9674.75813104678;9770.804583908282;1790.3107303688043;1806.8825526340745;1807.430659342303;1822.599028213791;1839.997201525172;59082.70458647722;69550.65224673845;69895.65052174758;74544.25455745427;79992;9771.804563908681;9927.602895884083;9972.750681232883;10126.848097278547;10201.489925503694;13557.661058473617;13581.320933953262;13599.728005440034;13620.799112208622;13666.658333541742;6656.633885136364;6803.319668033157;6848.280930502226;6937.236903940562;6960.965195173992;6252.937470625327;6269.937300627026;6405.19935008124;6407.455366293824;6442.871142577123;4221.282381995068;4300.333448315516;4320.891977700519;4368.5194628590825;4384.12317536494;1859.3585213101458;1898.9905050474658;1929.5079754662472;1929.7394851695121;1953.8632295739162;841.3017195727532;842.2924743215729;843.1273631791189;858.5578427110044;859.7205908079899;16889.497543445617;17034.48896533106;17577.648447030988;18088.366907158186;18408.35570755017;807.1202389395587;819.995900020496;837.9539125348042;852.5055467828645;853.9402241843011;9355.578998945064;9492.715218543455;9588;10123.886372499019;10511.84232236517;278964;301808;502985;508990;510422;76790.23209767943;87414;90039.54980225056;91545;92591.5370423157;971.2569884038716;977.3988996766938;1002.2583288366557;1005.6932635546083;1006.5923301063082;15387.516874454026;15470.767938480707;16008.439704610282;16457.835421645632;16720.832791671928;39576.40635390414;39639.603603963595;40017;40244.3963340556;40264.79867600643;50314.49685503098;53838.46161538334;54106.45893541014;54339.45660543344;54385.72807135939;7441;7776.88334674969;7814.53112813233;7837.7648670539975;8383.874241886255;11475.885241147482;11835.704107397383;11867.727618057319;12093.274403535816;12142.271463712206;10108;10218.948905255425;10411;10583.4708264588;10939.398333091756;10093.646722364681;10273.845892311472;10350.741231469274;10414.367813222434;10586.100181484351;10115.7471063224;10627.36235825853;10781.784364312512;10791.477388129548;11265.662030139109;7641.617919103911;7903.328217101611;7930.088039875488;8222.465539739898;8354.331653467587;7932.801679957816;10181.643642472478;10585.153187744809;10891.292066015683;11519 03:17:36 INFO - PROCESS | 12668 | |3;mootools.html;1352.5063351876568;1352.7903175007875;1361.5642994241846;1380.2132784312946;1380.9102408343456;6736.696848641811;7121.537100088491;7130.500864939457;7131.465140114493;7132.643367831601;6240.563160578761;6403.679816009192;6791.76228831991;6979.546329488579;7025.227225005258;2121.745390553132;2160.5786871560053;2160.6650969099815;2164.448065743233;2172.598069357166;2144.345974477784;2173.5109600339956;2186.666133658467;2194.714687090676;2201.636729939558;1818.4635532517873;1875.0718394394794;2071.109422948132;2124.798144176301;2128.457243402938;2135.7970992755663;2136.8183704385146;2138.9251376201914;2139.0801955159277;2141.839362047853;2062.0823733438624;2064.8038436348675;2083.916643334265;2108.4518025313378;2170.8263338932848;7079.681414336367;7111.8222044448785;7116.146062472485;7125.572465652078;7127.251638577926;4141.503019637633;4271.722338048048;4273.252180868336;4275.572442755731;4286.314189729628;2727.945441091167;2867.1398580426;2881.8414987175697;2912.0826939513986;2917.1102813641833;1044.3785947361384;1079.3685693869097;1085.8154113800672;1091.3888222595292;1131.8415421840948;9068.183863452256;9115.589798459085;9119.863202052042;9124.498152601604;9144.222741067017;3806.7715937043868;4022.6982976276895;4073.1242782801246;4076;4087.570805065485;7967.760967170878;7973.481723687942;7979.241972012649;7980.441369104107;7990.960045199737;4293.849715259951;4293.849715260013;4297.076128632359;4299.032717638569;4302.806373713191;3439.94840077399;3538.221591249921;3744.4570537271943;3872.0900588361715;3944.5660977292473;3421.8973430797114;3446.4485682290715;3551.4140166872694;3561.2343346180696;3605.729570282187;1185.7154282972197;1214.684182112657;1220.871808460099;1228.4963165102265;1231.9876801231874;643.9227292724903;689.327905292346;692.1797669761349;692.8787462194095;792.4413288631501;4567.543245675406;4595.678302518859;4610.815567377267;4650.4186976627925;4655;873.5282947208564;883.960221790021;899.2715900120922;900.3157600223877;948.9145976862116;3114.9065528034193;3184.442722523549;3247.723943464832;3254.316593515341;3317.2204531934976;8333.250007499355;8619.1811777881;8620.482771033632;8631.43895646781;8636.956815215884;8288.295494883003;8453.196946290092;8455.281301089477;8541.188587084218;8549.700760473354;6455.419012288822;6615.966920165369;6737.157855268091;6750.1562304711915;6753.3921947025;4474.821007159677;4532.116237333688;4654.464736555339;4746.311784791255;4817.710937343771;7466.440016998638;7581.583012934341;7795.298423141944;7847.332976697045;7852.450328476952;7626.122995855326;7718.961405192938;7770.92229077702;7782.143964163824;7783.494072885244;5288.894222115613;5434.10337294342;5815.738291776795;5986.341502434641;5986.760529578943;6530.804075877541;6746.190457145174;6760.526763126731;6823.112995310578;6886.724531018703;5915.526757859447;6014.939850601438;6042.123892035543;6081.787137450345;6191.318954914866;6076.605020673642;6108.17539632144;6143.907841382472;6164.47601953839;6167.321594624677;5499.3675727291875;5571.387147413862;5594.944050559442;5599.692016939108;5620;4169.207850508394;4191.664666826708;4193.454850869368;4261.786910654517;4305.74165550068;4362.563743625612;4393.692441529062;4436.245838207577;4526.751028693322;4581.152486789954 03:17:36 INFO - PROCESS | 12668 | |4;prototype.html;342.1361063315129;351.53246182577175;352.5821901047259;359.67090112546987;362.19592504639706;4812.254100614402;4883.438404583474;4888.095702295073;4900.240462728283;4921.129970611171;4583.495815460305;4621.4223222097235;4720.929186062212;4754.690945088567;4838.34682317887;3853.7109716771215;3865.845366185363;3869.400242962331;3885.630865067821;3900.9804950975204;3865.9226815463676;3867.3038853006447;3874.1089549403514;3875.8449662013486;3893.415987601854;3699.1491956849804;3749.4188400797784;3787.008263471868;3823.5794062653226;3861.710371722118;3820.2932457495453;3838.213166300902;3838.2152299181016;3842.5965273646425;3850.152966347413;3458.9654103459147;3462.9653703462895;3465.1337165708574;3466.168119651291;3479.1997840496574;4479.46246450428;4712.811487540494;4713.34013238147;4757.78589963449;4776.832810851603;4154.504378423765;4250.342366477076;4261.914761704748;4268.9573104268875;4274.5939135782055;5044.117279476113;5046.318746969149;5077.822276220315;5086.79652813887;5121.257417674454;3592.317459682652;3601.549806274216;3606.6393360663988;3614.1567800421976;3619.384704600198;5179.278912510283;5259.921101183485;5272.973635131838;5282.81510147143;5311.415744268166;3626.0390996385977;3635.8727444539845;3644.1436262478296;3646.744727869024;3658.2500587379523;3682.9079273018388;3700.648438398348;3701.9444708329397;3705.870294539678;3710.9072273192846;4201.873943781691;4279.16556271524;4309.827606895752;4322.740635561876;4324.156789426094;5041.294218809369;5048.974755126201;5056.898862022813;5077.466865979093;5082.390113186441;1228.8648248692637;1234.8641649418557;1243.434237421971;1244.8506179258547;1246.1526162209602;810.9229623185788;823.4688625836302;832.1470492744985;852.3394369363792;855.9572021398906;4236.597523235288;4245.27830268855;4267.466566679165;4310.956890431055;4325.286327755948;4995.70025798446;5027.497250274943;5062.316587260746;5076.36545431821;5086.338775959101;4192.895177620523;4228.505181942669;4305.375720520569;4305.526392096866;4444.888877778081;2657.734226577327;2673.318303832549;2676.812623116402;2686.2942031809553;2688.5698288273784;4725.220338644154;4744.481765834968;4744.928826067612;4751.786169622375;4787.234042553175;5066.670666406671;5161.948380516222;5198.558122559549;5223.224103804725;5224.268602395668;4695;4722.740249286254;4741.5021422750115;4748.6438517111355;4792.442456201678;4999.225120106389;5016.824411145592;5030;5038.39539255277;5038.39539255277;4746.833860814855;4916.115099282163;4926.704397736147;4972.602191824718;4996.400431948189;4719.622430205507;4744.4069491313585;4745.4542727585385;4760.357351757469;4763.356946812136;3513.947290790691;3516.3648903260105;3518.718502519741;3519.454484554898;3526.7002304803354;4840.636952228527;5037.57180639635;5041.773120209673;5072.137736584716;5146.511081447256;4868.391451068616;4888.90222195547;4892.706437613754;4907.4847141051105;4926.433460152129;4882.145624515767;4887.828925987716;4888.266759986031;4915.016996600622;4915.878417205172;4585.931211031904;4840.7337596432535;4849.927251091166;4850.902981940271;4852.975735121443;4872.3909511311085;4874.756262186947;4884.48712885142;4891.364122664173;4907.509249075064;4746.762661866962;4747.362160054776;4758.762061896822;4787.329773831736;4804.543568361 03:17:36 INFO - PROCESS | 12668 | |5;yui.html;659.4790115808512;678.0744284052267;720.3696765330336;723.5875550935968;740.4076738609114;12846.16499927504;14049.648758781035;14105.78841317381;14187.503437379693;14213.78679319811;13279.336033198326;13502.864971350284;13512.256825874572;13516.256605886672;13531.391087401065;642.9003504456816;664.8404382948106;791.3273717340272;791.6516732637635;820.7373640435063;798.5887268056955;800.4636893281486;802.297989259398;803.8713805791075;804.2721337189823;848.9151084891523;852.526847599582;854.5129276312505;854.8162145138793;854.9658013679476;692.5463821197098;710.2719712294887;713.53263612334;718.0700992215094;855.0765173612483;613.1324176290543;633.7971849008319;637.0985056145548;638.6966191059256;640.9006603976391;12461;12531.18547294432;12536.937315313366;12542.874571254262;12547.24716517012;12865.935670321589;12867.485300587965;12963.805542916863;12968.740625187444;13039;12001.879981200163;12066.457009434596;12129.514819407214;12304.692382690415;12409.62771116868;3200.679932006804;3220.066180807563;3354.8322583870954;4079.9592004079877;4090.1615168890307;61758;62499;62755.6862215686;62819.99999999954;63042.68478657623;9983.582245016318;10159.136473399696;10192.847107293397;10250.128739057114;10867.619633312795;19971.60056798856;20146.69779953302;20180.09189586472;20427.080781364875;20427.182912683325;6459.644719540376;6473.805785826338;6548.967255163694;6557.836054098686;6614.437772789367;3509.3858574749315;3532.91167720809;3542.4509201073874;3554.0581745837376;3604.044928094057;2828.5191517442086;2868.780768173518;2894.435585060935;2898.840563769013;2913;503.2777963622214;508.265556271192;511.2816492827509;511.6392942975268;514.8841510660146;584.4885724990634;596.6420147911306;596.7076132694948;604.4759054711025;607.5534482155612;8308.086110527836;8534.87197692035;8565.571721413904;8983.146601072887;9331.766705832408;562.5599459306394;585.3824215452738;587.2102022779355;590.7666471743637;596.9850753731191;3995.1011022520283;4087.734297270668;4132.979335103365;4138.751674899516;4252.107057517956;63315;64275.35724642787;65064.67467662632;65823.34176658269;66626.33373666299;45981.160753570155;47187;47415.52584474111;56043;56245.43754562484;38931;39163;39500;41566.79216603837;44970.550294497945;9140.63437462494;9822.410655360702;9830.4101753895;9900.653477128266;9906.207503399855;35741;36126.01306928144;36193;36484.27031459409;37366.626333737404;40897.59102408938;42227.788861055495;42270.36594451024;43331.78334108309;45201.80179279293;10664.413457259925;10906.72733181645;10990.450477476254;11018.834717479083;11051.502682379472;12362.814557781461;12508.499660013862;12556.623301300975;12713.55502557406;13459.05786594968;11731.35477548743;11747.823782643438;11956.099939304322;12143.14997950135;12309.93845030769;12002.519899203933;12049.397530123633;12073;12445.875541244472;12810;11292.604758833402;11323.32060076398;11980.520779168735;12022.939885300517;12047;9214.677486288216;9318.906810932074;9580.904190958001;9903;9998.300118991892;9829.262805289489;10292.279540432099;10296.742581435225;10302.536385862504;10343.84484232722 03:17:36 INFO - PROCESS | 12668 | __end_tp_report 03:17:36 INFO - PROCESS | 12668 | __start_cc_report 03:17:36 INFO - PROCESS | 12668 | _x_x_mozilla_cycle_collect,1578 03:17:36 INFO - PROCESS | 12668 | __end_cc_report 03:17:36 INFO - PROCESS | 12668 | __startTimestamp1484306256236__endTimestamp 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | ------- Summary: start ------- 03:17:36 INFO - PROCESS | 12668 | Number of tests: 6 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#0] dojo.html Cycles:165 Average:4704.13 Median:4834.23 stddev:502.86 (10.4%) stddev-sans-first:474.85 03:17:36 INFO - PROCESS | 12668 | Values: 2538.9 2550.3 2562.2 2569.8 2571.1 4608.4 4655.9 4663.3 4717.6 4729.2 4730.8 4765.9 4788.5 4823.8 4866.4 4297.9 4310.3 4346.9 4394.9 4402.5 4142.5 4406.5 4450.1 4455.7 4486.9 4260.6 4371.6 4391.7 4395.8 4491.1 4314.4 4317.6 4349.9 4372.1 4449.4 4352.4 4368.6 4372.7 4402.5 4412.6 4754.5 4759.7 4762.5 4767.0 4773.3 4960.0 4992.9 5066.1 5088.8 5107.8 5148.5 5191.1 5195.4 5222.7 5241.9 4834.2 4840.9 4842.7 4849.5 4884.7 5034.4 5069.3 5279.5 5293.0 5296.3 4949.2 4982.3 5003.3 5010.4 5069.5 4932.7 4948.1 5099.4 5104.7 5113.2 4973.5 5007.8 5045.4 5065.2 5110.4 5063.1 5102.1 5106.7 5112.5 5150.9 4301.6 4315.7 4328.5 4355.9 4418.4 3781.0 3784.5 3810.2 3812.7 3828.3 4419.5 4434.8 4437.9 4442.3 4475.7 5054.3 5066.4 5096.8 5107.9 5204.3 4399.7 4419.1 4432.4 4457.9 4460.8 4584.4 4590.9 4596.4 4596.8 4627.0 4652.7 4688.9 4703.4 4794.9 4798.3 5012.3 5049.4 5067.2 5120.6 5166.7 4771.4 4773.0 4777.5 4777.6 4822.2 4962.7 5014.1 5020.6 5023.0 5068.9 5047.1 5094.8 5137.4 5143.8 5146.6 5000.9 5006.9 5008.3 5010.3 5011.0 4886.6 4923.3 4935.8 4987.1 5004.3 4836.2 4905.6 4912.2 4939.6 4974.6 4911.3 4950.1 4952.8 4953.3 4996.2 4748.0 4794.2 4821.0 4841.2 4927.5 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#1] ext.html Cycles:180 Average:45645.60 Median:20683.05 stddev:76363.49 (369.2%) stddev-sans-first:76502.56 03:17:36 INFO - PROCESS | 12668 | Values: 526.6 541.8 544.8 584.7 604.3 28826.9 37157.4 38869.4 38916.2 43829.6 40131.4 40373.0 40449.0 40948.6 41073.6 7288.6 7570.1 7746.8 7751.7 7753.3 7295.1 9703.0 9989.3 9990.4 10294.4 10030.0 10096.6 10122.1 10137.0 10141.4 9973.1 9978.3 10027.3 10034.8 10045.7 9863.6 9931.4 9935.2 9942.9 9947.2 37240.0 37430.0 37535.3 37553.0 37608.4 3581.5 3717.2 3717.7 3757.7 3782.9 28429.0 28459.7 28680.7 29372.9 29467.1 3229.3 3233.4 3256.7 3391.9 3401.5 226413.0 227564.0 230530.0 230572.0 231570.0 51720.7 51891.7 51956.0 52005.0 52021.5 54880.7 54942.7 55012.7 55035.4 55041.4 12618.2 12902.4 12911.6 12921.4 12935.4 8610.7 8872.9 9080.8 9181.6 9371.0 14869.3 15408.2 15513.7 15542.1 15546.9 5724.5 5806.3 5826.3 5970.7 5986.6 814.6 827.3 834.5 845.4 854.9 26568.2 27766.2 27875.6 27877.9 28299.7 951.3 952.8 957.3 985.1 992.7 14016.8 14854.7 15000.5 15007.1 15157.8 325362.0 327401.0 327554.0 327645.0 327757.0 48549.8 48887.8 48982.0 49004.8 49053.5 1177.9 1194.2 1208.8 1210.3 1246.0 25022.9 25754.9 26622.6 27002.9 27082.6 40198.8 53297.2 54395.5 54498.7 54965.7 255678.0 320338.0 320946.0 321183.0 323372.0 39884.0 39894.6 39921.2 39935.0 40763.0 42837.8 42982.0 43031.8 43100.8 43102.4 36505.6 36864.6 37627.6 37876.4 38706.2 37452.6 37520.6 37776.0 38519.2 43164.6 36456.5 36926.8 37365.0 37873.0 37914.4 31699.2 34041.3 34482.7 34764.5 34877.7 25869.4 26250.2 26255.7 26614.2 26748.5 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#2] jquery.html Cycles:180 Average:25720.68 Median:4260.81 stddev:71819.41 (1685.6%) stddev-sans-first:71995.66 03:17:36 INFO - PROCESS | 12668 | Values: 373.0 383.8 391.9 394.8 416.4 12558.0 14365.9 14970.7 18134.8 18173.5 15302.5 15324.5 15649.5 15731.1 15780.1 5163.8 5348.0 5359.9 5389.8 5401.2 3964.4 4162.7 5353.2 5357.0 6382.4 6450.7 6473.1 6473.2 6476.7 6489.7 6150.0 6257.5 6278.9 6292.8 6345.0 5346.7 5539.1 5569.9 5571.9 5582.2 19650.8 20409.2 21679.6 21985.2 22011.1 2384.3 2430.4 2441.5 2467.9 2470.2 9110.4 9202.4 9428.4 9674.8 9770.8 1790.3 1806.9 1807.4 1822.6 1840.0 59082.7 69550.7 69895.7 74544.3 79992.0 9771.8 9927.6 9972.8 10126.8 10201.5 13557.7 13581.3 13599.7 13620.8 13666.7 6656.6 6803.3 6848.3 6937.2 6961.0 6252.9 6269.9 6405.2 6407.5 6442.9 4221.3 4300.3 4320.9 4368.5 4384.1 1859.4 1899.0 1929.5 1929.7 1953.9 841.3 842.3 843.1 858.6 859.7 16889.5 17034.5 17577.6 18088.4 18408.4 807.1 820.0 838.0 852.5 853.9 9355.6 9492.7 9588.0 10123.9 10511.8 278964.0 301808.0 502985.0 508990.0 510422.0 76790.2 87414.0 90039.5 91545.0 92591.5 971.3 977.4 1002.3 1005.7 1006.6 15387.5 15470.8 16008.4 16457.8 16720.8 39576.4 39639.6 40017.0 40244.4 40264.8 50314.5 53838.5 54106.5 54339.5 54385.7 7441.0 7776.9 7814.5 7837.8 8383.9 11475.9 11835.7 11867.7 12093.3 12142.3 10108.0 10218.9 10411.0 10583.5 10939.4 10093.6 10273.8 10350.7 10414.4 10586.1 10115.7 10627.4 10781.8 10791.5 11265.7 7641.6 7903.3 7930.1 8222.5 8354.3 7932.8 10181.6 10585.2 10891.3 11519.0 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#3] mootools.html Cycles:180 Average:4637.53 Median:4652.44 stddev:2456.76 (52.8%) stddev-sans-first:2451.24 03:17:36 INFO - PROCESS | 12668 | Values: 1352.5 1352.8 1361.6 1380.2 1380.9 6736.7 7121.5 7130.5 7131.5 7132.6 6240.6 6403.7 6791.8 6979.5 7025.2 2121.7 2160.6 2160.7 2164.4 2172.6 2144.3 2173.5 2186.7 2194.7 2201.6 1818.5 1875.1 2071.1 2124.8 2128.5 2135.8 2136.8 2138.9 2139.1 2141.8 2062.1 2064.8 2083.9 2108.5 2170.8 7079.7 7111.8 7116.1 7125.6 7127.3 4141.5 4271.7 4273.3 4275.6 4286.3 2727.9 2867.1 2881.8 2912.1 2917.1 1044.4 1079.4 1085.8 1091.4 1131.8 9068.2 9115.6 9119.9 9124.5 9144.2 3806.8 4022.7 4073.1 4076.0 4087.6 7967.8 7973.5 7979.2 7980.4 7991.0 4293.8 4293.8 4297.1 4299.0 4302.8 3439.9 3538.2 3744.5 3872.1 3944.6 3421.9 3446.4 3551.4 3561.2 3605.7 1185.7 1214.7 1220.9 1228.5 1232.0 643.9 689.3 692.2 692.9 792.4 4567.5 4595.7 4610.8 4650.4 4655.0 873.5 884.0 899.3 900.3 948.9 3114.9 3184.4 3247.7 3254.3 3317.2 8333.3 8619.2 8620.5 8631.4 8637.0 8288.3 8453.2 8455.3 8541.2 8549.7 6455.4 6616.0 6737.2 6750.2 6753.4 4474.8 4532.1 4654.5 4746.3 4817.7 7466.4 7581.6 7795.3 7847.3 7852.5 7626.1 7719.0 7770.9 7782.1 7783.5 5288.9 5434.1 5815.7 5986.3 5986.8 6530.8 6746.2 6760.5 6823.1 6886.7 5915.5 6014.9 6042.1 6081.8 6191.3 6076.6 6108.2 6143.9 6164.5 6167.3 5499.4 5571.4 5594.9 5599.7 5620.0 4169.2 4191.7 4193.5 4261.8 4305.7 4362.6 4393.7 4436.2 4526.8 4581.2 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#4] prototype.html Cycles:180 Average:4134.92 Median:4733.36 stddev:1178.64 (24.9%) stddev-sans-first:1147.05 03:17:36 INFO - PROCESS | 12668 | Values: 342.1 351.5 352.6 359.7 362.2 4812.3 4883.4 4888.1 4900.2 4921.1 4583.5 4621.4 4720.9 4754.7 4838.3 3853.7 3865.8 3869.4 3885.6 3901.0 3865.9 3867.3 3874.1 3875.8 3893.4 3699.1 3749.4 3787.0 3823.6 3861.7 3820.3 3838.2 3838.2 3842.6 3850.2 3459.0 3463.0 3465.1 3466.2 3479.2 4479.5 4712.8 4713.3 4757.8 4776.8 4154.5 4250.3 4261.9 4269.0 4274.6 5044.1 5046.3 5077.8 5086.8 5121.3 3592.3 3601.5 3606.6 3614.2 3619.4 5179.3 5259.9 5273.0 5282.8 5311.4 3626.0 3635.9 3644.1 3646.7 3658.3 3682.9 3700.6 3701.9 3705.9 3710.9 4201.9 4279.2 4309.8 4322.7 4324.2 5041.3 5049.0 5056.9 5077.5 5082.4 1228.9 1234.9 1243.4 1244.9 1246.2 810.9 823.5 832.1 852.3 856.0 4236.6 4245.3 4267.5 4311.0 4325.3 4995.7 5027.5 5062.3 5076.4 5086.3 4192.9 4228.5 4305.4 4305.5 4444.9 2657.7 2673.3 2676.8 2686.3 2688.6 4725.2 4744.5 4744.9 4751.8 4787.2 5066.7 5161.9 5198.6 5223.2 5224.3 4695.0 4722.7 4741.5 4748.6 4792.4 4999.2 5016.8 5030.0 5038.4 5038.4 4746.8 4916.1 4926.7 4972.6 4996.4 4719.6 4744.4 4745.5 4760.4 4763.4 3513.9 3516.4 3518.7 3519.5 3526.7 4840.6 5037.6 5041.8 5072.1 5146.5 4868.4 4888.9 4892.7 4907.5 4926.4 4882.1 4887.8 4888.3 4915.0 4915.9 4585.9 4840.7 4849.9 4850.9 4853.0 4872.4 4874.8 4884.5 4891.4 4907.5 4746.8 4747.4 4758.8 4787.3 4804.5 03:17:36 INFO - PROCESS | 12668 | 03:17:36 INFO - PROCESS | 12668 | [#5] yui.html Cycles:180 Average:14400.89 Median:22852.77 stddev:17229.89 (75.4%) stddev-sans-first:17247.33 03:17:36 INFO - PROCESS | 12668 | Values: 659.5 678.1 720.4 723.6 740.4 12846.2 14049.6 14105.8 14187.5 14213.8 13279.3 13502.9 13512.3 13516.3 13531.4 642.9 664.8 791.3 791.7 820.7 798.6 800.5 802.3 803.9 804.3 848.9 852.5 854.5 854.8 855.0 692.5 710.3 713.5 718.1 855.1 613.1 633.8 637.1 638.7 640.9 12461.0 12531.2 12536.9 12542.9 12547.2 12865.9 12867.5 12963.8 12968.7 13039.0 12001.9 12066.5 12129.5 12304.7 12409.6 3200.7 3220.1 3354.8 4080.0 4090.2 61758.0 62499.0 62755.7 62820.0 63042.7 9983.6 10159.1 10192.8 10250.1 10867.6 19971.6 20146.7 20180.1 20427.1 20427.2 6459.6 6473.8 6549.0 6557.8 6614.4 3509.4 3532.9 3542.5 3554.1 3604.0 2828.5 2868.8 2894.4 2898.8 2913.0 503.3 508.3 511.3 511.6 514.9 584.5 596.6 596.7 604.5 607.6 8308.1 8534.9 8565.6 8983.1 9331.8 562.6 585.4 587.2 590.8 597.0 3995.1 4087.7 4133.0 4138.8 4252.1 63315.0 64275.4 65064.7 65823.3 66626.3 45981.2 47187.0 47415.5 56043.0 56245.4 38931.0 39163.0 39500.0 41566.8 44970.6 9140.6 9822.4 9830.4 9900.7 9906.2 35741.0 36126.0 36193.0 36484.3 37366.6 40897.6 42227.8 42270.4 43331.8 45201.8 10664.4 10906.7 10990.5 11018.8 11051.5 12362.8 12508.5 12556.6 12713.6 13459.1 11731.4 11747.8 11956.1 12143.1 12309.9 12002.5 12049.4 12073.0 12445.9 12810.0 11292.6 11323.3 11980.5 12022.9 12047.0 9214.7 9318.9 9580.9 9903.0 9998.3 9829.3 10292.3 10296.7 10302.5 10343.8 03:17:36 INFO - PROCESS | 12668 | -------- Summary: end -------- 03:17:36 INFO - PROCESS | 12668 | 03:17:37 INFO - TEST-INFO | 12668: exit 0 03:17:37 INFO - TEST-OK | dromaeo_css | took 1121027ms 03:17:37 INFO - TEST-START | kraken 03:17:37 INFO - operating with platform_type : linux_ 03:17:37 INFO - Initialising browser for kraken test... 03:17:37 INFO - TEST-INFO | started process 12973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnah5g/profile http://localhost:37461/getInfo.html) 03:17:41 INFO - PROCESS | 12973 | __metrics Screen width/height:1600/1200 03:17:41 INFO - PROCESS | 12973 | colorDepth:24 03:17:41 INFO - PROCESS | 12973 | Browser inner width/height: 1024/697 03:17:41 INFO - PROCESS | 12973 | __metrics 03:17:42 INFO - PROCESS | 12973 | 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:17:42 INFO - PROCESS | 12973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:42 INFO - PROCESS | 12973 | console.error: PushService: 03:17:42 INFO - PROCESS | 12973 | stateChangeProcessEnqueue: Error transitioning state 03:17:42 INFO - PROCESS | 12973 | UnknownError 03:17:43 INFO - TEST-INFO | 12973: exit 0 03:17:43 INFO - Browser initialized. 03:17:43 INFO - Running cycle 1/1 for kraken test... 03:17:43 INFO - TEST-INFO | started process 13058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnah5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:55 INFO - PROCESS | 13058 | RSS: Main: 152494080 03:17:55 INFO - PROCESS | 13058 | 03:17:58 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37461/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:59 INFO - PROCESS | 13058 | RSS: Main: 206028800 03:17:59 INFO - PROCESS | 13058 | 03:18:01 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37461/tests/kraken/driver.html?testName=audio-dft) 03:18:02 INFO - PROCESS | 13058 | RSS: Main: 186355712 03:18:02 INFO - PROCESS | 13058 | 03:18:05 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37461/tests/kraken/driver.html?testName=audio-fft) 03:18:06 INFO - PROCESS | 13058 | RSS: Main: 268107776 03:18:06 INFO - PROCESS | 13058 | 03:18:08 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37461/tests/kraken/driver.html?testName=audio-oscillator) 03:18:08 INFO - PROCESS | 13058 | RSS: Main: 179359744 03:18:08 INFO - PROCESS | 13058 | 03:18:11 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:11 INFO - PROCESS | 13058 | RSS: Main: 182624256 03:18:11 INFO - PROCESS | 13058 | 03:18:14 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37461/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:15 INFO - PROCESS | 13058 | RSS: Main: 221970432 03:18:15 INFO - PROCESS | 13058 | 03:18:18 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37461/tests/kraken/driver.html?testName=imaging-desaturate) 03:18:19 INFO - PROCESS | 13058 | RSS: Main: 221503488 03:18:19 INFO - PROCESS | 13058 | 03:18:22 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37461/tests/kraken/driver.html?testName=json-parse-financial) 03:18:23 INFO - PROCESS | 13058 | RSS: Main: 219881472 03:18:23 INFO - PROCESS | 13058 | 03:18:24 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:25 INFO - PROCESS | 13058 | RSS: Main: 182767616 03:18:25 INFO - PROCESS | 13058 | 03:18:27 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:27 INFO - PROCESS | 13058 | RSS: Main: 189906944 03:18:27 INFO - PROCESS | 13058 | 03:18:30 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:30 INFO - PROCESS | 13058 | RSS: Main: 198369280 03:18:30 INFO - PROCESS | 13058 | 03:18:33 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:34 INFO - PROCESS | 13058 | RSS: Main: 207040512 03:18:34 INFO - PROCESS | 13058 | 03:18:37 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:37 INFO - PROCESS | 13058 | RSS: Main: 203702272 03:18:37 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | Cycle 1(1): loaded http://localhost:37461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37461/tests/kraken/driver.html?testName=ai-astar) 03:18:39 INFO - PROCESS | 13058 | RSS: Main: 255320064 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | __start_tp_report 03:18:39 INFO - PROCESS | 13058 | _x_x_mozilla_page_load 03:18:39 INFO - PROCESS | 13058 | _x_x_mozilla_page_load_details 03:18:39 INFO - PROCESS | 13058 | |i|pagename|runs| 03:18:39 INFO - PROCESS | 13058 | |0;ai-astar;106;114;114;117;116;113;114;115;114;115 03:18:39 INFO - PROCESS | 13058 | |1;audio-beat-detection;151;124;124;177;126;127;124;124;144;125 03:18:39 INFO - PROCESS | 13058 | |2;audio-dft;161;160;161;161;161;162;161;161;161;161 03:18:39 INFO - PROCESS | 13058 | |3;audio-fft;75;75;76;109;76;76;84;76;94;77 03:18:39 INFO - PROCESS | 13058 | |4;audio-oscillator;85;84;114;86;84;85;110;85;86;111 03:18:39 INFO - PROCESS | 13058 | |5;imaging-gaussian-blur;117;117;118;117;117;118;117;118;117;118 03:18:39 INFO - PROCESS | 13058 | |6;imaging-darkroom;148;149;150;150;149;149;149;150;149;149 03:18:39 INFO - PROCESS | 13058 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;96 03:18:39 INFO - PROCESS | 13058 | |8;json-parse-financial;63;61;61;61;61;63;61;60;61;63 03:18:39 INFO - PROCESS | 13058 | |9;json-stringify-tinderbox;67;67;68;68;67;67;69;67;67;83 03:18:39 INFO - PROCESS | 13058 | |10;stanford-crypto-aes;85;84;83;83;85;85;85;86;90;85 03:18:39 INFO - PROCESS | 13058 | |11;stanford-crypto-ccm;145;134;131;140;139;133;130;131;180;139 03:18:39 INFO - PROCESS | 13058 | |12;stanford-crypto-pbkdf2;179;182;177;172;178;175;172;175;176;172 03:18:39 INFO - PROCESS | 13058 | |13;stanford-crypto-sha256-iterative;68;68;72;67;75;68;68;69;66;65 03:18:39 INFO - PROCESS | 13058 | __end_tp_report 03:18:39 INFO - PROCESS | 13058 | __start_cc_report 03:18:39 INFO - PROCESS | 13058 | _x_x_mozilla_cycle_collect,1807 03:18:39 INFO - PROCESS | 13058 | __end_cc_report 03:18:39 INFO - PROCESS | 13058 | __startTimestamp1484306319895__endTimestamp 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | ------- Summary: start ------- 03:18:39 INFO - PROCESS | 13058 | Number of tests: 14 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:2.97 (2.6%) stddev-sans-first:1.22 03:18:39 INFO - PROCESS | 13058 | Values: 106.0 114.0 114.0 117.0 116.0 113.0 114.0 115.0 114.0 115.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.50 stddev:17.73 (14.0%) stddev-sans-first:17.78 03:18:39 INFO - PROCESS | 13058 | Values: 151.0 124.0 124.0 177.0 126.0 127.0 124.0 124.0 144.0 125.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 03:18:39 INFO - PROCESS | 13058 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 161.0 161.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.27 (14.8%) stddev-sans-first:11.68 03:18:39 INFO - PROCESS | 13058 | Values: 75.0 75.0 76.0 109.0 76.0 76.0 84.0 76.0 94.0 77.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:85.00 stddev:12.94 (15.2%) stddev-sans-first:13.39 03:18:39 INFO - PROCESS | 13058 | Values: 85.0 84.0 114.0 86.0 84.0 85.0 110.0 85.0 86.0 111.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:18:39 INFO - PROCESS | 13058 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 03:18:39 INFO - PROCESS | 13058 | Values: 148.0 149.0 150.0 150.0 149.0 149.0 149.0 150.0 149.0 149.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:18:39 INFO - PROCESS | 13058 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.00 stddev:1.08 (1.8%) stddev-sans-first:1.00 03:18:39 INFO - PROCESS | 13058 | Values: 63.0 61.0 61.0 61.0 61.0 63.0 61.0 60.0 61.0 63.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:67.50 stddev:4.97 (7.4%) stddev-sans-first:5.21 03:18:39 INFO - PROCESS | 13058 | Values: 67.0 67.0 68.0 68.0 67.0 67.0 69.0 67.0 67.0 83.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.97 (2.3%) stddev-sans-first:2.09 03:18:39 INFO - PROCESS | 13058 | Values: 85.0 84.0 83.0 83.0 85.0 85.0 85.0 86.0 90.0 85.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.00 stddev:14.81 (10.7%) stddev-sans-first:15.60 03:18:39 INFO - PROCESS | 13058 | Values: 145.0 134.0 131.0 140.0 139.0 133.0 130.0 131.0 180.0 139.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.50 stddev:3.33 (1.9%) stddev-sans-first:3.32 03:18:39 INFO - PROCESS | 13058 | Values: 179.0 182.0 177.0 172.0 178.0 175.0 172.0 175.0 176.0 172.0 03:18:39 INFO - PROCESS | 13058 | 03:18:39 INFO - PROCESS | 13058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:2.91 (4.3%) stddev-sans-first:3.08 03:18:39 INFO - PROCESS | 13058 | Values: 68.0 68.0 72.0 67.0 75.0 68.0 68.0 69.0 66.0 65.0 03:18:39 INFO - PROCESS | 13058 | -------- Summary: end -------- 03:18:39 INFO - PROCESS | 13058 | 03:18:40 INFO - TEST-INFO | 13058: exit 0 03:18:41 INFO - TEST-OK | kraken | took 63955ms 03:18:41 INFO - SUITE-END | took 1184s 03:18:41 INFO - Completed test suite (00:19:44) 03:18:41 INFO - javascript benchmark 03:18:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2538.923832285032, 2550.2604244769013, 2562.244137979296, 2569.832960857544, 2571.125817222144, 4608.446986361637, 4655.860324190276, 4663.347131401598, 4717.622590192785, 4729.172394830899, 4730.834420795273, 4765.857024289268, 4788.521147885219, 4823.78292976816, 4866.391701037371, 4297.93553096703, 4310.267254566731, 4346.8913277168, 4394.890127746816, 4402.493713222988, 4142.523609784868, 4406.493253275882, 4450.132224216279, 4455.710378825383, 4486.8878278042985, 4260.573942605745, 4371.628411585019, 4391.670624703144, 4395.824167033315, 4491.056878055612, 4314.417553630251, 4317.589828966243, 4349.869503914888, 4372.147431250907, 4449.3548435477, 4352.412424322708, 4368.584984426474, 4372.737635741865, 4402.537733537964, 4412.602865742067, 4754.453237877654, 4759.738214398207, 4762.476127625959, 4766.952330476685, 4773.284007398884, 4959.95840873417, 4992.87517812054, 5066.06277838601, 5088.7964481420695, 5107.770150343244, 5148.485151484859, 5191.091558977201, 5195.428502864682, 5222.686638801684, 5241.947580524184, 4834.226523756182, 4840.854774356775, 4842.709437433765, 4849.539293767087, 4884.706917584886, 5034.446210916796, 5069.290299358093, 5279.472052794767, 5293.0, 5296.311479507716, 4949.208126699711, 4982.327385802942, 5003.274525193827, 5010.398752149766, 5069.518395752398, 4932.7286999215385, 4948.134076536592, 5099.444669375802, 5104.69371837691, 5113.181890897513, 4973.477784832613, 5007.849764506997, 5045.369328833895, 5065.214891691794, 5110.361204849394, 5063.063333283354, 5102.132637451642, 5106.693598384109, 5112.539871411591, 5150.922736158961, 4301.612854843079, 4315.6763242756915, 4328.458942632171, 4355.891102722394, 4418.403515525363, 3781.0169355967646, 3784.4512545680723, 3810.2189051244427, 3812.6568608825337, 3828.272628200633, 4419.535948725402, 4434.800433980478, 4437.866863994085, 4442.333649952533, 4475.686701930834, 5054.267131265946, 5066.442691303953, 5096.770645320969, 5107.8723031923755, 5204.323437953042, 4399.670024748157, 4419.11617676466, 4432.4237849080055, 4457.9331310030375, 4460.821567137278, 4584.404027476407, 4590.885227869263, 4596.35651008859, 4596.770161491912, 4627.0, 4652.651051171108, 4688.859334219979, 4703.412073490814, 4794.856154315376, 4798.3042458843975, 5012.298278240976, 5049.394072711299, 5067.239914012927, 5120.641555091257, 5166.689998600096, 4771.427428708577, 4773.0, 4777.522247775195, 4777.593904518155, 4822.204336284473, 4962.6774259673, 5014.122528557415, 5020.648554601289, 5023.02051100032, 5068.949310506848, 5047.091523525801, 5094.7962081516325, 5137.434882163034, 5143.819966301311, 5146.588272938231, 5000.924986125284, 5006.899862002667, 5008.273800299009, 5010.323606313101, 5011.022850544255, 4886.584640305614, 4923.261510773269, 4935.8025678972435, 4987.10232158215, 5004.324416203912, 4836.177849765619, 4905.558499735041, 4912.214045752662, 4939.629527785502, 4974.5771609413605, 4911.26331050331, 4950.084234416644, 4952.826651067196, 4953.2570114483115, 4996.150654388835, 4748.026654535743, 4794.232922732346, 4820.9517904820505, 4841.2496063110275, 4927.457979622311], "value": 4670.64467663613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.6024151765417, 541.7670401727256, 544.7875328621836, 584.6755050946723, 604.2748701558131, 28826.855865720667, 37157.442638360444, 38869.416958745605, 38916.22167556647, 43829.56170438295, 40131.398029029515, 40373.0, 40449.0, 40948.59051409485, 41073.58926410735, 7288.635568221594, 7570.129435114977, 7746.806329841743, 7751.651175697107, 7753.302202801747, 7295.088113985752, 9702.951485242564, 9989.250806189528, 9990.400575965428, 10294.43380614066, 10030.0, 10096.646617368393, 10122.089011988919, 10137.0, 10141.44222067786, 9973.05256000686, 9978.251631127658, 10027.298089133763, 10034.799304013879, 10045.698629041104, 9863.556139973647, 9931.354461959949, 9935.205183585296, 9942.850857237147, 9947.20422366209, 37240.0, 37430.0, 37535.30808648919, 37553.0, 37608.435873461916, 3581.4806853006166, 3717.237966216946, 3717.70258379329, 3757.6618104370737, 3782.924341513182, 28429.0, 28459.715402845915, 28680.713192868014, 29372.8531357344, 29467.11598652044, 3229.321842413096, 3233.369492948876, 3256.6580509046685, 3391.8812841550425, 3401.4557670772806, 226413.0, 227564.0, 230530.0, 230572.0, 231570.0, 51720.741396292775, 51891.740541297055, 51956.0, 52005.0, 52021.47978520242, 54880.72559637176, 54942.72528637411, 55012.72493637506, 55035.44964550303, 55041.44958550363, 12618.24290542552, 12902.35488225585, 12911.612651620466, 12921.353932303347, 12935.417906194243, 8610.741677749678, 8872.8669069964, 9080.772980675536, 9181.632734690671, 9370.95314523423, 14869.256537173098, 15408.22958852053, 15513.689726205639, 15542.145182015098, 15546.9222653886, 5724.542036637059, 5806.274215723035, 5826.271716035496, 5970.671613061237, 5986.551008674367, 814.608987685914, 827.3463963468912, 834.4742812028384, 845.3870943565865, 854.9016863060704, 26568.202953911412, 27766.167014989584, 27875.581866272023, 27877.86061069682, 28299.71700283012, 951.3150531617224, 952.79991201847, 957.2533423929347, 985.0838719990335, 992.692265397729, 14016.789748153786, 14854.70290594182, 15000.474983375529, 15007.060913477464, 15157.848421515644, 325362.0, 327401.0, 327554.0, 327645.0, 327757.0, 48549.757251213516, 48887.755561221966, 48982.0, 49004.7549762256, 49053.509464905605, 1177.8527684039495, 1194.2237545595433, 1208.812634041725, 1210.3343161261448, 1245.9813102803466, 25022.874885625457, 25754.87122564375, 26622.600660990487, 27002.864985674947, 27082.593761093995, 40198.79900600478, 53297.20054199112, 54395.45604543904, 54498.727506362215, 54965.72517137389, 255678.0, 320338.0, 320946.0, 321183.0, 323372.0, 39884.0, 39894.60105398909, 39921.203545839926, 39935.0, 40763.0, 42837.78581107199, 42982.0, 43031.7848410756, 43100.78449607732, 43102.35346469743, 36505.63494365022, 36864.63135368719, 37627.62372376351, 37876.43185352277, 38706.22587548177, 37452.625473746004, 37520.62479375171, 37776.0, 38519.22961540698, 43164.568354316056, 36456.453153203256, 36926.815365923, 37365.0, 37873.0, 37914.43128353132, 31699.207519811265, 34041.276697863614, 34482.65517344794, 34764.47853282253, 34877.65122348744, 25869.435016969004, 26250.212493625222, 26255.73744262533, 26614.201573952814, 26748.465030698888], "value": 17899.03044779783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.98881033569, 383.84454296010125, 391.9339396840594, 394.84995701633386, 416.41493701349617, 12557.998096975758, 14365.928170359146, 14970.700585988287, 18134.82123661961, 18173.45479635613, 15302.464413745522, 15324.540263792076, 15649.530514084567, 15731.134787586678, 15780.132092734895, 5163.7676304566385, 5347.973260133694, 5359.892802143955, 5389.8113566025195, 5401.162819762943, 3964.385520244367, 4162.666986641061, 5353.170258609922, 5357.0, 6382.4255816976465, 6450.6774661266745, 6473.122794389621, 6473.223213214421, 6476.708548115346, 6489.675516224193, 6149.969250153743, 6257.530685198628, 6278.937210627881, 6292.779752708633, 6345.0, 5346.732663366816, 5539.113741801292, 5569.916451253234, 5571.8885622287735, 5582.162675598693, 19650.80349196504, 20409.183632654676, 21679.566408671737, 21985.23051693199, 22011.11955521777, 2384.332386931662, 2430.442919525889, 2441.4994926040117, 2467.90128394864, 2470.22188010776, 9110.362274640778, 9202.447853128766, 9428.387154834982, 9674.75813104678, 9770.804583908282, 1790.3107303688043, 1806.8825526340745, 1807.430659342303, 1822.599028213791, 1839.997201525172, 59082.70458647722, 69550.65224673845, 69895.65052174758, 74544.25455745427, 79992.0, 9771.804563908681, 9927.602895884083, 9972.750681232883, 10126.848097278547, 10201.489925503694, 13557.661058473617, 13581.320933953262, 13599.728005440034, 13620.799112208622, 13666.658333541742, 6656.633885136364, 6803.319668033157, 6848.280930502226, 6937.236903940562, 6960.965195173992, 6252.937470625327, 6269.937300627026, 6405.19935008124, 6407.455366293824, 6442.871142577123, 4221.282381995068, 4300.333448315516, 4320.891977700519, 4368.5194628590825, 4384.12317536494, 1859.3585213101458, 1898.9905050474658, 1929.5079754662472, 1929.7394851695121, 1953.8632295739162, 841.3017195727532, 842.2924743215729, 843.1273631791189, 858.5578427110044, 859.7205908079899, 16889.497543445617, 17034.48896533106, 17577.648447030988, 18088.366907158186, 18408.35570755017, 807.1202389395587, 819.995900020496, 837.9539125348042, 852.5055467828645, 853.9402241843011, 9355.578998945064, 9492.715218543455, 9588.0, 10123.886372499019, 10511.84232236517, 278964.0, 301808.0, 502985.0, 508990.0, 510422.0, 76790.23209767943, 87414.0, 90039.54980225056, 91545.0, 92591.5370423157, 971.2569884038716, 977.3988996766938, 1002.2583288366557, 1005.6932635546083, 1006.5923301063082, 15387.516874454026, 15470.767938480707, 16008.439704610282, 16457.835421645632, 16720.832791671928, 39576.40635390414, 39639.603603963595, 40017.0, 40244.3963340556, 40264.79867600643, 50314.49685503098, 53838.46161538334, 54106.45893541014, 54339.45660543344, 54385.72807135939, 7441.0, 7776.88334674969, 7814.53112813233, 7837.7648670539975, 8383.874241886255, 11475.885241147482, 11835.704107397383, 11867.727618057319, 12093.274403535816, 12142.271463712206, 10108.0, 10218.948905255425, 10411.0, 10583.4708264588, 10939.398333091756, 10093.646722364681, 10273.845892311472, 10350.741231469274, 10414.367813222434, 10586.100181484351, 10115.7471063224, 10627.36235825853, 10781.784364312512, 10791.477388129548, 11265.662030139109, 7641.617919103911, 7903.328217101611, 7930.088039875488, 8222.465539739898, 8354.331653467587, 7932.801679957816, 10181.643642472478, 10585.153187744809, 10891.292066015683, 11519.0], "value": 8455.765850795766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.5063351876568, 1352.7903175007875, 1361.5642994241846, 1380.2132784312946, 1380.9102408343456, 6736.696848641811, 7121.537100088491, 7130.500864939457, 7131.465140114493, 7132.643367831601, 6240.563160578761, 6403.679816009192, 6791.76228831991, 6979.546329488579, 7025.227225005258, 2121.745390553132, 2160.5786871560053, 2160.6650969099815, 2164.448065743233, 2172.598069357166, 2144.345974477784, 2173.5109600339956, 2186.666133658467, 2194.714687090676, 2201.636729939558, 1818.4635532517873, 1875.0718394394794, 2071.109422948132, 2124.798144176301, 2128.457243402938, 2135.7970992755663, 2136.8183704385146, 2138.9251376201914, 2139.0801955159277, 2141.839362047853, 2062.0823733438624, 2064.8038436348675, 2083.916643334265, 2108.4518025313378, 2170.8263338932848, 7079.681414336367, 7111.8222044448785, 7116.146062472485, 7125.572465652078, 7127.251638577926, 4141.503019637633, 4271.722338048048, 4273.252180868336, 4275.572442755731, 4286.314189729628, 2727.945441091167, 2867.1398580426, 2881.8414987175697, 2912.0826939513986, 2917.1102813641833, 1044.3785947361384, 1079.3685693869097, 1085.8154113800672, 1091.3888222595292, 1131.8415421840948, 9068.183863452256, 9115.589798459085, 9119.863202052042, 9124.498152601604, 9144.222741067017, 3806.7715937043868, 4022.6982976276895, 4073.1242782801246, 4076.0, 4087.570805065485, 7967.760967170878, 7973.481723687942, 7979.241972012649, 7980.441369104107, 7990.960045199737, 4293.849715259951, 4293.849715260013, 4297.076128632359, 4299.032717638569, 4302.806373713191, 3439.94840077399, 3538.221591249921, 3744.4570537271943, 3872.0900588361715, 3944.5660977292473, 3421.8973430797114, 3446.4485682290715, 3551.4140166872694, 3561.2343346180696, 3605.729570282187, 1185.7154282972197, 1214.684182112657, 1220.871808460099, 1228.4963165102265, 1231.9876801231874, 643.9227292724903, 689.327905292346, 692.1797669761349, 692.8787462194095, 792.4413288631501, 4567.543245675406, 4595.678302518859, 4610.815567377267, 4650.4186976627925, 4655.0, 873.5282947208564, 883.960221790021, 899.2715900120922, 900.3157600223877, 948.9145976862116, 3114.9065528034193, 3184.442722523549, 3247.723943464832, 3254.316593515341, 3317.2204531934976, 8333.250007499355, 8619.1811777881, 8620.482771033632, 8631.43895646781, 8636.956815215884, 8288.295494883003, 8453.196946290092, 8455.281301089477, 8541.188587084218, 8549.700760473354, 6455.419012288822, 6615.966920165369, 6737.157855268091, 6750.1562304711915, 6753.3921947025, 4474.821007159677, 4532.116237333688, 4654.464736555339, 4746.311784791255, 4817.710937343771, 7466.440016998638, 7581.583012934341, 7795.298423141944, 7847.332976697045, 7852.450328476952, 7626.122995855326, 7718.961405192938, 7770.92229077702, 7782.143964163824, 7783.494072885244, 5288.894222115613, 5434.10337294342, 5815.738291776795, 5986.341502434641, 5986.760529578943, 6530.804075877541, 6746.190457145174, 6760.526763126731, 6823.112995310578, 6886.724531018703, 5915.526757859447, 6014.939850601438, 6042.123892035543, 6081.787137450345, 6191.318954914866, 6076.605020673642, 6108.17539632144, 6143.907841382472, 6164.47601953839, 6167.321594624677, 5499.3675727291875, 5571.387147413862, 5594.944050559442, 5599.692016939108, 5620.0, 4169.207850508394, 4191.664666826708, 4193.454850869368, 4261.786910654517, 4305.74165550068, 4362.563743625612, 4393.692441529062, 4436.245838207577, 4526.751028693322, 4581.152486789954], "value": 3827.2584309369004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.1361063315129, 351.53246182577175, 352.5821901047259, 359.67090112546987, 362.19592504639706, 4812.254100614402, 4883.438404583474, 4888.095702295073, 4900.240462728283, 4921.129970611171, 4583.495815460305, 4621.4223222097235, 4720.929186062212, 4754.690945088567, 4838.34682317887, 3853.7109716771215, 3865.845366185363, 3869.400242962331, 3885.630865067821, 3900.9804950975204, 3865.9226815463676, 3867.3038853006447, 3874.1089549403514, 3875.8449662013486, 3893.415987601854, 3699.1491956849804, 3749.4188400797784, 3787.008263471868, 3823.5794062653226, 3861.710371722118, 3820.2932457495453, 3838.213166300902, 3838.2152299181016, 3842.5965273646425, 3850.152966347413, 3458.9654103459147, 3462.9653703462895, 3465.1337165708574, 3466.168119651291, 3479.1997840496574, 4479.46246450428, 4712.811487540494, 4713.34013238147, 4757.78589963449, 4776.832810851603, 4154.504378423765, 4250.342366477076, 4261.914761704748, 4268.9573104268875, 4274.5939135782055, 5044.117279476113, 5046.318746969149, 5077.822276220315, 5086.79652813887, 5121.257417674454, 3592.317459682652, 3601.549806274216, 3606.6393360663988, 3614.1567800421976, 3619.384704600198, 5179.278912510283, 5259.921101183485, 5272.973635131838, 5282.81510147143, 5311.415744268166, 3626.0390996385977, 3635.8727444539845, 3644.1436262478296, 3646.744727869024, 3658.2500587379523, 3682.9079273018388, 3700.648438398348, 3701.9444708329397, 3705.870294539678, 3710.9072273192846, 4201.873943781691, 4279.16556271524, 4309.827606895752, 4322.740635561876, 4324.156789426094, 5041.294218809369, 5048.974755126201, 5056.898862022813, 5077.466865979093, 5082.390113186441, 1228.8648248692637, 1234.8641649418557, 1243.434237421971, 1244.8506179258547, 1246.1526162209602, 810.9229623185788, 823.4688625836302, 832.1470492744985, 852.3394369363792, 855.9572021398906, 4236.597523235288, 4245.27830268855, 4267.466566679165, 4310.956890431055, 4325.286327755948, 4995.70025798446, 5027.497250274943, 5062.316587260746, 5076.36545431821, 5086.338775959101, 4192.895177620523, 4228.505181942669, 4305.375720520569, 4305.526392096866, 4444.888877778081, 2657.734226577327, 2673.318303832549, 2676.812623116402, 2686.2942031809553, 2688.5698288273784, 4725.220338644154, 4744.481765834968, 4744.928826067612, 4751.786169622375, 4787.234042553175, 5066.670666406671, 5161.948380516222, 5198.558122559549, 5223.224103804725, 5224.268602395668, 4695.0, 4722.740249286254, 4741.5021422750115, 4748.6438517111355, 4792.442456201678, 4999.225120106389, 5016.824411145592, 5030.0, 5038.39539255277, 5038.39539255277, 4746.833860814855, 4916.115099282163, 4926.704397736147, 4972.602191824718, 4996.400431948189, 4719.622430205507, 4744.4069491313585, 4745.4542727585385, 4760.357351757469, 4763.356946812136, 3513.947290790691, 3516.3648903260105, 3518.718502519741, 3519.454484554898, 3526.7002304803354, 4840.636952228527, 5037.57180639635, 5041.773120209673, 5072.137736584716, 5146.511081447256, 4868.391451068616, 4888.90222195547, 4892.706437613754, 4907.4847141051105, 4926.433460152129, 4882.145624515767, 4887.828925987716, 4888.266759986031, 4915.016996600622, 4915.878417205172, 4585.931211031904, 4840.7337596432535, 4849.927251091166, 4850.902981940271, 4852.975735121443, 4872.3909511311085, 4874.756262186947, 4884.48712885142, 4891.364122664173, 4907.509249075064, 4746.762661866962, 4747.362160054776, 4758.762061896822, 4787.329773831736, 4804.543568361], "value": 3772.525031716752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.4790115808512, 678.0744284052267, 720.3696765330336, 723.5875550935968, 740.4076738609114, 12846.16499927504, 14049.648758781035, 14105.78841317381, 14187.503437379693, 14213.78679319811, 13279.336033198326, 13502.864971350284, 13512.256825874572, 13516.256605886672, 13531.391087401065, 642.9003504456816, 664.8404382948106, 791.3273717340272, 791.6516732637635, 820.7373640435063, 798.5887268056955, 800.4636893281486, 802.297989259398, 803.8713805791075, 804.2721337189823, 848.9151084891523, 852.526847599582, 854.5129276312505, 854.8162145138793, 854.9658013679476, 692.5463821197098, 710.2719712294887, 713.53263612334, 718.0700992215094, 855.0765173612483, 613.1324176290543, 633.7971849008319, 637.0985056145548, 638.6966191059256, 640.9006603976391, 12461.0, 12531.18547294432, 12536.937315313366, 12542.874571254262, 12547.24716517012, 12865.935670321589, 12867.485300587965, 12963.805542916863, 12968.740625187444, 13039.0, 12001.879981200163, 12066.457009434596, 12129.514819407214, 12304.692382690415, 12409.62771116868, 3200.679932006804, 3220.066180807563, 3354.8322583870954, 4079.9592004079877, 4090.1615168890307, 61758.0, 62499.0, 62755.6862215686, 62819.99999999954, 63042.68478657623, 9983.582245016318, 10159.136473399696, 10192.847107293397, 10250.128739057114, 10867.619633312795, 19971.60056798856, 20146.69779953302, 20180.09189586472, 20427.080781364875, 20427.182912683325, 6459.644719540376, 6473.805785826338, 6548.967255163694, 6557.836054098686, 6614.437772789367, 3509.3858574749315, 3532.91167720809, 3542.4509201073874, 3554.0581745837376, 3604.044928094057, 2828.5191517442086, 2868.780768173518, 2894.435585060935, 2898.840563769013, 2913.0, 503.2777963622214, 508.265556271192, 511.2816492827509, 511.6392942975268, 514.8841510660146, 584.4885724990634, 596.6420147911306, 596.7076132694948, 604.4759054711025, 607.5534482155612, 8308.086110527836, 8534.87197692035, 8565.571721413904, 8983.146601072887, 9331.766705832408, 562.5599459306394, 585.3824215452738, 587.2102022779355, 590.7666471743637, 596.9850753731191, 3995.1011022520283, 4087.734297270668, 4132.979335103365, 4138.751674899516, 4252.107057517956, 63315.0, 64275.35724642787, 65064.67467662632, 65823.34176658269, 66626.33373666299, 45981.160753570155, 47187.0, 47415.52584474111, 56043.0, 56245.43754562484, 38931.0, 39163.0, 39500.0, 41566.79216603837, 44970.550294497945, 9140.63437462494, 9822.410655360702, 9830.4101753895, 9900.653477128266, 9906.207503399855, 35741.0, 36126.01306928144, 36193.0, 36484.27031459409, 37366.626333737404, 40897.59102408938, 42227.788861055495, 42270.36594451024, 43331.78334108309, 45201.80179279293, 10664.413457259925, 10906.72733181645, 10990.450477476254, 11018.834717479083, 11051.502682379472, 12362.814557781461, 12508.499660013862, 12556.623301300975, 12713.55502557406, 13459.05786594968, 11731.35477548743, 11747.823782643438, 11956.099939304322, 12143.14997950135, 12309.93845030769, 12002.519899203933, 12049.397530123633, 12073.0, 12445.875541244472, 12810.0, 11292.604758833402, 11323.32060076398, 11980.520779168735, 12022.939885300517, 12047.0, 9214.677486288216, 9318.906810932074, 9580.904190958001, 9903.0, 9998.300118991892, 9829.262805289489, 10292.279540432099, 10296.742581435225, 10302.536385862504, 10343.84484232722], "value": 6299.81072662809, "unit": "score"}], "name": "dromaeo_css", "value": 6329.608636907289, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 117.0, 116.0, 113.0, 114.0, 115.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 124.0, 177.0, 126.0, 127.0, 124.0, 124.0, 144.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 76.0, 76.0, 84.0, 76.0, 94.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 86.0, 84.0, 85.0, 110.0, 85.0, 86.0, 111.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 60.0, 61.0, 63.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 69.0, 67.0, 67.0, 83.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 85.0, 85.0, 85.0, 86.0, 90.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 131.0, 140.0, 139.0, 133.0, 130.0, 131.0, 180.0, 139.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 177.0, 172.0, 178.0, 175.0, 172.0, 175.0, 176.0, 172.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 72.0, 67.0, 75.0, 68.0, 68.0, 69.0, 66.0, 65.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1546.2999999999997, "alertThreshold": 2.0}]} 03:18:41 INFO - Return code: 0 03:18:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:41 INFO - # TBPL SUCCESS # 03:18:41 INFO - Running post-action listener: _resource_record_post_action 03:18:41 INFO - [mozharness: 2017-01-13 11:18:41.180274Z] Finished run-tests step (success) 03:18:41 INFO - Running post-run listener: _resource_record_post_run 03:18:41 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390590464; Read time: 8; Write time: 414788 03:18:41 INFO - TinderboxPrint: CPU usage
13.1% 03:18:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:18:41 INFO - TinderboxPrint: I/O write bytes / time
390,590,464 / 414,788 03:18:41 INFO - TinderboxPrint: CPU idle
8,325.0 (86.8%) 03:18:41 INFO - TinderboxPrint: CPU user
1,214.8 (12.7%) 03:18:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:18:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106483712; Read time: 0; Write time: 134860 03:18:41 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 282910720; Read time: 0; Write time: 279924 03:18:41 INFO - Running post-run listener: _upload_blobber_files 03:18:41 INFO - Blob upload gear active. 03:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:41 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:18:41 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:18:41 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:18:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:43 INFO - (blobuploader) - INFO - Done attempting. 03:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:44 INFO - (blobuploader) - INFO - Done attempting. 03:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:48 INFO - (blobuploader) - INFO - Done attempting. 03:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:49 INFO - (blobuploader) - INFO - Done attempting. 03:18:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:49 INFO - Return code: 0 03:18:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee1d8b758d189a3c4645c2f8e4719bd62d8a40dfd7048472b522f6291c0eee4b2a7d61daff1c6892f31abb12ed7a16920a576f7cf4c944dad46f5d96925ec034", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/86fc759d47e2af94c5f4f0c68423d6dfbd7c509b309f2822b40be669f3ca2fef79ac55ce3b8fd9758821394ff598daea43f97f74e47fee10be49d7da7dd9bb7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2173d446c81f40d567f7ceaaa6d9388bed1c7ec647f0392c122db7c10dcc3ed1bcdacd64a52b54328532e445ae3bde936b2ccdc79b83ea7d8fa73e2fcc9fb64c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fea3591de6f49b4a48a45fd77bc018932e73f652e05bed57be3cb75eaaada5995da74f68d445135784ab84ed00265c398e317451581b6e5bd8aa48e51eea39a1"} 03:18:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:49 INFO - Contents: 03:18:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee1d8b758d189a3c4645c2f8e4719bd62d8a40dfd7048472b522f6291c0eee4b2a7d61daff1c6892f31abb12ed7a16920a576f7cf4c944dad46f5d96925ec034", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/86fc759d47e2af94c5f4f0c68423d6dfbd7c509b309f2822b40be669f3ca2fef79ac55ce3b8fd9758821394ff598daea43f97f74e47fee10be49d7da7dd9bb7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2173d446c81f40d567f7ceaaa6d9388bed1c7ec647f0392c122db7c10dcc3ed1bcdacd64a52b54328532e445ae3bde936b2ccdc79b83ea7d8fa73e2fcc9fb64c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fea3591de6f49b4a48a45fd77bc018932e73f652e05bed57be3cb75eaaada5995da74f68d445135784ab84ed00265c398e317451581b6e5bd8aa48e51eea39a1"} 03:18:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:49 INFO - Copying logs to upload dir... 03:18:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.711230 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-13 03:18:48.628973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:18:48.632639) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 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/ee1d8b758d189a3c4645c2f8e4719bd62d8a40dfd7048472b522f6291c0eee4b2a7d61daff1c6892f31abb12ed7a16920a576f7cf4c944dad46f5d96925ec034", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/86fc759d47e2af94c5f4f0c68423d6dfbd7c509b309f2822b40be669f3ca2fef79ac55ce3b8fd9758821394ff598daea43f97f74e47fee10be49d7da7dd9bb7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2173d446c81f40d567f7ceaaa6d9388bed1c7ec647f0392c122db7c10dcc3ed1bcdacd64a52b54328532e445ae3bde936b2ccdc79b83ea7d8fa73e2fcc9fb64c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fea3591de6f49b4a48a45fd77bc018932e73f652e05bed57be3cb75eaaada5995da74f68d445135784ab84ed00265c398e317451581b6e5bd8aa48e51eea39a1"} build_url:https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011929 build_url: 'https://queue.taskcluster.net/v1/task/CJavl6s2Rpu0ABQRf_rIMA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee1d8b758d189a3c4645c2f8e4719bd62d8a40dfd7048472b522f6291c0eee4b2a7d61daff1c6892f31abb12ed7a16920a576f7cf4c944dad46f5d96925ec034", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/86fc759d47e2af94c5f4f0c68423d6dfbd7c509b309f2822b40be669f3ca2fef79ac55ce3b8fd9758821394ff598daea43f97f74e47fee10be49d7da7dd9bb7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2173d446c81f40d567f7ceaaa6d9388bed1c7ec647f0392c122db7c10dcc3ed1bcdacd64a52b54328532e445ae3bde936b2ccdc79b83ea7d8fa73e2fcc9fb64c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fea3591de6f49b4a48a45fd77bc018932e73f652e05bed57be3cb75eaaada5995da74f68d445135784ab84ed00265c398e317451581b6e5bd8aa48e51eea39a1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:18:48.658388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:18:48.658718) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1484305080.82626-1236974402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:18:48.742075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:18:48.742400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:18:48.742692) ========= ========= Total master_lag: 0.15 =========