builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1488754885.38 results: success (0) revision: 69efeba94b307f236a50a9e5fdd2bbd2e946657b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.381965) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.382435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.382744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.426357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.426740) ========= 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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-05 15:01:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-03-05 15:01:26 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.307279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.750086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.750432) ========= 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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020958 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:25.803085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 15:01:25.803873) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69efeba94b307f236a50a9e5fdd2bbd2e946657b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69efeba94b307f236a50a9e5fdd2bbd2e946657b --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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-05 15:01:26,598 truncating revision to first 12 chars 2017-03-05 15:01:26,598 Setting DEBUG logging. 2017-03-05 15:01:26,598 attempt 1/10 2017-03-05 15:01:26,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/69efeba94b30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 15:01:28,390 unpacking tar archive at: mozilla-aurora-69efeba94b30/testing/mozharness/ program finished with exit code 0 elapsedTime=2.131432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 15:01:27.950844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:27.951252) ========= script_repo_revision: 69efeba94b307f236a50a9e5fdd2bbd2e946657b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:27.951686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:27.951986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 15:01:27.961674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-03-05 15:01:27.962140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 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', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] 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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:28 INFO - MultiFileLogger online at 20170305 15:01:28 in /builds/slave/test 15:01:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 15:01:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:28 INFO - {'append_to_log': False, 15:01:28 INFO - 'base_work_dir': '/builds/slave/test', 15:01:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 15:01:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:28 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 15:01:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:28 INFO - 'config_files': ('talos/linux_config.py',), 15:01:28 INFO - 'default_actions': ('clobber', 15:01:28 INFO - 'read-buildbot-config', 15:01:28 INFO - 'download-and-extract', 15:01:28 INFO - 'populate-webroot', 15:01:28 INFO - 'create-virtualenv', 15:01:28 INFO - 'install', 15:01:28 INFO - 'run-tests'), 15:01:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:28 INFO - 'download_minidump_stackwalk': True, 15:01:28 INFO - 'download_symbols': 'ondemand', 15:01:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:28 INFO - 'installer_path': 'installer.exe', 15:01:28 INFO - 'log_level': 'info', 15:01:28 INFO - 'log_name': 'talos', 15:01:28 INFO - 'log_to_console': True, 15:01:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:28 INFO - 'opt_config_files': (), 15:01:28 INFO - 'pip_index': False, 15:01:28 INFO - 'sps_profile': False, 15:01:28 INFO - 'sps_profile_interval': 0, 15:01:28 INFO - 'suite': 'dromaeojs', 15:01:28 INFO - 'system_bits': '32', 15:01:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:28 INFO - 'title': 'talos-linux64-ix-029', 15:01:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:28 INFO - 'use_talos_json': True, 15:01:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:28 INFO - 'work_dir': 'build'} 15:01:28 INFO - [mozharness: 2017-03-05 23:01:28.857325Z] Running clobber step. 15:01:28 INFO - Running pre-action listener: _resource_record_pre_action 15:01:28 INFO - Running main action method: clobber 15:01:28 INFO - rmtree: /builds/slave/test/build 15:01:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:29 INFO - Running post-action listener: _resource_record_post_action 15:01:29 INFO - [mozharness: 2017-03-05 23:01:29.773121Z] Finished clobber step (success) 15:01:29 INFO - [mozharness: 2017-03-05 23:01:29.773222Z] Running read-buildbot-config step. 15:01:29 INFO - Running pre-action listener: _resource_record_pre_action 15:01:29 INFO - Running main action method: read_buildbot_config 15:01:29 INFO - Using buildbot properties: 15:01:29 INFO - { 15:01:29 INFO - "project": "", 15:01:29 INFO - "product": "firefox", 15:01:29 INFO - "who": "ryanvm@gmail.com", 15:01:29 INFO - "installer_path": "public/build/target.tar.bz2", 15:01:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:01:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:01:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 15:01:29 INFO - "stage_platform": "linux64", 15:01:29 INFO - "basedir": "/builds/slave/test", 15:01:29 INFO - "buildnumber": 63, 15:01:29 INFO - "platform": "ubuntu64_hw", 15:01:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:01:29 INFO - "slavebuilddir": "test", 15:01:29 INFO - "taskId": "B8tyT8cuR_6RX6GRaAPCNw", 15:01:29 INFO - "branch": "mozilla-aurora", 15:01:29 INFO - "script_repo_revision": "production", 15:01:29 INFO - "revision": "69efeba94b307f236a50a9e5fdd2bbd2e946657b", 15:01:29 INFO - "slavename": "talos-linux64-ix-029", 15:01:29 INFO - "repo_path": "releases/mozilla-aurora" 15:01:29 INFO - } 15:01:29 INFO - Finding installer, test and symbols from parent task. 15:01:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8tyT8cuR_6RX6GRaAPCNw'}, attempt #1 15:01:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8tyT8cuR_6RX6GRaAPCNw'}, attempt #1 15:01:30 INFO - Task dependencies: WNhDJLyjSmOIcauImldpIg 15:01:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg'}, attempt #1 15:01:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 15:01:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/test_packages.json 15:01:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.crashreporter-symbols.zip 15:01:31 INFO - Running post-action listener: _resource_record_post_action 15:01:31 INFO - [mozharness: 2017-03-05 23:01:31.161959Z] Finished read-buildbot-config step (success) 15:01:31 INFO - [mozharness: 2017-03-05 23:01:31.162270Z] Running download-and-extract step. 15:01:31 INFO - Running pre-action listener: _resource_record_pre_action 15:01:31 INFO - Running main action method: download_and_extract 15:01:31 INFO - mkdir: /builds/slave/test/build/tests 15:01: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')]} 15:01:31 INFO - trying https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.test_packages.json 15:01:31 INFO - Downloading https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:01:31 INFO - Downloaded 896 bytes. 15:01:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:01:31 INFO - Using the following test package requirements: 15:01:31 INFO - {u'common': [u'target.common.tests.zip'], 15:01:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:01:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:01:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:01:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:01:31 INFO - u'mozbase': [u'target.common.tests.zip'], 15:01:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:01:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:01:31 INFO - u'web-platform': [u'target.common.tests.zip', 15:01:31 INFO - u'target.web-platform.tests.zip'], 15:01:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:01:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:01:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip 15:01:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:01:31 INFO - Fetch https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip into memory 15:01:32 INFO - Expected file size: 21861318 15:01:32 INFO - Obtained file size: 21861318 15:01:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:01:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip 15:01:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:01:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.common.tests.zip into memory 15:01:37 INFO - Expected file size: 21861318 15:01:37 INFO - Obtained file size: 21861318 15:01:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.talos.tests.zip 15:01:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:01:42 INFO - Fetch https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.talos.tests.zip into memory 15:01:43 INFO - Expected file size: 14403650 15:01:43 INFO - Obtained file size: 14403650 15:01:44 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')]} 15:01:44 INFO - trying https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 15:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:01:46 INFO - Downloaded 66227492 bytes. 15:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 15:01:46 INFO - mkdir: /builds/slave/test/properties 15:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:46 INFO - Contents: 15:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 15:01:46 INFO - Running post-action listener: _resource_record_post_action 15:01:46 INFO - Running post-action listener: set_extra_try_arguments 15:01:46 INFO - [mozharness: 2017-03-05 23:01:46.563469Z] Finished download-and-extract step (success) 15:01:46 INFO - [mozharness: 2017-03-05 23:01:46.563630Z] Running populate-webroot step. 15:01:46 INFO - Running pre-action listener: _resource_record_pre_action 15:01:46 INFO - Running main action method: populate_webroot 15:01:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:46 INFO - '--tppagecycles', 15:01:46 INFO - '7'], 15:01:46 INFO - 'tests': ['tsvgm']}}, 15:01:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['damp', 'tps']}, 15:01:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'tests': ['damp', 'tps']}, 15:01:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['dromaeo_dom']}, 15:01:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['basic_compositor_video']}, 15:01:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['tsvgx', 15:01:46 INFO - 'tsvgr_opacity', 15:01:46 INFO - 'tart', 15:01:46 INFO - 'tscrollx', 15:01:46 INFO - 'cart', 15:01:46 INFO - 'tsvg_static']}, 15:01:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:46 INFO - 'tsvgr_opacity', 15:01:46 INFO - 'tart', 15:01:46 INFO - 'tscrollx', 15:01:46 INFO - 'cart', 15:01:46 INFO - 'tsvg_static']}, 15:01:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-e10s'], 15:01:46 INFO - 'tests': ['tp5o']}, 15:01:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-e10s', 15:01:46 INFO - '--xperf_path', 15:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:46 INFO - 'tests': ['tp5n']}, 15:01:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--xperf_path', 15:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:46 INFO - 'tests': ['tp5n']}}, 15:01:46 INFO - 'talos.zip': {'path': '', 15:01:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:46 INFO - Running post-action listener: _resource_record_post_action 15:01:46 INFO - [mozharness: 2017-03-05 23:01:46.577685Z] Finished populate-webroot step (success) 15:01:46 INFO - [mozharness: 2017-03-05 23:01:46.577774Z] Running create-virtualenv step. 15:01:46 INFO - Running pre-action listener: _resource_record_pre_action 15:01:46 INFO - Running main action method: create_virtualenv 15:01:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:46 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 15:01:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:46 INFO - Using real prefix '/usr' 15:01:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:49 INFO - Installing pip.................done. 15:01:49 INFO - Return code: 0 15:01:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:49 INFO - Reading from file tmpfile_stdout 15:01:49 INFO - Output received: 15:01:49 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) 15:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:49 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 15:01:49 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 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:49 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 15:01:49 INFO - Cleaning up... 15:01:49 INFO - Return code: 0 15:01:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:49 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 15:01:49 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 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:49 INFO - Downloading/unpacking psutil>=3.1.1 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:51 INFO - Installing collected packages: psutil 15:01:51 INFO - Running setup.py install for psutil 15:01:51 INFO - building 'psutil._psutil_linux' extension 15:01:51 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 15:01:52 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 15:01:52 INFO - building 'psutil._psutil_posix' extension 15:01:52 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 15:01:52 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 15:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:52 INFO - Successfully installed psutil 15:01:52 INFO - Cleaning up... 15:01:52 INFO - Return code: 0 15:01:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:52 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')]} 15:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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')]} 15:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:52 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 15:01:52 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 15:01:52 INFO - Using env: {'DISPLAY': ':0', 15:01:52 INFO - 'HOME': '/home/cltbld', 15:01:52 INFO - 'LANG': 'en_US.UTF-8', 15:01:52 INFO - 'LANGUAGE': 'en_US:en', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MAIL': '/var/mail/cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SHLVL': '1', 15:01:52 INFO - 'TERM': 'linux', 15:01:52 INFO - 'TMOUT': '86400', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - '_': '/tools/buildbot/bin/python'} 15:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:54 INFO - Installing collected packages: mozsystemmonitor 15:01:54 INFO - Running setup.py install for mozsystemmonitor 15:01:54 INFO - Successfully installed mozsystemmonitor 15:01:54 INFO - Cleaning up... 15:01:54 INFO - Return code: 0 15:01:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:54 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')]} 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 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')]} 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:54 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 15:01:54 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 15:01:54 INFO - Using env: {'DISPLAY': ':0', 15:01:54 INFO - 'HOME': '/home/cltbld', 15:01:54 INFO - 'LANG': 'en_US.UTF-8', 15:01:54 INFO - 'LANGUAGE': 'en_US:en', 15:01:54 INFO - 'LOGNAME': 'cltbld', 15:01:54 INFO - 'MAIL': '/var/mail/cltbld', 15:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:54 INFO - 'MOZ_NO_REMOTE': '1', 15:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:54 INFO - 'NO_EM_RESTART': '1', 15:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:54 INFO - 'PWD': '/builds/slave/test', 15:01:54 INFO - 'SHELL': '/bin/bash', 15:01:54 INFO - 'SHLVL': '1', 15:01:54 INFO - 'TERM': 'linux', 15:01:54 INFO - 'TMOUT': '86400', 15:01:54 INFO - 'USER': 'cltbld', 15:01:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:54 INFO - '_': '/tools/buildbot/bin/python'} 15:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:55 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:55 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 15:01:55 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 15:01:55 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 15:01:55 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 15:01:55 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 15:01:55 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 15:01:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:57 INFO - warning: no files found matching '*.txt' 15:01:57 INFO - no previously-included directories found matching 'build' 15:01:57 INFO - no previously-included directories found matching 'dist' 15:01:57 INFO - no previously-included directories found matching '.git*' 15:01:57 INFO - Installing collected packages: jsonschema, functools32 15:01:57 INFO - Running setup.py install for functools32 15:01:57 INFO - warning: no files found matching '*.txt' 15:01:57 INFO - no previously-included directories found matching 'build' 15:01:57 INFO - no previously-included directories found matching 'dist' 15:01:57 INFO - no previously-included directories found matching '.git*' 15:01:57 INFO - Successfully installed jsonschema functools32 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:57 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')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:57 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 15:01:57 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 15:01:57 INFO - Using env: {'DISPLAY': ':0', 15:01:57 INFO - 'HOME': '/home/cltbld', 15:01:57 INFO - 'LANG': 'en_US.UTF-8', 15:01:57 INFO - 'LANGUAGE': 'en_US:en', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MAIL': '/var/mail/cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SHLVL': '1', 15:01:57 INFO - 'TERM': 'linux', 15:01:57 INFO - 'TMOUT': '86400', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - '_': '/tools/buildbot/bin/python'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:57 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')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:01:57 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 15:01:57 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 15:01:57 INFO - Using env: {'DISPLAY': ':0', 15:01:57 INFO - 'HOME': '/home/cltbld', 15:01:57 INFO - 'LANG': 'en_US.UTF-8', 15:01:57 INFO - 'LANGUAGE': 'en_US:en', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MAIL': '/var/mail/cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SHLVL': '1', 15:01:57 INFO - 'TERM': 'linux', 15:01:57 INFO - 'TMOUT': '86400', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - '_': '/tools/buildbot/bin/python'} 15:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:58 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 15:01:58 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 15:01:58 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 15:01:58 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 15:01:58 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 15:01:58 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 15:02:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 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 15:02:00 INFO - Downloading docopt-0.6.1.tar.gz 15:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:00 INFO - Running setup.py install for blobuploader 15:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:00 INFO - Running setup.py install for requests 15:02:01 INFO - Running setup.py install for docopt 15:02:01 INFO - Successfully installed blobuploader requests docopt 15:02:01 INFO - Cleaning up... 15:02:01 INFO - Return code: 0 15:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:02:01 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 15:02:01 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 15:02:01 INFO - Using env: {'DISPLAY': ':0', 15:02:01 INFO - 'HOME': '/home/cltbld', 15:02:01 INFO - 'LANG': 'en_US.UTF-8', 15:02:01 INFO - 'LANGUAGE': 'en_US:en', 15:02:01 INFO - 'LOGNAME': 'cltbld', 15:02:01 INFO - 'MAIL': '/var/mail/cltbld', 15:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:01 INFO - 'MOZ_NO_REMOTE': '1', 15:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:01 INFO - 'NO_EM_RESTART': '1', 15:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:01 INFO - 'PWD': '/builds/slave/test', 15:02:01 INFO - 'SHELL': '/bin/bash', 15:02:01 INFO - 'SHLVL': '1', 15:02:01 INFO - 'TERM': 'linux', 15:02:01 INFO - 'TMOUT': '86400', 15:02:01 INFO - 'USER': 'cltbld', 15:02:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:01 INFO - '_': '/tools/buildbot/bin/python'} 15:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:01 INFO - Running setup.py (path:/tmp/pip-a8Y55z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:01 INFO - Running setup.py (path:/tmp/pip-6FYO2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:01 INFO - Running setup.py (path:/tmp/pip-7L7k9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:01 INFO - Running setup.py (path:/tmp/pip-rxrC2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:01 INFO - Running setup.py (path:/tmp/pip-gE1Y85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:02 INFO - Running setup.py (path:/tmp/pip-JvXNs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:02 INFO - Running setup.py (path:/tmp/pip-fFSV1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:02 INFO - Running setup.py (path:/tmp/pip-vk70r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:02 INFO - Running setup.py (path:/tmp/pip-c4QWnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:02 INFO - Running setup.py (path:/tmp/pip-w4gixt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:02 INFO - Running setup.py (path:/tmp/pip-zuNMOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:02 INFO - Running setup.py (path:/tmp/pip-qC4F0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:02 INFO - Running setup.py (path:/tmp/pip-kHcVi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:02 INFO - Running setup.py (path:/tmp/pip-NHmhdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:02 INFO - Running setup.py (path:/tmp/pip-DN8eV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:02 INFO - Running setup.py (path:/tmp/pip-95SZPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:02 INFO - Running setup.py (path:/tmp/pip-zfS4PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:02 INFO - Running setup.py install for manifestparser 15:02:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for mozcrash 15:02:03 INFO - Running setup.py install for mozdebug 15:02:03 INFO - Running setup.py install for mozdevice 15:02:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for mozfile 15:02:03 INFO - Running setup.py install for mozhttpd 15:02:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for mozinfo 15:02:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for mozInstall 15:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for mozleak 15:02:03 INFO - Running setup.py install for mozlog 15:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:03 INFO - Running setup.py install for moznetwork 15:02:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Running setup.py install for mozprocess 15:02:04 INFO - Running setup.py install for mozprofile 15:02:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Running setup.py install for mozrunner 15:02:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Running setup.py install for mozscreenshot 15:02:04 INFO - Running setup.py install for moztest 15:02:04 INFO - Running setup.py install for mozversion 15:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:04 INFO - Cleaning up... 15:02:04 INFO - Return code: 0 15:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:04 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:02:04 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 15:02:04 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 15:02:04 INFO - Using env: {'DISPLAY': ':0', 15:02:04 INFO - 'HOME': '/home/cltbld', 15:02:04 INFO - 'LANG': 'en_US.UTF-8', 15:02:04 INFO - 'LANGUAGE': 'en_US:en', 15:02:04 INFO - 'LOGNAME': 'cltbld', 15:02:04 INFO - 'MAIL': '/var/mail/cltbld', 15:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:04 INFO - 'MOZ_NO_REMOTE': '1', 15:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:04 INFO - 'NO_EM_RESTART': '1', 15:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:04 INFO - 'PWD': '/builds/slave/test', 15:02:04 INFO - 'SHELL': '/bin/bash', 15:02:04 INFO - 'SHLVL': '1', 15:02:04 INFO - 'TERM': 'linux', 15:02:04 INFO - 'TMOUT': '86400', 15:02:04 INFO - 'USER': 'cltbld', 15:02:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:04 INFO - '_': '/tools/buildbot/bin/python'} 15:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:04 INFO - Running setup.py (path:/tmp/pip-3enDAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:05 INFO - Running setup.py (path:/tmp/pip-bluFpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:05 INFO - Running setup.py (path:/tmp/pip-nS8uwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:05 INFO - Running setup.py (path:/tmp/pip-4CgzkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:05 INFO - Running setup.py (path:/tmp/pip-86AVhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:05 INFO - Running setup.py (path:/tmp/pip-xlVBSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:05 INFO - Running setup.py (path:/tmp/pip-clr8Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:05 INFO - Running setup.py (path:/tmp/pip-jzTM0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:05 INFO - Running setup.py (path:/tmp/pip-S1DrQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:05 INFO - Running setup.py (path:/tmp/pip-4UNlph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:05 INFO - Running setup.py (path:/tmp/pip-F1xfbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:05 INFO - Running setup.py (path:/tmp/pip-U0wyan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:05 INFO - Running setup.py (path:/tmp/pip-FgUQLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:05 INFO - Running setup.py (path:/tmp/pip-dkbuKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:05 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)) 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:05 INFO - Running setup.py (path:/tmp/pip-MZTkTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:06 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)) 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:06 INFO - Running setup.py (path:/tmp/pip-97tJ3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:06 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)) 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:06 INFO - Running setup.py (path:/tmp/pip-K_xwYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:06 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)) 15:02:06 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)) 15:02:06 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)) 15:02:06 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)) 15:02:06 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)) 15:02:06 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)) 15:02:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:06 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 15:02:06 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 15:02:06 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 15:02:06 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 15:02:06 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 15:02:06 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 15:02:08 INFO - Downloading blessings-1.6.tar.gz 15:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:08 INFO - Installing collected packages: blessings 15:02:08 INFO - Running setup.py install for blessings 15:02:08 INFO - Successfully installed blessings 15:02:08 INFO - Cleaning up... 15:02:08 INFO - Return code: 0 15:02:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:08 INFO - Reading from file tmpfile_stdout 15:02:08 INFO - Current package versions: 15:02:08 INFO - argparse == 1.2.1 15:02:08 INFO - blessings == 1.6 15:02:08 INFO - blobuploader == 1.2.4 15:02:08 INFO - docopt == 0.6.1 15:02:08 INFO - functools32 == 3.2.3-2 15:02:08 INFO - jsonschema == 2.5.1 15:02:08 INFO - manifestparser == 1.1 15:02:08 INFO - mozInstall == 1.12 15:02:08 INFO - mozcrash == 1.0 15:02:08 INFO - mozdebug == 0.1 15:02:08 INFO - mozdevice == 0.49 15:02:08 INFO - mozfile == 1.2 15:02:08 INFO - mozhttpd == 0.7 15:02:08 INFO - mozinfo == 0.9 15:02:08 INFO - mozleak == 0.1 15:02:08 INFO - mozlog == 3.4 15:02:08 INFO - moznetwork == 0.27 15:02:08 INFO - mozprocess == 0.24 15:02:08 INFO - mozprofile == 0.28 15:02:08 INFO - mozrunner == 6.13 15:02:08 INFO - mozscreenshot == 0.1 15:02:08 INFO - mozsystemmonitor == 0.3 15:02:08 INFO - moztest == 0.8 15:02:08 INFO - mozversion == 1.4 15:02:08 INFO - psutil == 3.1.1 15:02:08 INFO - requests == 1.2.3 15:02:08 INFO - wsgiref == 0.1.2 15:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:08 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:02:08 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 15:02:08 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 15:02:08 INFO - Using env: {'DISPLAY': ':0', 15:02:08 INFO - 'HOME': '/home/cltbld', 15:02:08 INFO - 'LANG': 'en_US.UTF-8', 15:02:08 INFO - 'LANGUAGE': 'en_US:en', 15:02:08 INFO - 'LOGNAME': 'cltbld', 15:02:08 INFO - 'MAIL': '/var/mail/cltbld', 15:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:08 INFO - 'MOZ_NO_REMOTE': '1', 15:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:08 INFO - 'NO_EM_RESTART': '1', 15:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:08 INFO - 'PWD': '/builds/slave/test', 15:02:08 INFO - 'SHELL': '/bin/bash', 15:02:08 INFO - 'SHLVL': '1', 15:02:08 INFO - 'TERM': 'linux', 15:02:08 INFO - 'TMOUT': '86400', 15:02:08 INFO - 'USER': 'cltbld', 15:02:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:08 INFO - '_': '/tools/buildbot/bin/python'} 15:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 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)) 15:02:08 INFO - Cleaning up... 15:02:08 INFO - Return code: 0 15:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:09 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 0xc3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', '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 15:02:09 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 15:02:09 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 15:02:09 INFO - Using env: {'DISPLAY': ':0', 15:02:09 INFO - 'HOME': '/home/cltbld', 15:02:09 INFO - 'LANG': 'en_US.UTF-8', 15:02:09 INFO - 'LANGUAGE': 'en_US:en', 15:02:09 INFO - 'LOGNAME': 'cltbld', 15:02:09 INFO - 'MAIL': '/var/mail/cltbld', 15:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:09 INFO - 'MOZ_NO_REMOTE': '1', 15:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:09 INFO - 'NO_EM_RESTART': '1', 15:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:09 INFO - 'PWD': '/builds/slave/test', 15:02:09 INFO - 'SHELL': '/bin/bash', 15:02:09 INFO - 'SHLVL': '1', 15:02:09 INFO - 'TERM': 'linux', 15:02:09 INFO - 'TMOUT': '86400', 15:02:09 INFO - 'USER': 'cltbld', 15:02:09 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:09 INFO - '_': '/tools/buildbot/bin/python'} 15:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:02:09 INFO - Cleaning up... 15:02:09 INFO - Return code: 0 15:02:09 INFO - Running post-action listener: _resource_record_post_action 15:02:09 INFO - Running post-action listener: _start_resource_monitoring 15:02:09 INFO - Starting resource monitoring. 15:02:09 INFO - [mozharness: 2017-03-05 23:02:09.253995Z] Finished create-virtualenv step (success) 15:02:09 INFO - [mozharness: 2017-03-05 23:02:09.254433Z] Running install step. 15:02:09 INFO - Running pre-action listener: _resource_record_pre_action 15:02:09 INFO - Running main action method: install 15:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:09 INFO - Reading from file tmpfile_stdout 15:02:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:09 INFO - Reading from file tmpfile_stdout 15:02:09 INFO - Output received: 15:02:09 INFO - Usage: mozinstall [options] installer 15:02:09 INFO - Options: 15:02:09 INFO - -h, --help show this help message and exit 15:02:09 INFO - -d DEST, --destination=DEST 15:02:09 INFO - Directory to install application into. [default: 15:02:09 INFO - "/builds/slave/test"] 15:02:09 INFO - --app=APP Application being installed. [default: firefox] 15:02:09 INFO - mkdir: /builds/slave/test/build/application 15:02:09 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'] 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:02:26 INFO - Reading from file tmpfile_stdout 15:02:26 INFO - Output received: 15:02:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:26 INFO - Running post-action listener: _resource_record_post_action 15:02:26 INFO - [mozharness: 2017-03-05 23:02:26.027708Z] Finished install step (success) 15:02:26 INFO - [mozharness: 2017-03-05 23:02:26.027858Z] Running run-tests step. 15:02:26 INFO - Running pre-action listener: _resource_record_pre_action 15:02:26 INFO - Running main action method: run_tests 15:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:26 INFO - Python 2.7.3 15:02:26 INFO - Return code: 0 15:02:26 INFO - grabbing minidump binary from tooltool 15:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:26 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 0xfa9d00>, '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 0xfaaa00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:26 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 15:02:26 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 15:02:26 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 15:02:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:26 INFO - Return code: 0 15:02:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 15:02:26 INFO - Using env: {'DISPLAY': ':0', 15:02:26 INFO - 'HOME': '/home/cltbld', 15:02:26 INFO - 'LANG': 'en_US.UTF-8', 15:02:26 INFO - 'LANGUAGE': 'en_US:en', 15:02:26 INFO - 'LOGNAME': 'cltbld', 15:02:26 INFO - 'MAIL': '/var/mail/cltbld', 15:02:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:26 INFO - 'MOZ_NO_REMOTE': '1', 15:02:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:26 INFO - 'NO_EM_RESTART': '1', 15:02:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:26 INFO - 'PWD': '/builds/slave/test', 15:02:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:26 INFO - 'SHELL': '/bin/bash', 15:02:26 INFO - 'SHLVL': '1', 15:02:26 INFO - 'TERM': 'linux', 15:02:26 INFO - 'TMOUT': '86400', 15:02:26 INFO - 'USER': 'cltbld', 15:02:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487', 15:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:26 INFO - '_': '/tools/buildbot/bin/python'} 15:02:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:02:26 INFO - mozversion application_buildid: 20170305221025 15:02:26 INFO - mozversion application_changeset: 69efeba94b307f236a50a9e5fdd2bbd2e946657b 15:02:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:02:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:26 INFO - mozversion application_name: Firefox 15:02:26 INFO - mozversion application_remotingname: firefox-dev 15:02:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:26 INFO - mozversion application_vendor: Mozilla 15:02:26 INFO - mozversion application_version: 53.0a2 15:02:26 INFO - mozversion platform_buildid: 20170305221025 15:02:26 INFO - mozversion platform_changeset: 69efeba94b307f236a50a9e5fdd2bbd2e946657b 15:02:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:26 INFO - mozversion platform_version: 53.0a2 15:02:26 INFO - using testdate: 1488754946 15:02:26 INFO - actual date: 1488754946 15:02:26 INFO - starting webserver on 'localhost:47084' 15:02:26 INFO - SUITE-START | Running 2 tests 15:02:26 INFO - TEST-START | dromaeo_css 15:02:26 INFO - operating with platform_type : linux_ 15:02:26 INFO - Initialising browser for dromaeo_css test... 15:02:26 INFO - TEST-INFO | started process 19614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUdys3l/profile http://localhost:47084/getInfo.html) 15:02:30 INFO - PROCESS | 19614 | __metrics Screen width/height:1600/1200 15:02:30 INFO - PROCESS | 19614 | colorDepth:24 15:02:30 INFO - PROCESS | 19614 | Browser inner width/height: 1024/697 15:02:30 INFO - PROCESS | 19614 | __metrics 15:02:31 INFO - PROCESS | 19614 | 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" 15:02:31 INFO - PROCESS | 19614 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:31 INFO - PROCESS | 19614 | console.error: PushService: 15:02:31 INFO - PROCESS | 19614 | stateChangeProcessEnqueue: Error transitioning state 15:02:31 INFO - PROCESS | 19614 | UnknownError 15:02:32 INFO - TEST-INFO | 19614: exit 0 15:02:32 INFO - Browser initialized. 15:02:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:32 INFO - TEST-INFO | started process 19706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUdys3l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:44 INFO - PROCESS | 19706 | RSS: Main: 138072064 15:02:44 INFO - PROCESS | 19706 | 15:05:44 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47084/tests/dromaeo/cssquery-ext.html) 15:05:45 INFO - PROCESS | 19706 | RSS: Main: 247332864 15:05:45 INFO - PROCESS | 19706 | 15:07:34 INFO - PROCESS | 19706 | ************************* 15:07:34 INFO - PROCESS | 19706 | A coding exception was thrown and uncaught in a Task. 15:07:34 INFO - PROCESS | 19706 | 15:07:34 ERROR - PROCESS | 19706 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:07:34 INFO - PROCESS | 19706 | Full stack: 15:07:34 INFO - PROCESS | 19706 | ************************* 15:08:47 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-ext.html (next: http://localhost:47084/tests/dromaeo/cssquery-jquery.html) 15:08:48 INFO - PROCESS | 19706 | RSS: Main: 223105024 15:08:48 INFO - PROCESS | 19706 | 15:11:50 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47084/tests/dromaeo/cssquery-mootools.html) 15:11:50 INFO - PROCESS | 19706 | RSS: Main: 170246144 15:11:50 INFO - PROCESS | 19706 | 15:14:52 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47084/tests/dromaeo/cssquery-prototype.html) 15:14:53 INFO - PROCESS | 19706 | RSS: Main: 213762048 15:14:53 INFO - PROCESS | 19706 | 15:17:55 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47084/tests/dromaeo/cssquery-yui.html) 15:17:56 INFO - PROCESS | 19706 | RSS: Main: 178630656 15:17:56 INFO - PROCESS | 19706 | 15:20:58 INFO - PROCESS | 19706 | Cycle 1(1): loaded http://localhost:47084/tests/dromaeo/cssquery-yui.html (next: http://localhost:47084/tests/dromaeo/cssquery-dojo.html) 15:20:59 INFO - PROCESS | 19706 | RSS: Main: 262500352 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | __start_tp_report 15:20:59 INFO - PROCESS | 19706 | _x_x_mozilla_page_load 15:20:59 INFO - PROCESS | 19706 | _x_x_mozilla_page_load_details 15:20:59 INFO - PROCESS | 19706 | |i|pagename|runs| 15:20:59 INFO - PROCESS | 19706 | |0;dojo.html;3241.9837900810494;3262.0213935819256;3283.5567198428207;3297.76915615907;3332.9500057499126;5372.086745253311;5443.156310771827;5455.809046683366;5463.508284254416;5490.176473528973;5396.163594642827;5463.672179669213;5464.863378415542;5465.180222966557;5491.945080549193;4974.7015179089185;4988.127077761377;5013.248012798092;5039.47085556015;5086.516780905827;4890.951090489103;4911.778969946343;4934.777934992934;5031.345925029741;5069.340985671857;4942.406911170665;5036.899262014757;5038.143515602356;5053.418856831457;5076.238564215379;5058.342415486;5065.493450654942;5067.746612669352;5076.74616269185;5106.693598384071;4821.204501257288;4849.442314133849;4978;4979.676321039121;5048.419431765357;5291.28567643367;5314.840554783324;5379.784808607651;5425.728713564306;5438.320209973754;5809.7095145242565;5810.796622118248;5811.6222445541325;5819.883602327972;5826.213461182729;5641.661500309994;5703.657780533182;5781.682007489587;5783.479486846204;5840.8247752567495;5408.8377348679605;5416.51251387377;5502.697351645698;5532.114861622121;5536.916946245809;5968.194293770285;5969.343372229051;5970.58205925581;5974.910376344358;5975.55183361241;5530.86172845674;5754.223179870748;5770.19217309577;5772.7113644317615;5772.740226689725;5677.51741102011;5699.829005129853;5724.742386592613;5735.254416925856;5736.655800651891;5711.314642242957;5766.769329226868;5767.538596912237;5768.884622307531;5791.0734282514595;5726.513246374022;5769.1923130761725;5780.653160810365;5786.363500014995;5787.189793428924;4366.039471316305;4393.121375724868;4432.889177770517;4452.109578084396;4505.963628365429;4004.1591265833918;4026.9798651007145;4032.6572241359227;4037.858674946363;4053.7365071270274;5609.943900561024;5617.719114044281;5620.887582248332;5625.156226565966;5625.353084395265;5631.6902570359025;5642.802501912495;5664.405237450091;5687.118496633028;5708;5507.256520369699;5509.889802203934;5513.393526712059;5515.696636685021;5536.390996990328;4894.510548945077;4894.853154405374;4896.6572339935865;4898.093852637274;4919.0899683558655;5793.333766616809;5844.853878653068;5922.763089476459;5938.317093534212;6008.429199226067;5818.8254352369495;5818.883622327615;5839.211706419579;5841;5848.824535263949;6019.578629496068;6067.605605635619;6073.48375388097;6077.878442431038;6081.695915204134;5609;5643.125315576092;5728.0262355398845;5736.110902810071;5736.9673458777825;5649.12438572022;5719.8856022880145;5737.741801618854;5782.363939966516;5784.479396854304;5597.972010139923;5603.35561410443;5606.271184745957;5630.296212973379;5645.491905728504;5465.9726701366235;5511;5613.522850557748;5649.54803615718;5652.88694226105;5459.126539753779;5472.261244731911;5526.696031718133;5588.217649529151;5613.242212301287;5614.943850561605;5626.971865140648;5631;5632.324121105494;5636.070048442125;5423.9694458052845;5459.39946605881;5505.311836020497;5513.3108361454815;5554.361248456479 15:20:59 INFO - PROCESS | 19706 | |1;ext.html;554.5966982372431;575.1143239411307;610.41095342994;618.1068356225256;642.0209180998979;37156.25687486248;48459.515404845944;49495;49538.50461495388;49632;53098.73450632741;53497.1975420368;53501.46498535013;53503.73248133763;53516.46483535163;8723.25852302555;8934.195922366986;9354;9514.238860891111;9540.093691099335;11189.7202569936;11398.316101033923;11427;11925.821112683318;11933.880661193407;11657.067434605253;11737.295762254249;11742.060635149168;11750;11764.882351176464;11499;11579.36313502757;11586.478608462556;11586.594469193538;11596.942015289911;11274.943625281903;11352.091832653368;11354.432278386048;11356.886431135665;11363.715907102305;48610.7569462154;48640.51359486395;48990;49096.26355604669;49101.50898491041;4358.934615980763;4472.910541789179;4473;4485.820567177309;4673.929891051637;33441.49837752436;33469;33534.161645958804;33966.1508462288;34799.304013919835;4634.629229661619;4646.53534646536;4669.182892993713;4723.267893476516;4787.257975013878;362108;363331;363506;364166;366097.9999999973;63042;63154.68422657949;63520.364796351445;63586;63695.681521592094;66542.33457665361;66634.66682666652;66805;66874.33125668779;66877;19506.902465487583;19806.50483737918;19851.702224466644;19861.702074468605;19864.4040678777;13758.105723128165;13917.164970101827;14145.717085658229;14162.787558186636;14172.149671019772;18544.752092723873;19975;20075.096620652104;20927.895360523406;21078.789212107684;7057.4001209896705;7413.406927445792;7458.179600243969;7482.139553951365;7558.924410755932;993.895640957689;1007.1791489935679;1017.4302390661105;1018.8879223285433;1023.5445226873969;34706.305873882884;34935.12662183466;35321.470177947354;35350.46974295388;35433.64566354304;1180.7756526259984;1183.6981569699672;1231.4027696567157;1239.2997956154743;1285.4279845468864;18440.006180562057;18575.44273671792;18583.628327433646;18695.439136825917;18853.434396968114;545619;545998;547230;549044;553243;71351;71925;71930.2806971934;71987.28012719806;72135.63932180306;1510.7960425342437;1512.1078563647281;1541.8920675552604;1547.8761699064273;1583.7307657697988;30635.2341191472;31878;32001.199970000936;32363;32561.837190813894;59396.1090583633;60023.39976600178;60135.39864601473;60174.09738854008;60203.69898150656;416476;418899;419175;419365;419692;27696;28354.85822570874;30404.695953040187;32745;33227.335453291285;53833.730831345594;55179;55438.16842747281;55479.445205547425;55487;44417.555824442636;45715.31427028531;46717.76641116773;46779.29831052469;48858.26712599385;44637.776811115735;45861;45943.540564593925;46048.53951460576;47477.76261118672;44537.55462445334;45383;45937;45952.31071533997;46237.53762462332;37123.62876371202;39887;40580.1883962325;41191;41214;29122;29764.553531697475;30086.398272034;30092;30149.3970120592 15:20:59 INFO - PROCESS | 19706 | |2;jquery.html;438.50448992638314;438.5176306063329;438.9377705951596;441.7283370727003;454.8726356620148;20685.482862928417;21153;22481.437964050907;22551.436214094654;22625;21043.57912841746;21088.89455552724;22492.88753556234;22593.661095083546;22740.772592274072;5958.106284057393;5983.192269043667;6111.174991376174;6140.048292514645;6150.200473938382;5882;5948.256467941507;6098.634081955075;6108.572399932006;6109.541784366168;5884.411558844103;5987.9401205987815;6093.908591371133;6100.603460775058;6100.877982440348;6018.548608854331;6055.9697201514155;6070.757169713184;6071.332153463116;6071.696415179224;5448.046591846451;5466.508014278695;5481.424450432687;5678.261825962599;5713.114467257582;15060.849391506054;15072.321745521478;15124.848751512454;15225.467108651255;15260.847391526053;3064.5862808520787;3105.316830297331;3109.5335699645234;3116.3144108296365;3163.7152656261046;10882.455877206186;10982.395968221745;11074.390908500029;11106.666799996014;11295;1936.9031548422522;1982.6431242376366;1987.8807271563753;2012.0945574491536;2045.233037610896;66081.34600590644;70449.64775176092;92057;93008;99808;10964.671059868217;11339.149563782585;11348.489317980711;11417.372044537464;11430.371329576954;15295.235238238043;15318.617034574225;15361.385544578316;15367.308471118826;15379.538613841603;8671.566421679017;8680.479171249744;8822.911770882338;8967.372283940062;8969.641214351483;8763.334966356371;8779.692710755093;8788.956055219684;8905.688300909567;8945.821083578292;4610.2623580227;4652.232381656989;4697.412823397075;4929.704217746947;5244.29202057725;2128.51044259818;2131.776163502841;2140.636091864387;2189.5511420158828;2216.5456081503253;936.1247233836385;940.8635747816528;949.9335046546813;958.942463452195;968.912797848183;19465.832050077042;20065.097070631855;20957.790422095888;20967.37097887066;20992.475188120417;948.2650945517141;953.4088864903804;957.6791774755395;959.1367769007949;966.5408930757834;10970;11520.596779112859;11590.072794176445;11616.303021818718;11656.70858228534;661283;663312;674888;683728;700707;85148.57425712832;109875.45062274637;110626;112758.43620781843;113278.43360783144;1068.8557044799009;1096.0902450965839;1096.550414330121;1099.8570185875785;1100.664297389304;18522;18669.43991680252;18738.437846864617;18819;19127.426177214707;42758.57241427671;47814.52185478101;48155;48447;48585;62058;62484;62928.685356572925;63622;65695.01457478237;6513.54405191632;7036.683349249399;8418.663253469793;9585.424874507551;9800.411975281506;13423.798643020558;13584.117032392864;13669.863301366859;14238.644033899236;14437.35031923545;12160.209586377212;12177.695557610776;12212.877871221173;12225.266484010632;12296.446659900146;12194.75610487803;12230.082743794428;12258.570950016707;12403.193792403465;12437.875621244033;11654.41727913584;12132.514699411924;12137.757244855231;12239.877601223874;12266.202696824677;8751.91248087511;8812.955935220283;8871.379003469696;8893.64425422976;8949;11184.217104802585;11749.823752643546;11779.587714430296;11954.103442241692;12093.09301802386 15:20:59 INFO - PROCESS | 19706 | |3;mootools.html;1488.538553048555;1506.676064646101;1510.4713350327386;1513.9924300378495;1515.5907904865683;8398.706045288416;9022.639094436223;9026.142516460943;9026.232770214532;9034.72895813125;7902.170272121416;7937.563434011142;7940.40446966477;8283.91716082839;8842.469451832894;2319.9652005219978;2346.718393792747;2373.857568545884;2397.928062158138;2411.3127758588807;2344.2615576093476;2389.3190440724397;2416.9637455438096;2418.9274321770376;2423.8303318767607;2324.3491822289784;2330.8484948478294;2348.2250857217164;2357.422431504284;2359.1860808021206;2358.7287461941837;2373.786359227669;2378;2378.6194208926663;2379.393254720044;2299.4251437140715;2335.135999680112;2342.61346877765;2345.4019225097663;2345.5777959967368;9024.548772561411;9078.68224612142;9092.04533523977;9097.590608422637;9110.86333704995;5113.386393632788;5232.424433312332;5240.659357141773;5244.423113457517;5244.606654500928;3248.447763880146;3329.350776598564;3429.7770644908;3431.9485207721905;3445.3970555153;1368.4662981437248;1375.4704438791136;1397.7903314502805;1407.2752532445697;2145.9463513412134;11304.830427543593;11941.701457463547;12100.39498025104;12112.21270617407;12127.93936030323;4445.333200019958;4530.954690453119;4549.613282870927;4646.117237724821;4648.349231107648;9944.651937182163;10026.598936042477;10034.64878729241;10056.396616203052;10061.346012509164;5346.091164502044;5382.3541175059245;5403.189521571796;5409.350877894678;5410.269613602113;4470.530594287618;4561.521040290788;4909.2881532177635;4942.308076869242;5058.266551350033;4036.6367026967714;4079.3065178919655;4112.403701463331;4113.239050775616;4161.91676166475;1306.5753630070265;1319.491995581708;1331.0416500119898;1334.5195729537359;1335.6327010072307;980.1570649241646;993.0665174735725;995.9651412200539;999.9300048996646;1004.7287232447198;5823.767049318065;5872.207252021008;5890.021628047535;5959.821205363846;5966.552508561876;1075.7471994081384;1076.8815430302661;1079.6275285026654;1100.3617901617204;1107.2581370481796;4050.4531888194715;4063.715539912237;4093.9795301023305;4094.344904815215;4125.8968525786495;10240.590376384862;10605.946970265099;10659.14726821868;10672;10733.946330268298;10615.681529554126;10616.840747388795;10620.734481637866;10636.627718029831;10636.946815265874;8021.3181879539725;8100.71647492335;8168.632411541495;8170.714025009096;8177.386695997824;5666.575006874584;5689.317281926195;5738.770449181986;5843.970780146072;6125.571210015434;9661.372010819274;9711.9028809711;9719.222462202866;9802.901970980483;9941.552630131517;9806.068423499755;9847.31068825204;9929.751756206153;9932.304738668225;10082.092611664986;7214.855702885808;7266.382357499671;7679.539227646135;7818.374530037469;7822.804429889298;8177.4684645497855;8337;8342.87485687703;8739.38824282294;8749.518776467356;7644.197359277196;7686.116096648733;7694.8076298090755;7730.11103723079;7879.487833290817;7619.08570971487;7661.425393095428;7688.884666729891;7692.692292308245;7756.108047574601;6712.2616512184595;6738.191417029988;6791.626460544718;6794.796156115324;6797.592144471348;5103.693778373309;5112.642115051911;5114.181730923035;5120.692758434506;5260.7106609135335;5003.924941125813;5056.595472362129;5103.974480127576;5138.254953031864;5307.708076055854 15:20:59 INFO - PROCESS | 19706 | |4;prototype.html;396.56377984217346;398.93218152914;403.8869116647339;417.22188119157744;425.7871064467768;4986.975065124679;5193.896122077561;5237.554807841333;5275.709835959025;5303.628745987782;4955.876103097416;5076.1370567003605;5089.821856235032;5180.715060671661;5239.816606418776;4240.688824590606;4243.411518973424;4246.108317253381;4255.765932873698;4262.46719160105;4273.188094262096;4291;4294.26997410441;4303.353437635863;4312.460942382202;4072.511298644167;4073.739074813477;4252.319628859384;4265.552117027714;4273.957260427387;4233.661307095425;4253.490011046096;4254.978725106354;4276.144771045772;4277.230098582254;3877.3602355611292;3878.5151856017997;3889.358255887775;3891.1633998690136;3896.883093507199;5043.722595257259;5088.669236499616;5098.719570423626;5099.71951542665;5129.974350128263;4851.902961940777;4868.440129385131;4879.2925025871045;4883.243097319921;4886.047220791947;5523.619095226193;5530.889382212374;5534.667919924817;5543.972280138614;5567.526760225385;4124.6906482013965;4147.709660323779;4192.463559546461;4237.470316210473;4288;5571.164325351189;5613.484359223028;5616.466435688603;5651.717414129318;5656.971715141439;4371.23503386906;4373.169097871458;4380.299152135707;4395.758233297135;4396.60430561251;3992.9800350998057;4151.667866570667;4170.7706076166105;4452.797744608937;4457.66270118963;4683.501279590499;4684.578387945033;4691.108689349013;4696.412948381452;4704.200285951397;5472.151816468454;5480.725498917905;5499.340079190522;5510.889782204334;5526.336839579276;1349.9325033748273;1392.4987004678308;1394.0520446096752;1408.985910140906;1422.4096999745198;965.1458459263603;991.509202944547;998.7403275148368;998.9100980911608;1004.2568499310604;5193.454687257859;5222.92165617516;5224;5252.894942101213;5270.683758974474;5416.458354164631;5418;5444.156155795858;5444.312263198342;5449.1826226066405;5005.6996580205305;5234.031704134747;5254.973725131426;5260.658057226268;5260.947390526122;2856.9714902635033;2857.3142445812855;2864.6562412510634;2864.942701145965;2868;5623.550115990793;5663.470862867085;5668;5673.205751194836;5701.885962280731;5265.289185959923;5420.430854760272;5532.225488431623;5544.362398324244;5551.611387202857;5600.467955544217;5630.239917611152;5635.605507614428;5640;5675.80134695292;5244.632875698817;5427.209021023132;5448.182772584144;5467.781288748564;5468.6641148899935;5347.967772246677;5360.222767698584;5361.4370491099435;5379.462053794589;5384.757685904222;5647.6893770843;5670.716464176692;5704.3725190228215;5708.257926469532;5710.200571919851;3909.433132195759;4035.2534781065597;4075.3683179107284;4095.7542547447247;4107.342825147962;5392.406835248041;5402.109871218879;5425.972870135782;5454.209139674805;5455.0726376515295;5268.315119034501;5301.792415588668;5308.973455132699;5332.520073193431;5341.973290133525;5041.697498150123;5242.790288388422;5266.89466210666;5283.260343551829;5330.387005494418;5242.7902883885745;5251;5251.553617942518;5263.184206448007;5282.683039017671;5303.178007408704;5315.4153043166;5331.4401987790725;5338.46615338463;5350.1974703793185;4979.302897594413;5111.207762796773;5131.640785145004;5165.586753059671;5201.323827902348 15:20:59 INFO - PROCESS | 19706 | |5;yui.html;802.5545822068754;816.4937738602067;826.7974346285162;906.5071793984629;912.2565109435807;13642.795358069625;15077.547673569783;15105.848941510581;15244.237788110591;15278.236088195588;14554.417823287056;14790.926045369759;14804.851951480481;14955.252237388115;14976.101433913973;685.2393842834438;698.7624207769358;699.1435491522894;701.9894701579481;802.1697543042952;822.042320696388;831.966721331146;832.134580036761;832.267604508032;836.782436566491;860.4450129666393;870.2168048756139;871.094062175337;872.2672954718035;872.389327470773;865.9997702653445;866.0689758509627;866.1252135343349;866.5060915278262;866.5710473315718;516.1483552139001;527.0302643136647;608.9725962331705;632.0140580694132;632.7595513704808;15874;16870.915645421694;16903;16915.06967116808;16916.577085572837;14400.207988560625;14705;15298.158601276926;15351.385944562204;15680.451184208612;13952.860471395257;14527;14585.124892506483;14681.632959175999;14690.485832995793;4780.880477988043;4786.44955830077;4787.904241915177;4803.1114243864995;4908.950910490921;80684;81369;81964.59017704934;82100.58949705273;82399.5880020602;11136.547670222257;11144.442777861075;11251.493682784294;11387;11525.827112593317;21826.454338641342;21843.235486757887;21845.235416760337;21869;21911.233106841184;8752.168543988311;8759.430637008574;8908.510031948175;9011.459312441275;9109.77225569366;4730.574248317668;4752.95247047532;4757.452892917358;4775.450823155312;4897.314375987365;3766.0208345830283;3845.615438456188;3846.653801157909;3850.133719912997;3857.556381016163;657.3426573426574;662.9889418636618;663.698017402081;663.7610460234312;669.1434963246954;786.1509569664748;791.4736700094488;792.9484583502054;812.1026265976011;841.848467275884;10658.253922225369;10678.906024432217;10881.510332035077;11053.171012173958;11212.598425196851;818.3575892924026;822.576373167819;830.9335253179731;840.2018082821344;842.2209456253064;5356.732163391893;5580.135079062752;5667.1782591524;5817.476427121579;5830;80011;80028.59985700034;80770;82419.5879020601;84337;58038.709806451545;58237.126443103385;59261;60830;67028;59420;59677;59697.999999999134;60801.69599151976;63084;10993.615223467461;11412;11417.828732568853;11579.536818527165;11698.824517632072;39195.41206881842;39459;39697.206055878145;40034.799826000686;40851;48722.26916596183;48895;50846.237306439696;51311.74344128255;52072;13249.205047697169;13304.068715189844;13388.665283367995;13462.73074538484;13564.86435135636;15083.773743393638;15118.697626047637;15696.764548531553;16408.17959102016;16473.423430179886;14819.851801482278;15135.545933622008;15771.842281577037;16015.679686405974;16031.51905442792;14077.507287244896;14100.506482273071;14137.293135342987;14181.503647372292;14509.056911300731;12909.483620655068;12963.092583519063;13039.282839443922;13041.608751737464;13417.262050587311;11435.714107147387;12152.93923530412;12158.45286962071;12166.878331216574;12175.817362739388;11723.296602203895;11997.589725457736;12152.453139608562;12185.756284874431;12217.633470995885 15:20:59 INFO - PROCESS | 19706 | __end_tp_report 15:20:59 INFO - PROCESS | 19706 | __start_cc_report 15:20:59 INFO - PROCESS | 19706 | _x_x_mozilla_cycle_collect,970 15:20:59 INFO - PROCESS | 19706 | __end_cc_report 15:20:59 INFO - PROCESS | 19706 | __startTimestamp1488756059246__endTimestamp 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | ------- Summary: start ------- 15:20:59 INFO - PROCESS | 19706 | Number of tests: 6 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#0] dojo.html Cycles:165 Average:5387.93 Median:5597.97 stddev:575.61 (10.3%) stddev-sans-first:552.21 15:20:59 INFO - PROCESS | 19706 | Values: 3242.0 3262.0 3283.6 3297.8 3333.0 5372.1 5443.2 5455.8 5463.5 5490.2 5396.2 5463.7 5464.9 5465.2 5491.9 4974.7 4988.1 5013.2 5039.5 5086.5 4891.0 4911.8 4934.8 5031.3 5069.3 4942.4 5036.9 5038.1 5053.4 5076.2 5058.3 5065.5 5067.7 5076.7 5106.7 4821.2 4849.4 4978.0 4979.7 5048.4 5291.3 5314.8 5379.8 5425.7 5438.3 5809.7 5810.8 5811.6 5819.9 5826.2 5641.7 5703.7 5781.7 5783.5 5840.8 5408.8 5416.5 5502.7 5532.1 5536.9 5968.2 5969.3 5970.6 5974.9 5975.6 5530.9 5754.2 5770.2 5772.7 5772.7 5677.5 5699.8 5724.7 5735.3 5736.7 5711.3 5766.8 5767.5 5768.9 5791.1 5726.5 5769.2 5780.7 5786.4 5787.2 4366.0 4393.1 4432.9 4452.1 4506.0 4004.2 4027.0 4032.7 4037.9 4053.7 5609.9 5617.7 5620.9 5625.2 5625.4 5631.7 5642.8 5664.4 5687.1 5708.0 5507.3 5509.9 5513.4 5515.7 5536.4 4894.5 4894.9 4896.7 4898.1 4919.1 5793.3 5844.9 5922.8 5938.3 6008.4 5818.8 5818.9 5839.2 5841.0 5848.8 6019.6 6067.6 6073.5 6077.9 6081.7 5609.0 5643.1 5728.0 5736.1 5737.0 5649.1 5719.9 5737.7 5782.4 5784.5 5598.0 5603.4 5606.3 5630.3 5645.5 5466.0 5511.0 5613.5 5649.5 5652.9 5459.1 5472.3 5526.7 5588.2 5613.2 5614.9 5627.0 5631.0 5632.3 5636.1 5424.0 5459.4 5505.3 5513.3 5554.4 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#1] ext.html Cycles:180 Average:63480.28 Median:417687.50 stddev:118908.65 (28.5%) stddev-sans-first:119148.36 15:20:59 INFO - PROCESS | 19706 | Values: 554.6 575.1 610.4 618.1 642.0 37156.3 48459.5 49495.0 49538.5 49632.0 53098.7 53497.2 53501.5 53503.7 53516.5 8723.3 8934.2 9354.0 9514.2 9540.1 11189.7 11398.3 11427.0 11925.8 11933.9 11657.1 11737.3 11742.1 11750.0 11764.9 11499.0 11579.4 11586.5 11586.6 11596.9 11274.9 11352.1 11354.4 11356.9 11363.7 48610.8 48640.5 48990.0 49096.3 49101.5 4358.9 4472.9 4473.0 4485.8 4673.9 33441.5 33469.0 33534.2 33966.2 34799.3 4634.6 4646.5 4669.2 4723.3 4787.3 362108.0 363331.0 363506.0 364166.0 366098.0 63042.0 63154.7 63520.4 63586.0 63695.7 66542.3 66634.7 66805.0 66874.3 66877.0 19506.9 19806.5 19851.7 19861.7 19864.4 13758.1 13917.2 14145.7 14162.8 14172.1 18544.8 19975.0 20075.1 20927.9 21078.8 7057.4 7413.4 7458.2 7482.1 7558.9 993.9 1007.2 1017.4 1018.9 1023.5 34706.3 34935.1 35321.5 35350.5 35433.6 1180.8 1183.7 1231.4 1239.3 1285.4 18440.0 18575.4 18583.6 18695.4 18853.4 545619.0 545998.0 547230.0 549044.0 553243.0 71351.0 71925.0 71930.3 71987.3 72135.6 1510.8 1512.1 1541.9 1547.9 1583.7 30635.2 31878.0 32001.2 32363.0 32561.8 59396.1 60023.4 60135.4 60174.1 60203.7 416476.0 418899.0 419175.0 419365.0 419692.0 27696.0 28354.9 30404.7 32745.0 33227.3 53833.7 55179.0 55438.2 55479.4 55487.0 44417.6 45715.3 46717.8 46779.3 48858.3 44637.8 45861.0 45943.5 46048.5 47477.8 44537.6 45383.0 45937.0 45952.3 46237.5 37123.6 39887.0 40580.2 41191.0 41214.0 29122.0 29764.6 30086.4 30092.0 30149.4 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#2] jquery.html Cycles:180 Average:35213.79 Median:3107.43 stddev:111169.74 (3577.6%) stddev-sans-first:111450.93 15:20:59 INFO - PROCESS | 19706 | Values: 438.5 438.5 438.9 441.7 454.9 20685.5 21153.0 22481.4 22551.4 22625.0 21043.6 21088.9 22492.9 22593.7 22740.8 5958.1 5983.2 6111.2 6140.0 6150.2 5882.0 5948.3 6098.6 6108.6 6109.5 5884.4 5987.9 6093.9 6100.6 6100.9 6018.5 6056.0 6070.8 6071.3 6071.7 5448.0 5466.5 5481.4 5678.3 5713.1 15060.8 15072.3 15124.8 15225.5 15260.8 3064.6 3105.3 3109.5 3116.3 3163.7 10882.5 10982.4 11074.4 11106.7 11295.0 1936.9 1982.6 1987.9 2012.1 2045.2 66081.3 70449.6 92057.0 93008.0 99808.0 10964.7 11339.1 11348.5 11417.4 11430.4 15295.2 15318.6 15361.4 15367.3 15379.5 8671.6 8680.5 8822.9 8967.4 8969.6 8763.3 8779.7 8789.0 8905.7 8945.8 4610.3 4652.2 4697.4 4929.7 5244.3 2128.5 2131.8 2140.6 2189.6 2216.5 936.1 940.9 949.9 958.9 968.9 19465.8 20065.1 20957.8 20967.4 20992.5 948.3 953.4 957.7 959.1 966.5 10970.0 11520.6 11590.1 11616.3 11656.7 661283.0 663312.0 674888.0 683728.0 700707.0 85148.6 109875.5 110626.0 112758.4 113278.4 1068.9 1096.1 1096.6 1099.9 1100.7 18522.0 18669.4 18738.4 18819.0 19127.4 42758.6 47814.5 48155.0 48447.0 48585.0 62058.0 62484.0 62928.7 63622.0 65695.0 6513.5 7036.7 8418.7 9585.4 9800.4 13423.8 13584.1 13669.9 14238.6 14437.4 12160.2 12177.7 12212.9 12225.3 12296.4 12194.8 12230.1 12258.6 12403.2 12437.9 11654.4 12132.5 12137.8 12239.9 12266.2 8751.9 8813.0 8871.4 8893.6 8949.0 11184.2 11749.8 11779.6 11954.1 12093.1 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#3] mootools.html Cycles:180 Average:5753.07 Median:5030.26 stddev:3176.54 (63.1%) stddev-sans-first:3169.28 15:20:59 INFO - PROCESS | 19706 | Values: 1488.5 1506.7 1510.5 1514.0 1515.6 8398.7 9022.6 9026.1 9026.2 9034.7 7902.2 7937.6 7940.4 8283.9 8842.5 2320.0 2346.7 2373.9 2397.9 2411.3 2344.3 2389.3 2417.0 2418.9 2423.8 2324.3 2330.8 2348.2 2357.4 2359.2 2358.7 2373.8 2378.0 2378.6 2379.4 2299.4 2335.1 2342.6 2345.4 2345.6 9024.5 9078.7 9092.0 9097.6 9110.9 5113.4 5232.4 5240.7 5244.4 5244.6 3248.4 3329.4 3429.8 3431.9 3445.4 1368.5 1375.5 1397.8 1407.3 2145.9 11304.8 11941.7 12100.4 12112.2 12127.9 4445.3 4531.0 4549.6 4646.1 4648.3 9944.7 10026.6 10034.6 10056.4 10061.3 5346.1 5382.4 5403.2 5409.4 5410.3 4470.5 4561.5 4909.3 4942.3 5058.3 4036.6 4079.3 4112.4 4113.2 4161.9 1306.6 1319.5 1331.0 1334.5 1335.6 980.2 993.1 996.0 999.9 1004.7 5823.8 5872.2 5890.0 5959.8 5966.6 1075.7 1076.9 1079.6 1100.4 1107.3 4050.5 4063.7 4094.0 4094.3 4125.9 10240.6 10605.9 10659.1 10672.0 10733.9 10615.7 10616.8 10620.7 10636.6 10636.9 8021.3 8100.7 8168.6 8170.7 8177.4 5666.6 5689.3 5738.8 5844.0 6125.6 9661.4 9711.9 9719.2 9802.9 9941.6 9806.1 9847.3 9929.8 9932.3 10082.1 7214.9 7266.4 7679.5 7818.4 7822.8 8177.5 8337.0 8342.9 8739.4 8749.5 7644.2 7686.1 7694.8 7730.1 7879.5 7619.1 7661.4 7688.9 7692.7 7756.1 6712.3 6738.2 6791.6 6794.8 6797.6 5103.7 5112.6 5114.2 5120.7 5260.7 5003.9 5056.6 5104.0 5138.3 5307.7 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#4] prototype.html Cycles:180 Average:4605.74 Median:5223.46 stddev:1283.88 (24.6%) stddev-sans-first:1248.01 15:20:59 INFO - PROCESS | 19706 | Values: 396.6 398.9 403.9 417.2 425.8 4987.0 5193.9 5237.6 5275.7 5303.6 4955.9 5076.1 5089.8 5180.7 5239.8 4240.7 4243.4 4246.1 4255.8 4262.5 4273.2 4291.0 4294.3 4303.4 4312.5 4072.5 4073.7 4252.3 4265.6 4274.0 4233.7 4253.5 4255.0 4276.1 4277.2 3877.4 3878.5 3889.4 3891.2 3896.9 5043.7 5088.7 5098.7 5099.7 5130.0 4851.9 4868.4 4879.3 4883.2 4886.0 5523.6 5530.9 5534.7 5544.0 5567.5 4124.7 4147.7 4192.5 4237.5 4288.0 5571.2 5613.5 5616.5 5651.7 5657.0 4371.2 4373.2 4380.3 4395.8 4396.6 3993.0 4151.7 4170.8 4452.8 4457.7 4683.5 4684.6 4691.1 4696.4 4704.2 5472.2 5480.7 5499.3 5510.9 5526.3 1349.9 1392.5 1394.1 1409.0 1422.4 965.1 991.5 998.7 998.9 1004.3 5193.5 5222.9 5224.0 5252.9 5270.7 5416.5 5418.0 5444.2 5444.3 5449.2 5005.7 5234.0 5255.0 5260.7 5260.9 2857.0 2857.3 2864.7 2864.9 2868.0 5623.6 5663.5 5668.0 5673.2 5701.9 5265.3 5420.4 5532.2 5544.4 5551.6 5600.5 5630.2 5635.6 5640.0 5675.8 5244.6 5427.2 5448.2 5467.8 5468.7 5348.0 5360.2 5361.4 5379.5 5384.8 5647.7 5670.7 5704.4 5708.3 5710.2 3909.4 4035.3 4075.4 4095.8 4107.3 5392.4 5402.1 5426.0 5454.2 5455.1 5268.3 5301.8 5309.0 5332.5 5342.0 5041.7 5242.8 5266.9 5283.3 5330.4 5242.8 5251.0 5251.6 5263.2 5282.7 5303.2 5315.4 5331.4 5338.5 5350.2 4979.3 5111.2 5131.6 5165.6 5201.3 15:20:59 INFO - PROCESS | 19706 | 15:20:59 INFO - PROCESS | 19706 | [#5] yui.html Cycles:180 Average:17698.10 Median:4741.76 stddev:21827.27 (460.3%) stddev-sans-first:21851.63 15:20:59 INFO - PROCESS | 19706 | Values: 802.6 816.5 826.8 906.5 912.3 13642.8 15077.5 15105.8 15244.2 15278.2 14554.4 14790.9 14804.9 14955.3 14976.1 685.2 698.8 699.1 702.0 802.2 822.0 832.0 832.1 832.3 836.8 860.4 870.2 871.1 872.3 872.4 866.0 866.1 866.1 866.5 866.6 516.1 527.0 609.0 632.0 632.8 15874.0 16870.9 16903.0 16915.1 16916.6 14400.2 14705.0 15298.2 15351.4 15680.5 13952.9 14527.0 14585.1 14681.6 14690.5 4780.9 4786.4 4787.9 4803.1 4909.0 80684.0 81369.0 81964.6 82100.6 82399.6 11136.5 11144.4 11251.5 11387.0 11525.8 21826.5 21843.2 21845.2 21869.0 21911.2 8752.2 8759.4 8908.5 9011.5 9109.8 4730.6 4753.0 4757.5 4775.5 4897.3 3766.0 3845.6 3846.7 3850.1 3857.6 657.3 663.0 663.7 663.8 669.1 786.2 791.5 792.9 812.1 841.8 10658.3 10678.9 10881.5 11053.2 11212.6 818.4 822.6 830.9 840.2 842.2 5356.7 5580.1 5667.2 5817.5 5830.0 80011.0 80028.6 80770.0 82419.6 84337.0 58038.7 58237.1 59261.0 60830.0 67028.0 59420.0 59677.0 59698.0 60801.7 63084.0 10993.6 11412.0 11417.8 11579.5 11698.8 39195.4 39459.0 39697.2 40034.8 40851.0 48722.3 48895.0 50846.2 51311.7 52072.0 13249.2 13304.1 13388.7 13462.7 13564.9 15083.8 15118.7 15696.8 16408.2 16473.4 14819.9 15135.5 15771.8 16015.7 16031.5 14077.5 14100.5 14137.3 14181.5 14509.1 12909.5 12963.1 13039.3 13041.6 13417.3 11435.7 12152.9 12158.5 12166.9 12175.8 11723.3 11997.6 12152.5 12185.8 12217.6 15:20:59 INFO - PROCESS | 19706 | -------- Summary: end -------- 15:20:59 INFO - PROCESS | 19706 | 15:21:00 INFO - TEST-INFO | 19706: exit 0 15:21:00 INFO - TEST-OK | dromaeo_css | took 1113720ms 15:21:00 INFO - TEST-START | kraken 15:21:00 INFO - operating with platform_type : linux_ 15:21:00 INFO - Initialising browser for kraken test... 15:21:00 INFO - TEST-INFO | started process 20026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVwrGF/profile http://localhost:47084/getInfo.html) 15:21:04 INFO - PROCESS | 20026 | __metrics Screen width/height:1600/1200 15:21:04 INFO - PROCESS | 20026 | colorDepth:24 15:21:04 INFO - PROCESS | 20026 | Browser inner width/height: 1024/697 15:21:04 INFO - PROCESS | 20026 | __metrics 15:21:05 INFO - PROCESS | 20026 | 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" 15:21:05 INFO - PROCESS | 20026 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:21:06 INFO - TEST-INFO | 20026: exit 0 15:21:06 INFO - Browser initialized. 15:21:06 INFO - Running cycle 1/1 for kraken test... 15:21:06 INFO - TEST-INFO | started process 20117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVwrGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:18 INFO - PROCESS | 20117 | RSS: Main: 137728000 15:21:18 INFO - PROCESS | 20117 | 15:21:20 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47084/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:21 INFO - PROCESS | 20117 | RSS: Main: 181608448 15:21:21 INFO - PROCESS | 20117 | 15:21:24 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47084/tests/kraken/driver.html?testName=audio-dft) 15:21:24 INFO - PROCESS | 20117 | RSS: Main: 171757568 15:21:24 INFO - PROCESS | 20117 | 15:21:27 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47084/tests/kraken/driver.html?testName=audio-fft) 15:21:28 INFO - PROCESS | 20117 | RSS: Main: 264015872 15:21:28 INFO - PROCESS | 20117 | 15:21:30 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47084/tests/kraken/driver.html?testName=audio-oscillator) 15:21:30 INFO - PROCESS | 20117 | RSS: Main: 169967616 15:21:30 INFO - PROCESS | 20117 | 15:21:32 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:33 INFO - PROCESS | 20117 | RSS: Main: 171778048 15:21:33 INFO - PROCESS | 20117 | 15:21:36 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47084/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:37 INFO - PROCESS | 20117 | RSS: Main: 211402752 15:21:37 INFO - PROCESS | 20117 | 15:21:40 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47084/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:40 INFO - PROCESS | 20117 | RSS: Main: 209932288 15:21:40 INFO - PROCESS | 20117 | 15:21:43 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47084/tests/kraken/driver.html?testName=json-parse-financial) 15:21:44 INFO - PROCESS | 20117 | RSS: Main: 207966208 15:21:44 INFO - PROCESS | 20117 | 15:21:45 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:46 INFO - PROCESS | 20117 | RSS: Main: 170430464 15:21:46 INFO - PROCESS | 20117 | 15:21:48 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:48 INFO - PROCESS | 20117 | RSS: Main: 177065984 15:21:48 INFO - PROCESS | 20117 | 15:21:50 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:51 INFO - PROCESS | 20117 | RSS: Main: 186871808 15:21:51 INFO - PROCESS | 20117 | 15:21:53 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:54 INFO - PROCESS | 20117 | RSS: Main: 197111808 15:21:54 INFO - PROCESS | 20117 | 15:21:57 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:57 INFO - PROCESS | 20117 | RSS: Main: 192380928 15:21:57 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:47084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47084/tests/kraken/driver.html?testName=ai-astar) 15:21:59 INFO - PROCESS | 20117 | RSS: Main: 243687424 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | __start_tp_report 15:21:59 INFO - PROCESS | 20117 | _x_x_mozilla_page_load 15:21:59 INFO - PROCESS | 20117 | _x_x_mozilla_page_load_details 15:21:59 INFO - PROCESS | 20117 | |i|pagename|runs| 15:21:59 INFO - PROCESS | 20117 | |0;ai-astar;109;114;111;110;111;112;113;112;111;111 15:21:59 INFO - PROCESS | 20117 | |1;audio-beat-detection;146;116;116;148;120;119;122;121;134;116 15:21:59 INFO - PROCESS | 20117 | |2;audio-dft;161;159;161;163;161;160;161;161;159;159 15:21:59 INFO - PROCESS | 20117 | |3;audio-fft;74;76;76;110;75;77;76;75;101;76 15:21:59 INFO - PROCESS | 20117 | |4;audio-oscillator;82;82;103;81;82;83;100;82;82;104 15:21:59 INFO - PROCESS | 20117 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;116;118 15:21:59 INFO - PROCESS | 20117 | |6;imaging-darkroom;147;146;145;145;146;146;145;145;145;145 15:21:59 INFO - PROCESS | 20117 | |7;imaging-desaturate;95;96;95;96;95;95;96;96;96;95 15:21:59 INFO - PROCESS | 20117 | |8;json-parse-financial;51;48;51;48;49;49;49;48;48;48 15:21:59 INFO - PROCESS | 20117 | |9;json-stringify-tinderbox;64;65;68;64;64;65;65;69;65;65 15:21:59 INFO - PROCESS | 20117 | |10;stanford-crypto-aes;74;75;77;80;77;74;84;75;78;75 15:21:59 INFO - PROCESS | 20117 | |11;stanford-crypto-ccm;122;125;121;134;121;117;121;123;163;123 15:21:59 INFO - PROCESS | 20117 | |12;stanford-crypto-pbkdf2;169;161;160;161;160;163;161;165;164;165 15:21:59 INFO - PROCESS | 20117 | |13;stanford-crypto-sha256-iterative;63;62;61;61;61;61;62;61;60;59 15:21:59 INFO - PROCESS | 20117 | __end_tp_report 15:21:59 INFO - PROCESS | 20117 | __start_cc_report 15:21:59 INFO - PROCESS | 20117 | _x_x_mozilla_cycle_collect,1502 15:21:59 INFO - PROCESS | 20117 | __end_cc_report 15:21:59 INFO - PROCESS | 20117 | __startTimestamp1488756119796__endTimestamp 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | ------- Summary: start ------- 15:21:59 INFO - PROCESS | 20117 | Number of tests: 14 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.43 (1.3%) stddev-sans-first:1.22 15:21:59 INFO - PROCESS | 20117 | Values: 109.0 114.0 111.0 110.0 111.0 112.0 113.0 112.0 111.0 111.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:121.50 stddev:12.35 (10.2%) stddev-sans-first:10.73 15:21:59 INFO - PROCESS | 20117 | Values: 146.0 116.0 116.0 148.0 120.0 119.0 122.0 121.0 134.0 116.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 15:21:59 INFO - PROCESS | 20117 | Values: 161.0 159.0 161.0 163.0 161.0 160.0 161.0 161.0 159.0 159.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.80 (16.8%) stddev-sans-first:13.28 15:21:59 INFO - PROCESS | 20117 | Values: 74.0 76.0 76.0 110.0 75.0 77.0 76.0 75.0 101.0 76.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:82.00 stddev:9.88 (12.1%) stddev-sans-first:10.23 15:21:59 INFO - PROCESS | 20117 | Values: 82.0 82.0 103.0 81.0 82.0 83.0 100.0 82.0 82.0 104.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:21:59 INFO - PROCESS | 20117 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 118.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 15:21:59 INFO - PROCESS | 20117 | Values: 147.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:21:59 INFO - PROCESS | 20117 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:1.20 (2.4%) stddev-sans-first:1.00 15:21:59 INFO - PROCESS | 20117 | Values: 51.0 48.0 51.0 48.0 49.0 49.0 49.0 48.0 48.0 48.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.71 (2.6%) stddev-sans-first:1.74 15:21:59 INFO - PROCESS | 20117 | Values: 64.0 65.0 68.0 64.0 64.0 65.0 65.0 69.0 65.0 65.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:3.14 (4.1%) stddev-sans-first:3.15 15:21:59 INFO - PROCESS | 20117 | Values: 74.0 75.0 77.0 80.0 77.0 74.0 84.0 75.0 78.0 75.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.00 stddev:13.39 (10.9%) stddev-sans-first:14.08 15:21:59 INFO - PROCESS | 20117 | Values: 122.0 125.0 121.0 134.0 121.0 117.0 121.0 123.0 163.0 123.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:2.88 (1.8%) stddev-sans-first:2.05 15:21:59 INFO - PROCESS | 20117 | Values: 169.0 161.0 160.0 161.0 160.0 163.0 161.0 165.0 164.0 165.0 15:21:59 INFO - PROCESS | 20117 | 15:21:59 INFO - PROCESS | 20117 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.10 (1.8%) stddev-sans-first:0.93 15:21:59 INFO - PROCESS | 20117 | Values: 63.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 60.0 59.0 15:21:59 INFO - PROCESS | 20117 | -------- Summary: end -------- 15:21:59 INFO - PROCESS | 20117 | 15:22:00 INFO - TEST-INFO | 20117: exit 0 15:22:00 INFO - TEST-OK | kraken | took 60816ms 15:22:00 INFO - SUITE-END | took 1174s 15:22:00 INFO - Completed test suite (00:19:34) 15:22:00 INFO - javascript benchmark 15:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.9837900810494, 3262.0213935819256, 3283.5567198428207, 3297.76915615907, 3332.9500057499126, 5372.086745253311, 5443.156310771827, 5455.809046683366, 5463.508284254416, 5490.176473528973, 5396.163594642827, 5463.672179669213, 5464.863378415542, 5465.180222966557, 5491.945080549193, 4974.7015179089185, 4988.127077761377, 5013.248012798092, 5039.47085556015, 5086.516780905827, 4890.951090489103, 4911.778969946343, 4934.777934992934, 5031.345925029741, 5069.340985671857, 4942.406911170665, 5036.899262014757, 5038.143515602356, 5053.418856831457, 5076.238564215379, 5058.342415486, 5065.493450654942, 5067.746612669352, 5076.74616269185, 5106.693598384071, 4821.204501257288, 4849.442314133849, 4978.0, 4979.676321039121, 5048.419431765357, 5291.28567643367, 5314.840554783324, 5379.784808607651, 5425.728713564306, 5438.320209973754, 5809.7095145242565, 5810.796622118248, 5811.6222445541325, 5819.883602327972, 5826.213461182729, 5641.661500309994, 5703.657780533182, 5781.682007489587, 5783.479486846204, 5840.8247752567495, 5408.8377348679605, 5416.51251387377, 5502.697351645698, 5532.114861622121, 5536.916946245809, 5968.194293770285, 5969.343372229051, 5970.58205925581, 5974.910376344358, 5975.55183361241, 5530.86172845674, 5754.223179870748, 5770.19217309577, 5772.7113644317615, 5772.740226689725, 5677.51741102011, 5699.829005129853, 5724.742386592613, 5735.254416925856, 5736.655800651891, 5711.314642242957, 5766.769329226868, 5767.538596912237, 5768.884622307531, 5791.0734282514595, 5726.513246374022, 5769.1923130761725, 5780.653160810365, 5786.363500014995, 5787.189793428924, 4366.039471316305, 4393.121375724868, 4432.889177770517, 4452.109578084396, 4505.963628365429, 4004.1591265833918, 4026.9798651007145, 4032.6572241359227, 4037.858674946363, 4053.7365071270274, 5609.943900561024, 5617.719114044281, 5620.887582248332, 5625.156226565966, 5625.353084395265, 5631.6902570359025, 5642.802501912495, 5664.405237450091, 5687.118496633028, 5708.0, 5507.256520369699, 5509.889802203934, 5513.393526712059, 5515.696636685021, 5536.390996990328, 4894.510548945077, 4894.853154405374, 4896.6572339935865, 4898.093852637274, 4919.0899683558655, 5793.333766616809, 5844.853878653068, 5922.763089476459, 5938.317093534212, 6008.429199226067, 5818.8254352369495, 5818.883622327615, 5839.211706419579, 5841.0, 5848.824535263949, 6019.578629496068, 6067.605605635619, 6073.48375388097, 6077.878442431038, 6081.695915204134, 5609.0, 5643.125315576092, 5728.0262355398845, 5736.110902810071, 5736.9673458777825, 5649.12438572022, 5719.8856022880145, 5737.741801618854, 5782.363939966516, 5784.479396854304, 5597.972010139923, 5603.35561410443, 5606.271184745957, 5630.296212973379, 5645.491905728504, 5465.9726701366235, 5511.0, 5613.522850557748, 5649.54803615718, 5652.88694226105, 5459.126539753779, 5472.261244731911, 5526.696031718133, 5588.217649529151, 5613.242212301287, 5614.943850561605, 5626.971865140648, 5631.0, 5632.324121105494, 5636.070048442125, 5423.9694458052845, 5459.39946605881, 5505.311836020497, 5513.3108361454815, 5554.361248456479], "value": 5351.86553929517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5966982372431, 575.1143239411307, 610.41095342994, 618.1068356225256, 642.0209180998979, 37156.25687486248, 48459.515404845944, 49495.0, 49538.50461495388, 49632.0, 53098.73450632741, 53497.1975420368, 53501.46498535013, 53503.73248133763, 53516.46483535163, 8723.25852302555, 8934.195922366986, 9354.0, 9514.238860891111, 9540.093691099335, 11189.7202569936, 11398.316101033923, 11427.0, 11925.821112683318, 11933.880661193407, 11657.067434605253, 11737.295762254249, 11742.060635149168, 11750.0, 11764.882351176464, 11499.0, 11579.36313502757, 11586.478608462556, 11586.594469193538, 11596.942015289911, 11274.943625281903, 11352.091832653368, 11354.432278386048, 11356.886431135665, 11363.715907102305, 48610.7569462154, 48640.51359486395, 48990.0, 49096.26355604669, 49101.50898491041, 4358.934615980763, 4472.910541789179, 4473.0, 4485.820567177309, 4673.929891051637, 33441.49837752436, 33469.0, 33534.161645958804, 33966.1508462288, 34799.304013919835, 4634.629229661619, 4646.53534646536, 4669.182892993713, 4723.267893476516, 4787.257975013878, 362108.0, 363331.0, 363506.0, 364166.0, 366097.9999999973, 63042.0, 63154.68422657949, 63520.364796351445, 63586.0, 63695.681521592094, 66542.33457665361, 66634.66682666652, 66805.0, 66874.33125668779, 66877.0, 19506.902465487583, 19806.50483737918, 19851.702224466644, 19861.702074468605, 19864.4040678777, 13758.105723128165, 13917.164970101827, 14145.717085658229, 14162.787558186636, 14172.149671019772, 18544.752092723873, 19975.0, 20075.096620652104, 20927.895360523406, 21078.789212107684, 7057.4001209896705, 7413.406927445792, 7458.179600243969, 7482.139553951365, 7558.924410755932, 993.895640957689, 1007.1791489935679, 1017.4302390661105, 1018.8879223285433, 1023.5445226873969, 34706.305873882884, 34935.12662183466, 35321.470177947354, 35350.46974295388, 35433.64566354304, 1180.7756526259984, 1183.6981569699672, 1231.4027696567157, 1239.2997956154743, 1285.4279845468864, 18440.006180562057, 18575.44273671792, 18583.628327433646, 18695.439136825917, 18853.434396968114, 545619.0, 545998.0, 547230.0, 549044.0, 553243.0, 71351.0, 71925.0, 71930.2806971934, 71987.28012719806, 72135.63932180306, 1510.7960425342437, 1512.1078563647281, 1541.8920675552604, 1547.8761699064273, 1583.7307657697988, 30635.2341191472, 31878.0, 32001.199970000936, 32363.0, 32561.837190813894, 59396.1090583633, 60023.39976600178, 60135.39864601473, 60174.09738854008, 60203.69898150656, 416476.0, 418899.0, 419175.0, 419365.0, 419692.0, 27696.0, 28354.85822570874, 30404.695953040187, 32745.0, 33227.335453291285, 53833.730831345594, 55179.0, 55438.16842747281, 55479.445205547425, 55487.0, 44417.555824442636, 45715.31427028531, 46717.76641116773, 46779.29831052469, 48858.26712599385, 44637.776811115735, 45861.0, 45943.540564593925, 46048.53951460576, 47477.76261118672, 44537.55462445334, 45383.0, 45937.0, 45952.31071533997, 46237.53762462332, 37123.62876371202, 39887.0, 40580.1883962325, 41191.0, 41214.0, 29122.0, 29764.553531697475, 30086.398272034, 30092.0, 30149.3970120592], "value": 22424.855271953533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.50448992638314, 438.5176306063329, 438.9377705951596, 441.7283370727003, 454.8726356620148, 20685.482862928417, 21153.0, 22481.437964050907, 22551.436214094654, 22625.0, 21043.57912841746, 21088.89455552724, 22492.88753556234, 22593.661095083546, 22740.772592274072, 5958.106284057393, 5983.192269043667, 6111.174991376174, 6140.048292514645, 6150.200473938382, 5882.0, 5948.256467941507, 6098.634081955075, 6108.572399932006, 6109.541784366168, 5884.411558844103, 5987.9401205987815, 6093.908591371133, 6100.603460775058, 6100.877982440348, 6018.548608854331, 6055.9697201514155, 6070.757169713184, 6071.332153463116, 6071.696415179224, 5448.046591846451, 5466.508014278695, 5481.424450432687, 5678.261825962599, 5713.114467257582, 15060.849391506054, 15072.321745521478, 15124.848751512454, 15225.467108651255, 15260.847391526053, 3064.5862808520787, 3105.316830297331, 3109.5335699645234, 3116.3144108296365, 3163.7152656261046, 10882.455877206186, 10982.395968221745, 11074.390908500029, 11106.666799996014, 11295.0, 1936.9031548422522, 1982.6431242376366, 1987.8807271563753, 2012.0945574491536, 2045.233037610896, 66081.34600590644, 70449.64775176092, 92057.0, 93008.0, 99808.0, 10964.671059868217, 11339.149563782585, 11348.489317980711, 11417.372044537464, 11430.371329576954, 15295.235238238043, 15318.617034574225, 15361.385544578316, 15367.308471118826, 15379.538613841603, 8671.566421679017, 8680.479171249744, 8822.911770882338, 8967.372283940062, 8969.641214351483, 8763.334966356371, 8779.692710755093, 8788.956055219684, 8905.688300909567, 8945.821083578292, 4610.2623580227, 4652.232381656989, 4697.412823397075, 4929.704217746947, 5244.29202057725, 2128.51044259818, 2131.776163502841, 2140.636091864387, 2189.5511420158828, 2216.5456081503253, 936.1247233836385, 940.8635747816528, 949.9335046546813, 958.942463452195, 968.912797848183, 19465.832050077042, 20065.097070631855, 20957.790422095888, 20967.37097887066, 20992.475188120417, 948.2650945517141, 953.4088864903804, 957.6791774755395, 959.1367769007949, 966.5408930757834, 10970.0, 11520.596779112859, 11590.072794176445, 11616.303021818718, 11656.70858228534, 661283.0, 663312.0, 674888.0, 683728.0, 700707.0, 85148.57425712832, 109875.45062274637, 110626.0, 112758.43620781843, 113278.43360783144, 1068.8557044799009, 1096.0902450965839, 1096.550414330121, 1099.8570185875785, 1100.664297389304, 18522.0, 18669.43991680252, 18738.437846864617, 18819.0, 19127.426177214707, 42758.57241427671, 47814.52185478101, 48155.0, 48447.0, 48585.0, 62058.0, 62484.0, 62928.685356572925, 63622.0, 65695.01457478237, 6513.54405191632, 7036.683349249399, 8418.663253469793, 9585.424874507551, 9800.411975281506, 13423.798643020558, 13584.117032392864, 13669.863301366859, 14238.644033899236, 14437.35031923545, 12160.209586377212, 12177.695557610776, 12212.877871221173, 12225.266484010632, 12296.446659900146, 12194.75610487803, 12230.082743794428, 12258.570950016707, 12403.193792403465, 12437.875621244033, 11654.41727913584, 12132.514699411924, 12137.757244855231, 12239.877601223874, 12266.202696824677, 8751.91248087511, 8812.955935220283, 8871.379003469696, 8893.64425422976, 8949.0, 11184.217104802585, 11749.823752643546, 11779.587714430296, 11954.103442241692, 12093.09301802386], "value": 9750.482878222081, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.538553048555, 1506.676064646101, 1510.4713350327386, 1513.9924300378495, 1515.5907904865683, 8398.706045288416, 9022.639094436223, 9026.142516460943, 9026.232770214532, 9034.72895813125, 7902.170272121416, 7937.563434011142, 7940.40446966477, 8283.91716082839, 8842.469451832894, 2319.9652005219978, 2346.718393792747, 2373.857568545884, 2397.928062158138, 2411.3127758588807, 2344.2615576093476, 2389.3190440724397, 2416.9637455438096, 2418.9274321770376, 2423.8303318767607, 2324.3491822289784, 2330.8484948478294, 2348.2250857217164, 2357.422431504284, 2359.1860808021206, 2358.7287461941837, 2373.786359227669, 2378.0, 2378.6194208926663, 2379.393254720044, 2299.4251437140715, 2335.135999680112, 2342.61346877765, 2345.4019225097663, 2345.5777959967368, 9024.548772561411, 9078.68224612142, 9092.04533523977, 9097.590608422637, 9110.86333704995, 5113.386393632788, 5232.424433312332, 5240.659357141773, 5244.423113457517, 5244.606654500928, 3248.447763880146, 3329.350776598564, 3429.7770644908, 3431.9485207721905, 3445.3970555153, 1368.4662981437248, 1375.4704438791136, 1397.7903314502805, 1407.2752532445697, 2145.9463513412134, 11304.830427543593, 11941.701457463547, 12100.39498025104, 12112.21270617407, 12127.93936030323, 4445.333200019958, 4530.954690453119, 4549.613282870927, 4646.117237724821, 4648.349231107648, 9944.651937182163, 10026.598936042477, 10034.64878729241, 10056.396616203052, 10061.346012509164, 5346.091164502044, 5382.3541175059245, 5403.189521571796, 5409.350877894678, 5410.269613602113, 4470.530594287618, 4561.521040290788, 4909.2881532177635, 4942.308076869242, 5058.266551350033, 4036.6367026967714, 4079.3065178919655, 4112.403701463331, 4113.239050775616, 4161.91676166475, 1306.5753630070265, 1319.491995581708, 1331.0416500119898, 1334.5195729537359, 1335.6327010072307, 980.1570649241646, 993.0665174735725, 995.9651412200539, 999.9300048996646, 1004.7287232447198, 5823.767049318065, 5872.207252021008, 5890.021628047535, 5959.821205363846, 5966.552508561876, 1075.7471994081384, 1076.8815430302661, 1079.6275285026654, 1100.3617901617204, 1107.2581370481796, 4050.4531888194715, 4063.715539912237, 4093.9795301023305, 4094.344904815215, 4125.8968525786495, 10240.590376384862, 10605.946970265099, 10659.14726821868, 10672.0, 10733.946330268298, 10615.681529554126, 10616.840747388795, 10620.734481637866, 10636.627718029831, 10636.946815265874, 8021.3181879539725, 8100.71647492335, 8168.632411541495, 8170.714025009096, 8177.386695997824, 5666.575006874584, 5689.317281926195, 5738.770449181986, 5843.970780146072, 6125.571210015434, 9661.372010819274, 9711.9028809711, 9719.222462202866, 9802.901970980483, 9941.552630131517, 9806.068423499755, 9847.31068825204, 9929.751756206153, 9932.304738668225, 10082.092611664986, 7214.855702885808, 7266.382357499671, 7679.539227646135, 7818.374530037469, 7822.804429889298, 8177.4684645497855, 8337.0, 8342.87485687703, 8739.38824282294, 8749.518776467356, 7644.197359277196, 7686.116096648733, 7694.8076298090755, 7730.11103723079, 7879.487833290817, 7619.08570971487, 7661.425393095428, 7688.884666729891, 7692.692292308245, 7756.108047574601, 6712.2616512184595, 6738.191417029988, 6791.626460544718, 6794.796156115324, 6797.592144471348, 5103.693778373309, 5112.642115051911, 5114.181730923035, 5120.692758434506, 5260.7106609135335, 5003.924941125813, 5056.595472362129, 5103.974480127576, 5138.254953031864, 5307.708076055854], "value": 4684.40068412612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.56377984217346, 398.93218152914, 403.8869116647339, 417.22188119157744, 425.7871064467768, 4986.975065124679, 5193.896122077561, 5237.554807841333, 5275.709835959025, 5303.628745987782, 4955.876103097416, 5076.1370567003605, 5089.821856235032, 5180.715060671661, 5239.816606418776, 4240.688824590606, 4243.411518973424, 4246.108317253381, 4255.765932873698, 4262.46719160105, 4273.188094262096, 4291.0, 4294.26997410441, 4303.353437635863, 4312.460942382202, 4072.511298644167, 4073.739074813477, 4252.319628859384, 4265.552117027714, 4273.957260427387, 4233.661307095425, 4253.490011046096, 4254.978725106354, 4276.144771045772, 4277.230098582254, 3877.3602355611292, 3878.5151856017997, 3889.358255887775, 3891.1633998690136, 3896.883093507199, 5043.722595257259, 5088.669236499616, 5098.719570423626, 5099.71951542665, 5129.974350128263, 4851.902961940777, 4868.440129385131, 4879.2925025871045, 4883.243097319921, 4886.047220791947, 5523.619095226193, 5530.889382212374, 5534.667919924817, 5543.972280138614, 5567.526760225385, 4124.6906482013965, 4147.709660323779, 4192.463559546461, 4237.470316210473, 4288.0, 5571.164325351189, 5613.484359223028, 5616.466435688603, 5651.717414129318, 5656.971715141439, 4371.23503386906, 4373.169097871458, 4380.299152135707, 4395.758233297135, 4396.60430561251, 3992.9800350998057, 4151.667866570667, 4170.7706076166105, 4452.797744608937, 4457.66270118963, 4683.501279590499, 4684.578387945033, 4691.108689349013, 4696.412948381452, 4704.200285951397, 5472.151816468454, 5480.725498917905, 5499.340079190522, 5510.889782204334, 5526.336839579276, 1349.9325033748273, 1392.4987004678308, 1394.0520446096752, 1408.985910140906, 1422.4096999745198, 965.1458459263603, 991.509202944547, 998.7403275148368, 998.9100980911608, 1004.2568499310604, 5193.454687257859, 5222.92165617516, 5224.0, 5252.894942101213, 5270.683758974474, 5416.458354164631, 5418.0, 5444.156155795858, 5444.312263198342, 5449.1826226066405, 5005.6996580205305, 5234.031704134747, 5254.973725131426, 5260.658057226268, 5260.947390526122, 2856.9714902635033, 2857.3142445812855, 2864.6562412510634, 2864.942701145965, 2868.0, 5623.550115990793, 5663.470862867085, 5668.0, 5673.205751194836, 5701.885962280731, 5265.289185959923, 5420.430854760272, 5532.225488431623, 5544.362398324244, 5551.611387202857, 5600.467955544217, 5630.239917611152, 5635.605507614428, 5640.0, 5675.80134695292, 5244.632875698817, 5427.209021023132, 5448.182772584144, 5467.781288748564, 5468.6641148899935, 5347.967772246677, 5360.222767698584, 5361.4370491099435, 5379.462053794589, 5384.757685904222, 5647.6893770843, 5670.716464176692, 5704.3725190228215, 5708.257926469532, 5710.200571919851, 3909.433132195759, 4035.2534781065597, 4075.3683179107284, 4095.7542547447247, 4107.342825147962, 5392.406835248041, 5402.109871218879, 5425.972870135782, 5454.209139674805, 5455.0726376515295, 5268.315119034501, 5301.792415588668, 5308.973455132699, 5332.520073193431, 5341.973290133525, 5041.697498150123, 5242.790288388422, 5266.89466210666, 5283.260343551829, 5330.387005494418, 5242.7902883885745, 5251.0, 5251.553617942518, 5263.184206448007, 5282.683039017671, 5303.178007408704, 5315.4153043166, 5331.4401987790725, 5338.46615338463, 5350.1974703793185, 4979.302897594413, 5111.207762796773, 5131.640785145004, 5165.586753059671, 5201.323827902348], "value": 4216.956288884986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.5545822068754, 816.4937738602067, 826.7974346285162, 906.5071793984629, 912.2565109435807, 13642.795358069625, 15077.547673569783, 15105.848941510581, 15244.237788110591, 15278.236088195588, 14554.417823287056, 14790.926045369759, 14804.851951480481, 14955.252237388115, 14976.101433913973, 685.2393842834438, 698.7624207769358, 699.1435491522894, 701.9894701579481, 802.1697543042952, 822.042320696388, 831.966721331146, 832.134580036761, 832.267604508032, 836.782436566491, 860.4450129666393, 870.2168048756139, 871.094062175337, 872.2672954718035, 872.389327470773, 865.9997702653445, 866.0689758509627, 866.1252135343349, 866.5060915278262, 866.5710473315718, 516.1483552139001, 527.0302643136647, 608.9725962331705, 632.0140580694132, 632.7595513704808, 15874.0, 16870.915645421694, 16903.0, 16915.06967116808, 16916.577085572837, 14400.207988560625, 14705.0, 15298.158601276926, 15351.385944562204, 15680.451184208612, 13952.860471395257, 14527.0, 14585.124892506483, 14681.632959175999, 14690.485832995793, 4780.880477988043, 4786.44955830077, 4787.904241915177, 4803.1114243864995, 4908.950910490921, 80684.0, 81369.0, 81964.59017704934, 82100.58949705273, 82399.5880020602, 11136.547670222257, 11144.442777861075, 11251.493682784294, 11387.0, 11525.827112593317, 21826.454338641342, 21843.235486757887, 21845.235416760337, 21869.0, 21911.233106841184, 8752.168543988311, 8759.430637008574, 8908.510031948175, 9011.459312441275, 9109.77225569366, 4730.574248317668, 4752.95247047532, 4757.452892917358, 4775.450823155312, 4897.314375987365, 3766.0208345830283, 3845.615438456188, 3846.653801157909, 3850.133719912997, 3857.556381016163, 657.3426573426574, 662.9889418636618, 663.698017402081, 663.7610460234312, 669.1434963246954, 786.1509569664748, 791.4736700094488, 792.9484583502054, 812.1026265976011, 841.848467275884, 10658.253922225369, 10678.906024432217, 10881.510332035077, 11053.171012173958, 11212.598425196851, 818.3575892924026, 822.576373167819, 830.9335253179731, 840.2018082821344, 842.2209456253064, 5356.732163391893, 5580.135079062752, 5667.1782591524, 5817.476427121579, 5830.0, 80011.0, 80028.59985700034, 80770.0, 82419.5879020601, 84337.0, 58038.709806451545, 58237.126443103385, 59261.0, 60830.0, 67028.0, 59420.0, 59677.0, 59697.999999999134, 60801.69599151976, 63084.0, 10993.615223467461, 11412.0, 11417.828732568853, 11579.536818527165, 11698.824517632072, 39195.41206881842, 39459.0, 39697.206055878145, 40034.799826000686, 40851.0, 48722.26916596183, 48895.0, 50846.237306439696, 51311.74344128255, 52072.0, 13249.205047697169, 13304.068715189844, 13388.665283367995, 13462.73074538484, 13564.86435135636, 15083.773743393638, 15118.697626047637, 15696.764548531553, 16408.17959102016, 16473.423430179886, 14819.851801482278, 15135.545933622008, 15771.842281577037, 16015.679686405974, 16031.51905442792, 14077.507287244896, 14100.506482273071, 14137.293135342987, 14181.503647372292, 14509.056911300731, 12909.483620655068, 12963.092583519063, 13039.282839443922, 13041.608751737464, 13417.262050587311, 11435.714107147387, 12152.93923530412, 12158.45286962071, 12166.878331216574, 12175.817362739388, 11723.296602203895, 11997.589725457736, 12152.453139608562, 12185.756284874431, 12217.633470995885], "value": 7584.453514549666, "unit": "score"}], "name": "dromaeo_css", "value": 7481.373716104778, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 111.0, 110.0, 111.0, 112.0, 113.0, 112.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 116.0, 148.0, 120.0, 119.0, 122.0, 121.0, 134.0, 116.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 110.0, 75.0, 77.0, 76.0, 75.0, 101.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 103.0, 81.0, 82.0, 83.0, 100.0, 82.0, 82.0, 104.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 51.0, 48.0, 49.0, 49.0, 49.0, 48.0, 48.0, 48.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 64.0, 64.0, 65.0, 65.0, 69.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 80.0, 77.0, 74.0, 84.0, 75.0, 78.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 121.0, 134.0, 121.0, 117.0, 121.0, 123.0, 163.0, 123.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 160.0, 161.0, 160.0, 163.0, 161.0, 165.0, 164.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 59.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1467.4, "alertThreshold": 2.0}]} 15:22:01 INFO - Return code: 0 15:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:01 ERROR - # TBPL SUCCESS # 15:22:01 INFO - Running post-action listener: _resource_record_post_action 15:22:01 INFO - [mozharness: 2017-03-05 23:22:01.115913Z] Finished run-tests step (success) 15:22:01 INFO - Running post-run listener: _resource_record_post_run 15:22:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 362070016; Read time: 208; Write time: 375972 15:22:01 INFO - TinderboxPrint: CPU usage
13.1% 15:22:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 15:22:01 INFO - TinderboxPrint: I/O write bytes / time
362,070,016 / 375,972 15:22:01 INFO - TinderboxPrint: CPU idle
8,263.3 (86.9%) 15:22:01 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 15:22:01 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109469696; Read time: 200; Write time: 100624 15:22:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252219392; Read time: 8; Write time: 275316 15:22:01 INFO - Running post-run listener: _upload_blobber_files 15:22:01 INFO - Blob upload gear active. 15:22:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:01 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 15:22:01 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:01 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:22:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:03 INFO - (blobuploader) - INFO - Done attempting. 15:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:04 INFO - (blobuploader) - INFO - Done attempting. 15:22:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:07 INFO - (blobuploader) - INFO - Done attempting. 15:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:08 INFO - (blobuploader) - INFO - Done attempting. 15:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:08 INFO - Return code: 0 15:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b65d19c08f7003cb10246b887e17b591c3532aeb89c4c0a3eb3db23618ca70acb0a288606ae561105352fb67a2321d97591473a87c6796f36d93c122e17994a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f4b8fa2fd941eb1641b85f7a86d38ecf2aee19cf83f91a7d8216fb1ed6ed905423ab391ef0416c130654bb1a59e86390dcd2a653b6376badf647f79837e0fe69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/02c4e5d48fa6b901f87e37337e2b7f516df1d9e2d6f7fcd039c06efa1df5513f703b72afd0774ed6463cd17570d9e8d55f0eb6c0c3ccb705f1140d0647f85b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0ef3ed6d24ed92eef77b0af8cc930b1364e88dd0310c9a23667bc350123e6e2366b5b65e203457a7f62443795dd9d2e2eef17ea4ee4d02f4de168822274a960"} 15:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:08 INFO - Contents: 15:22:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b65d19c08f7003cb10246b887e17b591c3532aeb89c4c0a3eb3db23618ca70acb0a288606ae561105352fb67a2321d97591473a87c6796f36d93c122e17994a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f4b8fa2fd941eb1641b85f7a86d38ecf2aee19cf83f91a7d8216fb1ed6ed905423ab391ef0416c130654bb1a59e86390dcd2a653b6376badf647f79837e0fe69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/02c4e5d48fa6b901f87e37337e2b7f516df1d9e2d6f7fcd039c06efa1df5513f703b72afd0774ed6463cd17570d9e8d55f0eb6c0c3ccb705f1140d0647f85b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0ef3ed6d24ed92eef77b0af8cc930b1364e88dd0310c9a23667bc350123e6e2366b5b65e203457a7f62443795dd9d2e2eef17ea4ee4d02f4de168822274a960"} 15:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:08 INFO - Copying logs to upload dir... 15:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.645027 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-03-05 15:22:07.616368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 15:22:07.619566) ========= 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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b65d19c08f7003cb10246b887e17b591c3532aeb89c4c0a3eb3db23618ca70acb0a288606ae561105352fb67a2321d97591473a87c6796f36d93c122e17994a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f4b8fa2fd941eb1641b85f7a86d38ecf2aee19cf83f91a7d8216fb1ed6ed905423ab391ef0416c130654bb1a59e86390dcd2a653b6376badf647f79837e0fe69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/02c4e5d48fa6b901f87e37337e2b7f516df1d9e2d6f7fcd039c06efa1df5513f703b72afd0774ed6463cd17570d9e8d55f0eb6c0c3ccb705f1140d0647f85b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0ef3ed6d24ed92eef77b0af8cc930b1364e88dd0310c9a23667bc350123e6e2366b5b65e203457a7f62443795dd9d2e2eef17ea4ee4d02f4de168822274a960"} build_url:https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/WNhDJLyjSmOIcauImldpIg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b65d19c08f7003cb10246b887e17b591c3532aeb89c4c0a3eb3db23618ca70acb0a288606ae561105352fb67a2321d97591473a87c6796f36d93c122e17994a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f4b8fa2fd941eb1641b85f7a86d38ecf2aee19cf83f91a7d8216fb1ed6ed905423ab391ef0416c130654bb1a59e86390dcd2a653b6376badf647f79837e0fe69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/02c4e5d48fa6b901f87e37337e2b7f516df1d9e2d6f7fcd039c06efa1df5513f703b72afd0774ed6463cd17570d9e8d55f0eb6c0c3ccb705f1140d0647f85b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0ef3ed6d24ed92eef77b0af8cc930b1364e88dd0310c9a23667bc350123e6e2366b5b65e203457a7f62443795dd9d2e2eef17ea4ee4d02f4de168822274a960"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 15:22:07.644354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:22:07.644674) ========= 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=ba164b0a7b0ec7655860e956000001c1-1488751989.877843-1106204487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:22:07.727064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 15:22:07.727386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 15:22:07.727675) ========= ========= Total master_lag: 0.16 =========