builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1486659015.05 results: success (0) revision: 1c204002b9bedaa9fb386dda2031e32d664d6871 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.047791) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.048261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.048531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.064832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.065142) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 08:50:15-- 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% 219M=0s 2017-02-09 08:50:15 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.308339 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.387176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.387489) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:15.437903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 08:50:15.438283) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c204002b9bedaa9fb386dda2031e32d664d6871 --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 1c204002b9bedaa9fb386dda2031e32d664d6871 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 08:50:15,790 truncating revision to first 12 chars 2017-02-09 08:50:15,790 Setting DEBUG logging. 2017-02-09 08:50:15,790 attempt 1/10 2017-02-09 08:50:15,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1c204002b9be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 08:50:16,563 unpacking tar archive at: mozilla-aurora-1c204002b9be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.111480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 08:50:16.562134) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:16.562492) ========= script_repo_revision: 1c204002b9bedaa9fb386dda2031e32d664d6871 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:16.562957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:16.563242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 08:50:16.571424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 08:50:16.571719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:50:17 INFO - MultiFileLogger online at 20170209 08:50:17 in /builds/slave/test 08:50:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:50:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:17 INFO - {'append_to_log': False, 08:50:17 INFO - 'base_work_dir': '/builds/slave/test', 08:50:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:17 INFO - 'branch': 'Mozilla-Aurora', 08:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:17 INFO - 'config_files': ('talos/linux_config.py',), 08:50:17 INFO - 'default_actions': ('clobber', 08:50:17 INFO - 'read-buildbot-config', 08:50:17 INFO - 'download-and-extract', 08:50:17 INFO - 'populate-webroot', 08:50:17 INFO - 'create-virtualenv', 08:50:17 INFO - 'install', 08:50:17 INFO - 'run-tests'), 08:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:17 INFO - 'download_minidump_stackwalk': True, 08:50:17 INFO - 'download_symbols': 'ondemand', 08:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:17 INFO - 'installer_path': 'installer.exe', 08:50:17 INFO - 'log_level': 'info', 08:50:17 INFO - 'log_name': 'talos', 08:50:17 INFO - 'log_to_console': True, 08:50:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:50:17 INFO - 'opt_config_files': (), 08:50:17 INFO - 'pip_index': False, 08:50:17 INFO - 'sps_profile': False, 08:50:17 INFO - 'sps_profile_interval': 0, 08:50:17 INFO - 'suite': 'dromaeojs-e10s', 08:50:17 INFO - 'system_bits': '32', 08:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:17 INFO - 'title': 'talos-linux64-ix-068', 08:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:17 INFO - 'use_talos_json': True, 08:50:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:17 INFO - 'work_dir': 'build'} 08:50:17 INFO - [mozharness: 2017-02-09 16:50:17.019365Z] Running clobber step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: clobber 08:50:17 INFO - rmtree: /builds/slave/test/build 08:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:17 INFO - Running post-action listener: _resource_record_post_action 08:50:17 INFO - [mozharness: 2017-02-09 16:50:17.486769Z] Finished clobber step (success) 08:50:17 INFO - [mozharness: 2017-02-09 16:50:17.486871Z] Running read-buildbot-config step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: read_buildbot_config 08:50:17 INFO - Using buildbot properties: 08:50:17 INFO - { 08:50:17 INFO - "project": "", 08:50:17 INFO - "product": "firefox", 08:50:17 INFO - "who": "ffxbld@noreply.mozilla.org", 08:50:17 INFO - "installer_path": "public/build/target.tar.bz2", 08:50:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:50:17 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:50:17 INFO - "stage_platform": "linux64-pgo", 08:50:17 INFO - "basedir": "/builds/slave/test", 08:50:17 INFO - "buildnumber": 859, 08:50:17 INFO - "platform": "ubuntu64_hw", 08:50:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:50:17 INFO - "slavebuilddir": "test", 08:50:17 INFO - "taskId": "MBAAHsg6TduwD5_XIp9yOg", 08:50:17 INFO - "branch": "mozilla-aurora", 08:50:17 INFO - "script_repo_revision": "production", 08:50:17 INFO - "revision": "1c204002b9bedaa9fb386dda2031e32d664d6871", 08:50:17 INFO - "slavename": "talos-linux64-ix-068", 08:50:17 INFO - "repo_path": "releases/mozilla-aurora" 08:50:17 INFO - } 08:50:17 INFO - Finding installer, test and symbols from parent task. 08:50:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MBAAHsg6TduwD5_XIp9yOg'}, attempt #1 08:50:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MBAAHsg6TduwD5_XIp9yOg'}, attempt #1 08:50:18 INFO - Task dependencies: bxXyMWRFQf-SndmpKA-mVQ 08:50:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ'}, attempt #1 08:50:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 08:50:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/test_packages.json 08:50:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.crashreporter-symbols.zip 08:50:18 INFO - Running post-action listener: _resource_record_post_action 08:50:18 INFO - [mozharness: 2017-02-09 16:50:18.930615Z] Finished read-buildbot-config step (success) 08:50:18 INFO - [mozharness: 2017-02-09 16:50:18.930880Z] Running download-and-extract step. 08:50:18 INFO - Running pre-action listener: _resource_record_pre_action 08:50:18 INFO - Running main action method: download_and_extract 08:50:18 INFO - mkdir: /builds/slave/test/build/tests 08:50:18 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')]} 08:50:18 INFO - trying https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.test_packages.json 08:50:18 INFO - Downloading https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:50:19 INFO - Downloaded 896 bytes. 08:50:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:50:19 INFO - Using the following test package requirements: 08:50:19 INFO - {u'common': [u'target.common.tests.zip'], 08:50:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:50:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:50:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:50:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:50:19 INFO - u'mozbase': [u'target.common.tests.zip'], 08:50:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:50:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:50:19 INFO - u'web-platform': [u'target.common.tests.zip', 08:50:19 INFO - u'target.web-platform.tests.zip'], 08:50:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:50:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:50:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip 08:50:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:50:19 INFO - Fetch https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip into memory 08:50:20 INFO - Expected file size: 21854920 08:50:20 INFO - Obtained file size: 21854920 08:50:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:50:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip 08:50:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:50:24 INFO - Fetch https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.common.tests.zip into memory 08:50:25 INFO - Expected file size: 21854920 08:50:25 INFO - Obtained file size: 21854920 08:50:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.talos.tests.zip 08:50:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:50:29 INFO - Fetch https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.talos.tests.zip into memory 08:50:30 INFO - Expected file size: 14403485 08:50:30 INFO - Obtained file size: 14403485 08:50: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')]} 08:50:31 INFO - trying https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 08:50:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:50:32 INFO - Downloaded 66068169 bytes. 08:50:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 08:50:32 INFO - mkdir: /builds/slave/test/properties 08:50:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:32 INFO - Contents: 08:50:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 08:50:32 INFO - Running post-action listener: _resource_record_post_action 08:50:32 INFO - Running post-action listener: set_extra_try_arguments 08:50:32 INFO - [mozharness: 2017-02-09 16:50:32.362295Z] Finished download-and-extract step (success) 08:50:32 INFO - [mozharness: 2017-02-09 16:50:32.362391Z] Running populate-webroot step. 08:50:32 INFO - Running pre-action listener: _resource_record_pre_action 08:50:32 INFO - Running main action method: populate_webroot 08:50:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:32 INFO - '--tppagecycles', 08:50:32 INFO - '7'], 08:50:32 INFO - 'tests': ['tsvgm']}}, 08:50:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['damp', 'tps']}, 08:50:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'tests': ['damp', 'tps']}, 08:50:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['dromaeo_dom']}, 08:50:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['basic_compositor_video']}, 08:50:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:50:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['a11yr', 08:50:32 INFO - 'ts_paint', 08:50:32 INFO - 'tpaint', 08:50:32 INFO - 'sessionrestore', 08:50:32 INFO - 'sessionrestore_no_auto_restore', 08:50:32 INFO - 'tabpaint']}, 08:50:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['tsvgx', 08:50:32 INFO - 'tsvgr_opacity', 08:50:32 INFO - 'tart', 08:50:32 INFO - 'tscrollx', 08:50:32 INFO - 'cart', 08:50:32 INFO - 'tsvg_static']}, 08:50:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:32 INFO - 'tsvgr_opacity', 08:50:32 INFO - 'tart', 08:50:32 INFO - 'tscrollx', 08:50:32 INFO - 'cart', 08:50:32 INFO - 'tsvg_static']}, 08:50:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'talos_options': ['--disable-e10s'], 08:50:32 INFO - 'tests': ['tp5o']}, 08:50:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:50:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'talos_options': ['--disable-e10s', 08:50:32 INFO - '--xperf_path', 08:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:32 INFO - 'tests': ['tp5n']}, 08:50:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:50:32 INFO - 'talos_options': ['--xperf_path', 08:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:32 INFO - 'tests': ['tp5n']}}, 08:50:32 INFO - 'talos.zip': {'path': '', 08:50:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:32 INFO - Running post-action listener: _resource_record_post_action 08:50:32 INFO - [mozharness: 2017-02-09 16:50:32.375484Z] Finished populate-webroot step (success) 08:50:32 INFO - [mozharness: 2017-02-09 16:50:32.375575Z] Running create-virtualenv step. 08:50:32 INFO - Running pre-action listener: _resource_record_pre_action 08:50:32 INFO - Running main action method: create_virtualenv 08:50:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:32 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 08:50:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:32 INFO - Using real prefix '/usr' 08:50:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:34 INFO - Installing pip.................done. 08:50:34 INFO - Return code: 0 08:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:35 INFO - Reading from file tmpfile_stdout 08:50:35 INFO - Output received: 08:50:35 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) 08:50:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:50:35 INFO - Using env: {'DISPLAY': ':0', 08:50:35 INFO - 'HOME': '/home/cltbld', 08:50:35 INFO - 'LANG': 'en_US.UTF-8', 08:50:35 INFO - 'LANGUAGE': 'en_US:en', 08:50:35 INFO - 'LOGNAME': 'cltbld', 08:50:35 INFO - 'MAIL': '/var/mail/cltbld', 08:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:35 INFO - 'MOZ_NO_REMOTE': '1', 08:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:35 INFO - 'NO_EM_RESTART': '1', 08:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:35 INFO - 'PWD': '/builds/slave/test', 08:50:35 INFO - 'SHELL': '/bin/bash', 08:50:35 INFO - 'SHLVL': '1', 08:50:35 INFO - 'TERM': 'linux', 08:50:35 INFO - 'TMOUT': '86400', 08:50:35 INFO - 'USER': 'cltbld', 08:50:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:35 INFO - '_': '/tools/buildbot/bin/python'} 08:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:35 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 08:50:35 INFO - Cleaning up... 08:50:35 INFO - Return code: 0 08:50:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:50:35 INFO - Using env: {'DISPLAY': ':0', 08:50:35 INFO - 'HOME': '/home/cltbld', 08:50:35 INFO - 'LANG': 'en_US.UTF-8', 08:50:35 INFO - 'LANGUAGE': 'en_US:en', 08:50:35 INFO - 'LOGNAME': 'cltbld', 08:50:35 INFO - 'MAIL': '/var/mail/cltbld', 08:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:35 INFO - 'MOZ_NO_REMOTE': '1', 08:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:35 INFO - 'NO_EM_RESTART': '1', 08:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:35 INFO - 'PWD': '/builds/slave/test', 08:50:35 INFO - 'SHELL': '/bin/bash', 08:50:35 INFO - 'SHLVL': '1', 08:50:35 INFO - 'TERM': 'linux', 08:50:35 INFO - 'TMOUT': '86400', 08:50:35 INFO - 'USER': 'cltbld', 08:50:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:35 INFO - '_': '/tools/buildbot/bin/python'} 08:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:35 INFO - Downloading/unpacking psutil>=3.1.1 08:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:37 INFO - Installing collected packages: psutil 08:50:37 INFO - Running setup.py install for psutil 08:50:37 INFO - building 'psutil._psutil_linux' extension 08:50:37 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 08:50:38 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 08:50:38 INFO - building 'psutil._psutil_posix' extension 08:50:38 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 08:50:38 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 08:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:38 INFO - Successfully installed psutil 08:50:38 INFO - Cleaning up... 08:50:38 INFO - Return code: 0 08:50:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:50:38 INFO - Using env: {'DISPLAY': ':0', 08:50:38 INFO - 'HOME': '/home/cltbld', 08:50:38 INFO - 'LANG': 'en_US.UTF-8', 08:50:38 INFO - 'LANGUAGE': 'en_US:en', 08:50:38 INFO - 'LOGNAME': 'cltbld', 08:50:38 INFO - 'MAIL': '/var/mail/cltbld', 08:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:38 INFO - 'MOZ_NO_REMOTE': '1', 08:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:38 INFO - 'NO_EM_RESTART': '1', 08:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:38 INFO - 'PWD': '/builds/slave/test', 08:50:38 INFO - 'SHELL': '/bin/bash', 08:50:38 INFO - 'SHLVL': '1', 08:50:38 INFO - 'TERM': 'linux', 08:50:38 INFO - 'TMOUT': '86400', 08:50:38 INFO - 'USER': 'cltbld', 08:50:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:38 INFO - '_': '/tools/buildbot/bin/python'} 08:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:40 INFO - Installing collected packages: mozsystemmonitor 08:50:40 INFO - Running setup.py install for mozsystemmonitor 08:50:40 INFO - Successfully installed mozsystemmonitor 08:50:40 INFO - Cleaning up... 08:50:40 INFO - Return code: 0 08:50:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:40 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:40 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 08:50:40 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 08:50:40 INFO - Using env: {'DISPLAY': ':0', 08:50:40 INFO - 'HOME': '/home/cltbld', 08:50:40 INFO - 'LANG': 'en_US.UTF-8', 08:50:40 INFO - 'LANGUAGE': 'en_US:en', 08:50:40 INFO - 'LOGNAME': 'cltbld', 08:50:40 INFO - 'MAIL': '/var/mail/cltbld', 08:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:40 INFO - 'MOZ_NO_REMOTE': '1', 08:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:40 INFO - 'NO_EM_RESTART': '1', 08:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:40 INFO - 'PWD': '/builds/slave/test', 08:50:40 INFO - 'SHELL': '/bin/bash', 08:50:40 INFO - 'SHLVL': '1', 08:50:40 INFO - 'TERM': 'linux', 08:50:40 INFO - 'TMOUT': '86400', 08:50:40 INFO - 'USER': 'cltbld', 08:50:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:40 INFO - '_': '/tools/buildbot/bin/python'} 08:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:41 INFO - Downloading/unpacking jsonschema==2.5.1 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:43 INFO - warning: no files found matching '*.txt' 08:50:43 INFO - no previously-included directories found matching 'build' 08:50:43 INFO - no previously-included directories found matching 'dist' 08:50:43 INFO - no previously-included directories found matching '.git*' 08:50:43 INFO - Installing collected packages: jsonschema, functools32 08:50:43 INFO - Running setup.py install for functools32 08:50:43 INFO - warning: no files found matching '*.txt' 08:50:43 INFO - no previously-included directories found matching 'build' 08:50:43 INFO - no previously-included directories found matching 'dist' 08:50:43 INFO - no previously-included directories found matching '.git*' 08:50:43 INFO - Successfully installed jsonschema functools32 08:50:43 INFO - Cleaning up... 08:50:43 INFO - Return code: 0 08:50:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50:43 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')]} 08:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 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')]} 08:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:43 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 08:50:43 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 08:50:43 INFO - Using env: {'DISPLAY': ':0', 08:50:43 INFO - 'HOME': '/home/cltbld', 08:50:43 INFO - 'LANG': 'en_US.UTF-8', 08:50:43 INFO - 'LANGUAGE': 'en_US:en', 08:50:43 INFO - 'LOGNAME': 'cltbld', 08:50:43 INFO - 'MAIL': '/var/mail/cltbld', 08:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:43 INFO - 'MOZ_NO_REMOTE': '1', 08:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:43 INFO - 'NO_EM_RESTART': '1', 08:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:43 INFO - 'PWD': '/builds/slave/test', 08:50:43 INFO - 'SHELL': '/bin/bash', 08:50:43 INFO - 'SHLVL': '1', 08:50:43 INFO - 'TERM': 'linux', 08:50:43 INFO - 'TMOUT': '86400', 08:50:43 INFO - 'USER': 'cltbld', 08:50:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:43 INFO - '_': '/tools/buildbot/bin/python'} 08:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:43 INFO - Cleaning up... 08:50:43 INFO - Return code: 0 08:50:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:43 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')]} 08:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 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')]} 08:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:43 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 08:50:43 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 08:50:43 INFO - Using env: {'DISPLAY': ':0', 08:50:43 INFO - 'HOME': '/home/cltbld', 08:50:43 INFO - 'LANG': 'en_US.UTF-8', 08:50:43 INFO - 'LANGUAGE': 'en_US:en', 08:50:43 INFO - 'LOGNAME': 'cltbld', 08:50:43 INFO - 'MAIL': '/var/mail/cltbld', 08:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:43 INFO - 'MOZ_NO_REMOTE': '1', 08:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:43 INFO - 'NO_EM_RESTART': '1', 08:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:43 INFO - 'PWD': '/builds/slave/test', 08:50:43 INFO - 'SHELL': '/bin/bash', 08:50:43 INFO - 'SHLVL': '1', 08:50:43 INFO - 'TERM': 'linux', 08:50:43 INFO - 'TMOUT': '86400', 08:50:43 INFO - 'USER': 'cltbld', 08:50:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:43 INFO - '_': '/tools/buildbot/bin/python'} 08:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 INFO - Downloading docopt-0.6.1.tar.gz 08:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:46 INFO - Running setup.py install for blobuploader 08:50:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:46 INFO - Running setup.py install for requests 08:50:47 INFO - Running setup.py install for docopt 08:50:47 INFO - Successfully installed blobuploader requests docopt 08:50:47 INFO - Cleaning up... 08:50:47 INFO - Return code: 0 08:50:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:47 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')]} 08:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:47 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')]} 08:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:47 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:47 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 08:50:47 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 08:50:47 INFO - Using env: {'DISPLAY': ':0', 08:50:47 INFO - 'HOME': '/home/cltbld', 08:50:47 INFO - 'LANG': 'en_US.UTF-8', 08:50:47 INFO - 'LANGUAGE': 'en_US:en', 08:50:47 INFO - 'LOGNAME': 'cltbld', 08:50:47 INFO - 'MAIL': '/var/mail/cltbld', 08:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:47 INFO - 'MOZ_NO_REMOTE': '1', 08:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:47 INFO - 'NO_EM_RESTART': '1', 08:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:47 INFO - 'PWD': '/builds/slave/test', 08:50:47 INFO - 'SHELL': '/bin/bash', 08:50:47 INFO - 'SHLVL': '1', 08:50:47 INFO - 'TERM': 'linux', 08:50:47 INFO - 'TMOUT': '86400', 08:50:47 INFO - 'USER': 'cltbld', 08:50:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:47 INFO - '_': '/tools/buildbot/bin/python'} 08:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:47 INFO - Running setup.py (path:/tmp/pip-3IzHEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:47 INFO - Running setup.py (path:/tmp/pip-z9wtf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:47 INFO - Running setup.py (path:/tmp/pip-ToxsQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:47 INFO - Running setup.py (path:/tmp/pip-FdgIQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:47 INFO - Running setup.py (path:/tmp/pip-Iw82A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:48 INFO - Running setup.py (path:/tmp/pip-4BwSC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:48 INFO - Running setup.py (path:/tmp/pip-_gSYyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:48 INFO - Running setup.py (path:/tmp/pip-THSYhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:48 INFO - Running setup.py (path:/tmp/pip-NLa6Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:48 INFO - Running setup.py (path:/tmp/pip-3X0NYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:48 INFO - Running setup.py (path:/tmp/pip-shguPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:48 INFO - Running setup.py (path:/tmp/pip-ldj432-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:48 INFO - Running setup.py (path:/tmp/pip-oOnEkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:48 INFO - Running setup.py (path:/tmp/pip-bI2WGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:48 INFO - Running setup.py (path:/tmp/pip-Y9y9kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:48 INFO - Running setup.py (path:/tmp/pip-u8dhN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:48 INFO - Running setup.py (path:/tmp/pip-vzs5Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:48 INFO - Running setup.py install for manifestparser 08:50:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozcrash 08:50:49 INFO - Running setup.py install for mozdebug 08:50:49 INFO - Running setup.py install for mozdevice 08:50:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozfile 08:50:49 INFO - Running setup.py install for mozhttpd 08:50:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozinfo 08:50:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozInstall 08:50:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozleak 08:50:49 INFO - Running setup.py install for mozlog 08:50:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for moznetwork 08:50:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozprocess 08:50:50 INFO - Running setup.py install for mozprofile 08:50:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozrunner 08:50:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozscreenshot 08:50:50 INFO - Running setup.py install for moztest 08:50:50 INFO - Running setup.py install for mozversion 08:50:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:50 INFO - Cleaning up... 08:50:50 INFO - Return code: 0 08:50:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:50 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')]} 08:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:50 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')]} 08:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:50 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:50 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 08:50:50 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 08:50:50 INFO - Using env: {'DISPLAY': ':0', 08:50:50 INFO - 'HOME': '/home/cltbld', 08:50:50 INFO - 'LANG': 'en_US.UTF-8', 08:50:50 INFO - 'LANGUAGE': 'en_US:en', 08:50:50 INFO - 'LOGNAME': 'cltbld', 08:50:50 INFO - 'MAIL': '/var/mail/cltbld', 08:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:50 INFO - 'MOZ_NO_REMOTE': '1', 08:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:50 INFO - 'NO_EM_RESTART': '1', 08:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:50 INFO - 'PWD': '/builds/slave/test', 08:50:50 INFO - 'SHELL': '/bin/bash', 08:50:50 INFO - 'SHLVL': '1', 08:50:50 INFO - 'TERM': 'linux', 08:50:50 INFO - 'TMOUT': '86400', 08:50:50 INFO - 'USER': 'cltbld', 08:50:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:50 INFO - '_': '/tools/buildbot/bin/python'} 08:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:50 INFO - Running setup.py (path:/tmp/pip-ROfbmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:51 INFO - Running setup.py (path:/tmp/pip-wvSpIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:51 INFO - Running setup.py (path:/tmp/pip-QPVAnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:51 INFO - Running setup.py (path:/tmp/pip-JsMDne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:51 INFO - Running setup.py (path:/tmp/pip-5YToo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:51 INFO - Running setup.py (path:/tmp/pip-er1o2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:51 INFO - Running setup.py (path:/tmp/pip-aPT1HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:51 INFO - Running setup.py (path:/tmp/pip-x5hGQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:51 INFO - Running setup.py (path:/tmp/pip-SFjeGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:51 INFO - Running setup.py (path:/tmp/pip-i8XJ05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:51 INFO - Running setup.py (path:/tmp/pip-nYfUYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:51 INFO - Running setup.py (path:/tmp/pip-bmWM0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:51 INFO - Running setup.py (path:/tmp/pip-teigAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:51 INFO - Running setup.py (path:/tmp/pip-odGit9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:52 INFO - Running setup.py (path:/tmp/pip-9AG28Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:52 INFO - Running setup.py (path:/tmp/pip-zpxsRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:52 INFO - Running setup.py (path:/tmp/pip-nuktQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:52 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)) 08:50:52 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)) 08:50:52 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)) 08:50:52 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)) 08:50:52 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)) 08:50:52 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)) 08:50:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:54 INFO - Downloading blessings-1.6.tar.gz 08:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:54 INFO - Installing collected packages: blessings 08:50:54 INFO - Running setup.py install for blessings 08:50:54 INFO - Successfully installed blessings 08:50:54 INFO - Cleaning up... 08:50:54 INFO - Return code: 0 08:50:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:54 INFO - Reading from file tmpfile_stdout 08:50:54 INFO - Current package versions: 08:50:54 INFO - argparse == 1.2.1 08:50:54 INFO - blessings == 1.6 08:50:54 INFO - blobuploader == 1.2.4 08:50:54 INFO - docopt == 0.6.1 08:50:54 INFO - functools32 == 3.2.3-2 08:50:54 INFO - jsonschema == 2.5.1 08:50:54 INFO - manifestparser == 1.1 08:50:54 INFO - mozInstall == 1.12 08:50:54 INFO - mozcrash == 1.0 08:50:54 INFO - mozdebug == 0.1 08:50:54 INFO - mozdevice == 0.49 08:50:54 INFO - mozfile == 1.2 08:50:54 INFO - mozhttpd == 0.7 08:50:54 INFO - mozinfo == 0.9 08:50:54 INFO - mozleak == 0.1 08:50:54 INFO - mozlog == 3.4 08:50:54 INFO - moznetwork == 0.27 08:50:54 INFO - mozprocess == 0.24 08:50:54 INFO - mozprofile == 0.28 08:50:54 INFO - mozrunner == 6.13 08:50:54 INFO - mozscreenshot == 0.1 08:50:54 INFO - mozsystemmonitor == 0.3 08:50:54 INFO - moztest == 0.8 08:50:54 INFO - mozversion == 1.4 08:50:54 INFO - psutil == 3.1.1 08:50:54 INFO - requests == 1.2.3 08:50:54 INFO - wsgiref == 0.1.2 08:50:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:54 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 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50:54 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 08:50:54 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 08:50:54 INFO - Using env: {'DISPLAY': ':0', 08:50:54 INFO - 'HOME': '/home/cltbld', 08:50:54 INFO - 'LANG': 'en_US.UTF-8', 08:50:54 INFO - 'LANGUAGE': 'en_US:en', 08:50:54 INFO - 'LOGNAME': 'cltbld', 08:50:54 INFO - 'MAIL': '/var/mail/cltbld', 08:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:54 INFO - 'MOZ_NO_REMOTE': '1', 08:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:54 INFO - 'NO_EM_RESTART': '1', 08:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:54 INFO - 'PWD': '/builds/slave/test', 08:50:54 INFO - 'SHELL': '/bin/bash', 08:50:54 INFO - 'SHLVL': '1', 08:50:54 INFO - 'TERM': 'linux', 08:50:54 INFO - 'TMOUT': '86400', 08:50:54 INFO - 'USER': 'cltbld', 08:50:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:54 INFO - '_': '/tools/buildbot/bin/python'} 08:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 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)) 08:50:54 INFO - Cleaning up... 08:50:54 INFO - Return code: 0 08:50:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', '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 08:50: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'] in /builds/slave/test/build 08:50: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 08:50:54 INFO - Using env: {'DISPLAY': ':0', 08:50:54 INFO - 'HOME': '/home/cltbld', 08:50:54 INFO - 'LANG': 'en_US.UTF-8', 08:50:54 INFO - 'LANGUAGE': 'en_US:en', 08:50:54 INFO - 'LOGNAME': 'cltbld', 08:50:54 INFO - 'MAIL': '/var/mail/cltbld', 08:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:54 INFO - 'MOZ_NO_REMOTE': '1', 08:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:54 INFO - 'NO_EM_RESTART': '1', 08:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:54 INFO - 'PWD': '/builds/slave/test', 08:50:54 INFO - 'SHELL': '/bin/bash', 08:50:54 INFO - 'SHLVL': '1', 08:50:54 INFO - 'TERM': 'linux', 08:50:54 INFO - 'TMOUT': '86400', 08:50:54 INFO - 'USER': 'cltbld', 08:50:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:54 INFO - '_': '/tools/buildbot/bin/python'} 08:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:55 INFO - Cleaning up... 08:50:55 INFO - Return code: 0 08:50:55 INFO - Running post-action listener: _resource_record_post_action 08:50:55 INFO - Running post-action listener: _start_resource_monitoring 08:50:55 INFO - Starting resource monitoring. 08:50:55 INFO - [mozharness: 2017-02-09 16:50:55.231842Z] Finished create-virtualenv step (success) 08:50:55 INFO - [mozharness: 2017-02-09 16:50:55.232286Z] Running install step. 08:50:55 INFO - Running pre-action listener: _resource_record_pre_action 08:50:55 INFO - Running main action method: install 08:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:55 INFO - Reading from file tmpfile_stdout 08:50:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:55 INFO - Reading from file tmpfile_stdout 08:50:55 INFO - Output received: 08:50:55 INFO - Usage: mozinstall [options] installer 08:50:55 INFO - Options: 08:50:55 INFO - -h, --help show this help message and exit 08:50:55 INFO - -d DEST, --destination=DEST 08:50:55 INFO - Directory to install application into. [default: 08:50:55 INFO - "/builds/slave/test"] 08:50:55 INFO - --app=APP Application being installed. [default: firefox] 08:50:55 INFO - mkdir: /builds/slave/test/build/application 08:50:55 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'] 08:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:51:12 INFO - Reading from file tmpfile_stdout 08:51:12 INFO - Output received: 08:51:12 INFO - /builds/slave/test/build/application/firefox/firefox 08:51:12 INFO - Running post-action listener: _resource_record_post_action 08:51:12 INFO - [mozharness: 2017-02-09 16:51:12.013246Z] Finished install step (success) 08:51:12 INFO - [mozharness: 2017-02-09 16:51:12.013523Z] Running run-tests step. 08:51:12 INFO - Running pre-action listener: _resource_record_pre_action 08:51:12 INFO - Running main action method: run_tests 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:12 INFO - Python 2.7.3 08:51:12 INFO - Return code: 0 08:51:12 INFO - grabbing minidump binary from tooltool 08:51:12 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')]} 08:51:12 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 0x184a820>, '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 0x184b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x184b9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:12 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 08:51:12 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 08:51:12 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 08:51:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:12 INFO - Return code: 0 08:51:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:51:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:51:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:51:12 INFO - Using env: {'DISPLAY': ':0', 08:51:12 INFO - 'HOME': '/home/cltbld', 08:51:12 INFO - 'LANG': 'en_US.UTF-8', 08:51:12 INFO - 'LANGUAGE': 'en_US:en', 08:51:12 INFO - 'LOGNAME': 'cltbld', 08:51:12 INFO - 'MAIL': '/var/mail/cltbld', 08:51:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:12 INFO - 'MOZ_NO_REMOTE': '1', 08:51:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:12 INFO - 'NO_EM_RESTART': '1', 08:51:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:12 INFO - 'PWD': '/builds/slave/test', 08:51:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:12 INFO - 'SHELL': '/bin/bash', 08:51:12 INFO - 'SHLVL': '1', 08:51:12 INFO - 'TERM': 'linux', 08:51:12 INFO - 'TMOUT': '86400', 08:51:12 INFO - 'USER': 'cltbld', 08:51:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691', 08:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:12 INFO - '_': '/tools/buildbot/bin/python'} 08:51:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:51:12 INFO - mozversion application_buildid: 20170209155318 08:51:12 INFO - mozversion application_changeset: 1c204002b9bedaa9fb386dda2031e32d664d6871 08:51:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:51:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:12 INFO - mozversion application_name: Firefox 08:51:12 INFO - mozversion application_remotingname: firefox-dev 08:51:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:51:12 INFO - mozversion application_vendor: Mozilla 08:51:12 INFO - mozversion application_version: 53.0a2 08:51:12 INFO - mozversion platform_buildid: 20170209155318 08:51:12 INFO - mozversion platform_changeset: 1c204002b9bedaa9fb386dda2031e32d664d6871 08:51:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:51:12 INFO - mozversion platform_version: 53.0a2 08:51:12 INFO - using testdate: 1486659072 08:51:12 INFO - actual date: 1486659072 08:51:12 INFO - starting webserver on 'localhost:46887' 08:51:12 INFO - SUITE-START | Running 2 tests 08:51:12 INFO - TEST-START | dromaeo_css 08:51:12 INFO - operating with platform_type : linux_ 08:51:12 INFO - Initialising browser for dromaeo_css test... 08:51:12 INFO - TEST-INFO | started process 16647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCXdVA/profile http://localhost:46887/getInfo.html) 08:51:16 INFO - PROCESS | 16647 | __metrics Screen width/height:1600/1200 08:51:16 INFO - PROCESS | 16647 | colorDepth:24 08:51:16 INFO - PROCESS | 16647 | Browser inner width/height: 1024/697 08:51:16 INFO - PROCESS | 16647 | __metrics 08:51:17 INFO - PROCESS | 16647 | 1486659077536 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmplCXdVA/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmplCXdVA/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmplCXdVA/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmplCXdVA/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:51:17 ERROR - PROCESS | 16647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:51:18 INFO - TEST-INFO | 16647: exit 0 08:51:18 INFO - Browser initialized. 08:51:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:18 INFO - TEST-INFO | started process 16775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCXdVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:30 INFO - PROCESS | 16775 | RSS: Main: 144330752 08:51:30 INFO - PROCESS | 16775 | 08:54:28 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46887/tests/dromaeo/cssquery-ext.html) 08:54:30 INFO - PROCESS | 16775 | RSS: Main: 152485888 08:54:30 INFO - PROCESS | 16775 | 08:56:18 INFO - PROCESS | 16775 | ************************* 08:56:18 INFO - PROCESS | 16775 | A coding exception was thrown and uncaught in a Task. 08:56:18 INFO - PROCESS | 16775 | 08:56:18 ERROR - PROCESS | 16775 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:56:18 INFO - PROCESS | 16775 | Full stack: 08:56:18 INFO - PROCESS | 16775 | ************************* 08:57:32 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-ext.html (next: http://localhost:46887/tests/dromaeo/cssquery-jquery.html) 08:57:33 INFO - PROCESS | 16775 | RSS: Main: 149925888 08:57:33 INFO - PROCESS | 16775 | 09:00:34 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46887/tests/dromaeo/cssquery-mootools.html) 09:00:35 INFO - PROCESS | 16775 | RSS: Main: 153055232 09:00:35 INFO - PROCESS | 16775 | 09:03:37 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46887/tests/dromaeo/cssquery-prototype.html) 09:03:37 INFO - PROCESS | 16775 | RSS: Main: 149647360 09:03:37 INFO - PROCESS | 16775 | 09:06:40 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46887/tests/dromaeo/cssquery-yui.html) 09:06:40 INFO - PROCESS | 16775 | RSS: Main: 153153536 09:06:40 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-yui.html (next: http://localhost:46887/tests/dromaeo/cssquery-dojo.html) 09:09:43 INFO - PROCESS | 16775 | RSS: Main: 153796608 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | __start_tp_report 09:09:43 INFO - PROCESS | 16775 | _x_x_mozilla_page_load 09:09:43 INFO - PROCESS | 16775 | _x_x_mozilla_page_load_details 09:09:43 INFO - PROCESS | 16775 | |i|pagename|runs| 09:09:43 INFO - PROCESS | 16775 | |0;dojo.html;3256.4789633658615;3275.181204698824;3284.293876816484;3285.0965984354316;3290.703836654702;5483.670979741213;5488.231647569339;5520.447955204478;5531.087370583854;5546.639468434559;5463.535599474039;5550.27846379971;5554.9722251388785;5557.3331200256025;5579.163125531162;4952.603791696664;4992.575631071363;4997.275395067713;5033.697978121306;5057.57010654093;5009.373828271466;5060.291559181717;5060.418051924021;5062.240663900426;5086.618503612225;4850.757462126897;4906.386701662293;5049.242613607951;5059.924101138486;5060.898782024376;4929;5003.049420610072;5015.899682006339;5053.545180933734;5106.285120083154;4946.752662366867;5027.899442011139;5027.899442011176;5042.520960508746;5054.1407960646775;5290.1800220965815;5425.13197888336;5441.238226648273;5579.69311687857;5601.747921343549;5719.227904232917;5759.65442073477;5826.737796799154;5831.708414579297;5924.763009479659;5924.1113832924975;5932.940670593325;5946.791862284799;5953.13679516472;5953.821385358447;5532.640378375433;5542.334919809648;5543.085390910535;5563.276774019392;5571.108622620402;5832.737526811304;5840.591158618856;5879.7060146993335;5886.05823068307;5914.467697907209;5702.971485142548;5759.740811663485;5762.94237057624;5766.106253530709;5773;5793.797217097382;5837.09525023622;5867.471927526543;5874.618149820248;5885.117232415087;5687.260656114679;5721.742521586539;5739.598228124075;5781.682007489629;5820.534357251409;5787.536997040227;5796.217510636095;5846.298444186725;5847.26909136358;5865.472107510344;4527.705699129612;4546.04533048057;4556.498785133633;4556.954430455719;4581.885452863705;3947.8618248361745;4004.3192657248337;4016.2770701274053;4059.7564146151326;4079.3065178919655;5630.774769009194;5679.716014199274;5687.544996400278;5732;5792.160136780228;5937.940620593825;5940.435658612425;5955.821325360246;5956.106584012433;5958.523318134538;5554.250176226238;5580.358258800209;5637.238972738628;5710.65736055838;5721.141828725725;5028.069807085701;5060.7216603086445;5062.949370506248;5093.796248150106;5095.15929871567;6099.054646529795;6120.724567394478;6130.448259656652;6132.908006379907;6143.877122457526;5653.632513886584;5705.258316418839;5912.379200184091;5927.229460170151;5933.940660593339;6017.578769486094;6046.244219472566;6060.363661815622;6120.050983828623;6120.294761999531;5807.390224026416;5821.883562328645;5840.795572154954;5843.240378750906;5863.706814659336;5726.713664316851;5876.676782776817;5924.348321684525;5951.583389162717;5957.970210148921;5630.071038278638;5675.318961724454;5724.341700704473;5732.799352022659;5823.970880145572;5765.798197063251;5776.306843178845;5787.189793428839;5788.479036886701;5794.82615521535;5577.717125061177;5690.37405885344;5716.771329146954;5718.199452076796;5729.742161602821;5547;5595.07681232592;5675.687837168995;5738.741756620879;5836.212111364912;5655.688937108499;5695.943040569707;5699.145128230799;5711.628744131618;5725.484706376446 09:09:43 INFO - PROCESS | 16775 | |1;ext.html;558.9636673616214;590.5393792841583;623.8253289079058;695.0651373902106;698.7833771530823;46090.76954615227;47517.28724069142;50965.745171274095;51092.48907510924;51451.48548514514;37450.43824342637;37876.81061594688;37919.431208531896;37979.62020379795;38056.80971595138;9272.814543709123;10581.947090264577;11020.779584408307;11048.06091482225;11299.209055366127;10775.946120269387;10834.295770774914;10837.783244335109;10865.45672716361;10889.346639201634;10860.728481787939;10959.616413425532;10970.232083754141;10971.177161712903;10972.286801357886;10768;10808.891911080867;10818.99999999996;10821.621243256448;10843.403612801292;11045.668629941114;11120.888791112147;11129.72175695606;11133.944330278297;11145;43628.127437451076;43987.34018989718;44187.77906110449;44287.55712442866;44409.11181776378;4400.7579583122915;4501.977490112528;4526.479454862667;4558.270676691746;4623.0522742837975;31947.840260798548;31982.360352793046;32580.674193258;32796.83601581977;33266.50100248498;4684.672072954894;4791.233402655594;4812.831550895702;4821.325014497973;4863.781129849165;355778;358011;358342;359762;359857;62865.37134628687;63012.684936575024;63292.68353658295;63445.36554634394;63608.68195658992;65216.347836521025;65474.34525654778;65638;65892.34107658958;65985;16714.916425417796;16947.745783813254;17108.144592770313;17129;17174.141292935303;14654.267286635626;15361.078335299917;15454.227288635524;15474.690506189812;15475.303611337516;20570.485737856376;20589.794102058786;20598.38204853857;20749;20757.584848303253;7235.746748863765;7376.151742549676;7460.925390746132;7462.96268518654;7478.738244161428;981.896900825403;994.4778991029767;997.152420442618;1008.4201584089178;1029.953652085658;32948.341033179204;33242.33515329728;33359.33281334408;33612.831935840164;33639.83180084084;1193.1826698711411;1197.6766273106211;1209.3771707570609;1221.4625564751482;1235.2279825109306;17670.558236043944;18131.18409671568;18170.27318907255;18218.180181891847;18272.817271827378;544414;545336;554331;554806;560543;71751.64124179346;72225;72533.637331813;72769.63615181891;73052.26947730561;1545.2659986506544;1559.8050243719536;1568.6705791783625;1587.7538981457892;1596.146061856901;32468;32668;32944.67055329512;33462.12445604034;33478.497822533165;60955.78088438295;62457.375426245155;62476.375236247055;62535;62597;485696;489300;489550;489820;490132;29391;30066.54900176543;30355.392892142474;32202.194945125622;32588.185295367806;48488.27267590918;49227.75386123046;49746.751266244886;50450;53656;41954;43540.56459435365;43769.56230437655;44136.558634413246;44434.555654443044;43058.784706077524;43201.3519797197;43240.135197296506;43572.78213608912;44125.33811992758;40105.79947100246;40903;41409.1718165641;42592.36111458269;42852.5714742861;34798;36199.63800361963;36223.094422639646;36470;36930;28213.294667632654;28332;28408.193460027458;28411.43177136487;28455.715442845307 09:09:43 INFO - PROCESS | 16775 | |2;jquery.html;434.9434573505444;447.6172872194274;450.56970593083605;450.95715906988835;452.2989366481954;20510.487237819045;22572.209972650962;22591.774082259173;23010.65484017741;23335.649965250534;22612.43468913278;22642;22725;22882.199123030696;23108.768912310872;6051.818445446644;6122.693865306739;6136.325004249529;6252.06219067139;6307.180066591337;6073.514118870502;6103.42017508336;6131.264248290211;6132.5093992480715;6140.232470941132;5898.498627616657;6053.455189032986;6066.150738896558;6081.452669259766;6172.783952561661;6126.448619624233;6170.568060235785;6171.228596425447;6175.320714721377;6176.320604733498;5423.267858839045;5534.778608855641;5573.359063707685;5573.944260557383;5574.386817450078;26393.472130557282;26506.86746566274;26698.86650566754;26736.73263267362;26855.73144268552;2801.6778070521946;2936.4861149299;3369.2082360645227;3463.3765922134007;3515.6835884770494;11336;11395.54417823286;11492.138089643227;11503.309801411859;11509.712257193554;2103.3374487036535;2123.734533183352;2139.6362618354915;2148.473623962124;2149.537849362379;97074;97591.99999999929;98392.50803746007;99719;99867.00398988042;13166.407511661999;13247.933760331136;13289;13626.454941802216;13661.97535184865;18124.909375453037;18132.546686332684;18150.909245453953;18191;18204.180811863498;9606.27952903535;9639.807203855884;9781.314899572175;9888.20894328452;9981.101700846959;9397.530123493798;9562;9599.808003839884;9678.419294842332;9787.804243915081;5395.055865223649;5418.945810541923;5442;5508.586855985817;5645.23789288449;1943.811087107286;2000.3998800359834;2045.5295282085203;2122.819560337358;2137.914483420677;1156.5373850459882;1165.539611853313;1186.1815347410259;1187.6555798818247;1198.6523908066738;21426.571468570542;23127.537449251256;23460.882695586413;23641;23833.642495362583;1079.2048594141056;1096.3202814255212;1101.5869049106584;1102.5534658463334;1119.3787447966295;11818.113641476924;11951.940240298743;11953.701157471132;12008;12035.879641203652;766865;817336;818061;844822;867356;97490.51254743681;98697.50651246698;100030.4998475003;119634.4018279903;122398;1078.724925144099;1108.3571528513282;1124.8425220469142;1131.7906187355366;1140.6521011091531;19634.8036519633;19896.50258743543;20012.299569515;20042.198312067354;20093.49766255855;47057;47185.7640711808;47601.285980709625;47683.52316476791;48116.518834811206;69041.59528268114;70063.29936700771;70195.64902175457;70292.29707702858;70621;9398.859017114886;9404.294677899048;9407.670731524637;9453.669121580986;9533.427994320364;9821.508924553887;13015.934920325337;13131.803022954473;13814;13998.790018149939;11104.722381940193;11194.944025279821;11204.383758893338;11480.081593472336;12237;11276.548938042386;11689.123315751183;11838.704032399259;11973.10201734856;12138.393080345772;11351.37567433766;11413.885861141614;11449.255798373079;12070.577529786415;12155.209911355734;9033.412828166149;9205.539723013688;9256.95371523138;9267.934187568246;9406.764830879283;11398.031167350868;12071.758564828478;12086.15396922207;12172.208806427909;12179.086568507575 09:09:43 INFO - PROCESS | 16775 | |3;mootools.html;1501.684646224293;1509.856563626455;1515.9242037898102;1526.3818153647774;1527.8624923756863;7628.427867909902;7889.408294377916;8236.341092712577;8805.911940880596;8833.337499687525;8273.089960104398;8518.659253629847;8531.744047678563;8754.474731516113;8769.254613357873;2409.2651741218965;2415.4927465232236;2441.841280316774;2445.902163913441;2448.3144719478573;2388.4028992751814;2390.1873363056557;2414.4446777241246;2415.855048697084;2449.632555116738;2359.2096647623066;2368.86971216583;2382.0233704181287;2384.0821283805685;2389.151851092863;2340.157543284416;2343.3438637181616;2376.560336337783;2379.2267513058237;2387.6179811230295;2321.68657231275;2340.6254999200046;2398.556267090594;2402.231285988484;2406.9879650601633;8617.61220745068;8671;8715.738527844174;8730.86903696445;8742.12578742127;5284.471552844723;5357.330333708286;5379.220013098118;5422.3764267109;5434.212039254286;3485.337785820686;3488.947665785015;3531.858725650971;3535.257595904863;3641.035125691694;1491.4705279625794;1521.6576270339197;1524.291204589871;1546.0955341125455;1562.8437156284394;11594.6521604352;11626.651200463999;11738.119641026871;11789.469473873696;11807.114466414967;4722.409698787652;4739.457255701385;4749.691270067435;4832.130216561053;4886.438059623189;10045.246606504541;10138.188944884392;10144.391336519833;10151.7462063449;10191.439470829175;5483.232347471358;5510.090835012178;5512.173174023928;5513.3108361454815;5514.200440936042;4923.507649235119;5026.497350265017;5105.744712764347;5174.14626586609;5174.508421699932;3908.5895980922164;3980.283548961215;4022.6982976276313;4052.230076285496;4077.327241005201;1244.3529364730289;1245.7383949370553;1255.265669583304;1261.3882267100632;1263.1158189267549;1067.40758878823;1084.4848696869083;1090.3294473898654;1100.4552746390427;1110.8944650258375;6052.757889684363;6088.1476593276975;6123.663198524124;6239.0953311770445;6272.686365681698;661.5534514202894;662.8707402056552;667.3660022978094;683.8598087392073;684.7706018483864;4127.463429754112;4273.722208056466;4296.441462609903;4330;4376.190404775127;9948.701538953843;10166;10225.539850706737;10242.385456872611;10294.794104118026;10134.23993200498;10289.53697083633;10297.588096476207;10299.279050466545;10310.587576497006;7789.532628042336;7980.68077276914;8080.151584083704;8250.38122140842;8250.504969701837;6036.63780173191;6226.62640241587;6245.344238855037;6397.4562162216735;6397.808065758035;9492.572834222614;9578.425294482353;9742.31803773729;9746.463944483121;9769.462679552693;9677.612895484383;9679.177269932135;9797.118259356692;9800.166985806287;9835.704928852147;7242.239564845615;7470.0662417197855;7541.057367829021;7604.5437273763755;7621.428392870446;8411.032731235742;8419.789505262417;8430.114837941928;8430.6206220719;8434.367422443218;7689.42329325314;7742.341900938258;7822.335101516207;7834.4907581007055;7928.7621371356645;7689.807754806175;7747.961260193663;7749.457537972288;7766.88349674744;7835.647395867314;6688.966555167193;6747.055412242388;6770.424513916372;6807.659617019228;6831.419329356861;5212.218167274939;5251.816186433456;5334.093204155381;5360.088784906653;5363;5434.510894019399;5507.752151153128;5583.302087239095;5594.021046316797;5601.551875850004 09:09:43 INFO - PROCESS | 16775 | |4;prototype.html;418.932970724684;420.53110781478654;429.14171656686625;436.2518281147831;436.3934131557134;5480.342358916925;5522.3649280332775;5530.92147031329;5553.694546799924;5598.972005139974;5348;5498.835034948958;5503.064479038563;5515.393306736256;5553.916691249625;4158.875233742978;4230.3865939438765;4275.508316543606;4304.708587423768;4335.848245311415;4274.123804620061;4312.892177695551;4318.5033721122;4320.768580954428;4322.675799315049;4289.270823959934;4295.4201182840225;4306.720063195898;4319.632831209351;4326.156399502099;4193.232466572078;4237.957620423787;4240.703150779446;4305.849295274666;4335.739855608674;3788.389934277921;3790.469334293201;3801.334766415866;3802.1825307559006;3813.103920578662;5391.595630327741;5411.540019098381;5428.859939412728;5462.153366228241;5475.5072043515875;4733.431988161408;4957.553820156168;4974.726390048546;4996.200607902754;5009.273655319958;5758.88482230353;5770.596058275923;5772.538196944234;5778.508826749731;5815.505682017034;4232.873013809591;4251.256030194734;4254.489461264637;4265.7440553566885;4269.615734583902;5789.392113828029;5961.761529538813;5980.594560278331;6028.7588496460085;6032.946017067221;4327.7186982846015;4344.761038142869;4366.563343665672;4378.255696531597;4395.27477966132;4382.9342559861625;4394.582514661102;4425.114977004612;4432.645388368923;4444.488883778342;4930.753462326869;4945.703257804544;4976.751162441863;4991.575716064175;5002.699838009658;5742.59801813869;5784.681842498619;5809.738561764646;5829.271341082364;5829.5044921181325;1463.9707205855823;1482.910061105087;1483.494253332868;1484.317214081513;1494.2080697230485;979.3536266064364;1018.7351288664852;1022.1158697726413;1034.6482196053378;1051;5544.445555444423;5560.527355174774;5565.220869078333;5576.721163941867;5583;5749.367569567345;5780.884382312414;5793.8841223175305;5837.67892765902;5852.824415267463;5437.374701909252;5542.944570554324;5553.861763221189;5557.527610153183;5558.638688485235;3036.8481575921555;3047.4666933286585;3082.1061892051052;3089.6137982752157;3098.98450507746;5820.2830165101395;5936.8812623748145;5990.191324171268;6006.249218847644;6007.459328660354;5800.709964501758;5811.3026436827;5846.269216347957;5877.588568800228;5933.495652869468;5853.970730146322;5888.499477544457;5947.881042379128;5974.027271864162;6013.098035294741;5469.589780766379;5685.488306052475;5696.287964004499;5784.855378615568;5820.738066787089;5626.831195064155;5651.971740141437;5675.0636145035605;5683.914741278967;5702.600817942704;5893.469587736953;6105.84735381619;6110.236220472441;6127.877442451215;6154.969225153845;4320.891977700583;4341.500727416387;4342.609165175149;4351.73889566627;4381.474223093249;5782.85542861415;5914.822555323347;5972.522198224218;5974.551908606785;6009.549283803644;5748.780682817635;5755.223044889054;5759.481646651821;5785.623934444247;5798.246227990503;5714.742836572447;5738.540916726568;5768.307803063659;5819.272590926134;5824.621399609012;5470.781168753365;5707.543396528351;5711.828645140652;5747.597668163356;5760.395158508296;5791.333996590446;5824.3593204748295;5828.444648764335;5855.268091488564;5857;5472.972635136799;5667.854340840873;5672.432756724294;5689.122589545523;5754.597178197653 09:09:43 INFO - PROCESS | 16775 | |5;yui.html;830.709251761883;850.2772643253239;856.1994535109673;921.4839689773727;952.995235023825;16874.325026998922;18137.546561335974;18154.3645972391;19382.321618743346;19401.320953766623;17745.64508709828;18049.81950180501;18528.258869645233;18714.251429942786;18728.531786705338;834.5284914023557;851.0213254757017;852.6163226548047;852.6972924611766;853.6798700487317;822.1408627983772;849.1381248033251;849.3332733803934;849.8257857139303;850.5067061104576;871.790770215147;880.7401816464159;882.9911700882973;883.3419102768446;884.1423818895693;873.2795443758893;876.6493402638931;878.7583414560983;883.7172104926426;885.654594708058;641.272156102822;649.1334069017867;649.2241771083557;649.3149727037973;650.5998810731413;15816.130112843788;16228;16841.915790420968;16867.915660421742;16874.578135546588;15414.845851541566;16170.75743863843;16342.428015019535;16366.590835229215;16439.83560164395;13090.345482725921;13480.258585777778;13596.184228946295;14048.43806247749;14092.788608170886;4120.711550191488;4149.80560184084;4169.937450938239;4182.393552934838;4230.090530535918;81456.18543814545;82397;82630;82889.58555207246;83082;13421.731565368638;13459.663508412368;13490.932545337211;13541.59375218745;13562.321883905764;25381.238562843144;25473.490530189294;26222;26256.21231363062;26465.206043818715;9045.095490451034;9084.364094513452;9156.221721153777;9186.724398268063;9237.538123093818;4886.315915771724;4909.2881532177635;5023.34696489454;5039.21892106724;5064.670796398223;4011.338129208648;4073.042834933788;4156.127213285184;4196.853110141131;4251.553586873396;676.4351766275117;683.7606837606797;691.3017851969547;695.02696225285;704.6476761619191;850.4642075492524;853.7566793463833;858.952757598338;866.8093019535692;870.6822009966317;11237.3257604544;11248.550057997589;11305.886941130648;12178.330191839357;12346.13577049598;866.8136350684633;877.5699907045629;891.1088911088912;902.273669695888;913.3287034029983;5477.561795056386;5597.132444471114;5603.943960560424;5672.8865422691315;5689.459501347365;80786;81753;83202;83761;83940.58029709812;56534.43465565374;61938.070928936104;64430.677846610466;69632.30367696258;70207;63115;63828.68085659635;64283.35716642774;64292.35707642957;64646.35353646497;11396.715082123013;11680.357580333164;11891.881081189424;11910.702232444259;11941.223820451643;40258.79870600628;40584.59415405808;41557.79221103875;41866;43132.78433607812;50529.49470505248;52618.47381526136;52756.73621631867;53646.46353536415;55222.723886380314;14373.784393234318;14533.92733036328;14603.269836508345;14693.485727999469;14714.337854796773;15659.060456372654;15735.527934161993;15830;15927.283272252545;15959.840401595835;13795.241261730702;13881.861181388056;13901.791473127709;13925.303734813016;14747.115173089649;15709.135997520247;15792.684146317239;16038.198090095682;16538.33846646169;16559.917200414402;14878.628034298796;15250.847491524943;15568.610784730472;15645;15989;12153.149279550347;12173.878261217274;12729.74540509166;12734.490620375082;13037.348132593143;11771.470283837076;12249.755004900031;12377.824106709848;12482.875171248172;12650.177738447339 09:09:43 INFO - PROCESS | 16775 | __end_tp_report 09:09:43 INFO - PROCESS | 16775 | __start_cc_report 09:09:43 INFO - PROCESS | 16775 | _x_x_mozilla_cycle_collect,296 09:09:43 INFO - PROCESS | 16775 | __end_cc_report 09:09:43 INFO - PROCESS | 16775 | __startTimestamp1486660183469__endTimestamp 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | ------- Summary: start ------- 09:09:43 INFO - PROCESS | 16775 | Number of tests: 6 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#0] dojo.html Cycles:165 Average:5469.64 Median:5699.15 stddev:600.09 (10.5%) stddev-sans-first:576.27 09:09:43 INFO - PROCESS | 16775 | Values: 3256.5 3275.2 3284.3 3285.1 3290.7 5483.7 5488.2 5520.4 5531.1 5546.6 5463.5 5550.3 5555.0 5557.3 5579.2 4952.6 4992.6 4997.3 5033.7 5057.6 5009.4 5060.3 5060.4 5062.2 5086.6 4850.8 4906.4 5049.2 5059.9 5060.9 4929.0 5003.0 5015.9 5053.5 5106.3 4946.8 5027.9 5027.9 5042.5 5054.1 5290.2 5425.1 5441.2 5579.7 5601.7 5719.2 5759.7 5826.7 5831.7 5924.8 5924.1 5932.9 5946.8 5953.1 5953.8 5532.6 5542.3 5543.1 5563.3 5571.1 5832.7 5840.6 5879.7 5886.1 5914.5 5703.0 5759.7 5762.9 5766.1 5773.0 5793.8 5837.1 5867.5 5874.6 5885.1 5687.3 5721.7 5739.6 5781.7 5820.5 5787.5 5796.2 5846.3 5847.3 5865.5 4527.7 4546.0 4556.5 4557.0 4581.9 3947.9 4004.3 4016.3 4059.8 4079.3 5630.8 5679.7 5687.5 5732.0 5792.2 5937.9 5940.4 5955.8 5956.1 5958.5 5554.3 5580.4 5637.2 5710.7 5721.1 5028.1 5060.7 5062.9 5093.8 5095.2 6099.1 6120.7 6130.4 6132.9 6143.9 5653.6 5705.3 5912.4 5927.2 5933.9 6017.6 6046.2 6060.4 6120.1 6120.3 5807.4 5821.9 5840.8 5843.2 5863.7 5726.7 5876.7 5924.3 5951.6 5958.0 5630.1 5675.3 5724.3 5732.8 5824.0 5765.8 5776.3 5787.2 5788.5 5794.8 5577.7 5690.4 5716.8 5718.2 5729.7 5547.0 5595.1 5675.7 5738.7 5836.2 5655.7 5695.9 5699.1 5711.6 5725.5 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#1] ext.html Cycles:180 Average:64272.12 Median:37190.22 stddev:125398.95 (337.2%) stddev-sans-first:125659.48 09:09:43 INFO - PROCESS | 16775 | Values: 559.0 590.5 623.8 695.1 698.8 46090.8 47517.3 50965.7 51092.5 51451.5 37450.4 37876.8 37919.4 37979.6 38056.8 9272.8 10581.9 11020.8 11048.1 11299.2 10775.9 10834.3 10837.8 10865.5 10889.3 10860.7 10959.6 10970.2 10971.2 10972.3 10768.0 10808.9 10819.0 10821.6 10843.4 11045.7 11120.9 11129.7 11133.9 11145.0 43628.1 43987.3 44187.8 44287.6 44409.1 4400.8 4502.0 4526.5 4558.3 4623.1 31947.8 31982.4 32580.7 32796.8 33266.5 4684.7 4791.2 4812.8 4821.3 4863.8 355778.0 358011.0 358342.0 359762.0 359857.0 62865.4 63012.7 63292.7 63445.4 63608.7 65216.3 65474.3 65638.0 65892.3 65985.0 16714.9 16947.7 17108.1 17129.0 17174.1 14654.3 15361.1 15454.2 15474.7 15475.3 20570.5 20589.8 20598.4 20749.0 20757.6 7235.7 7376.2 7460.9 7463.0 7478.7 981.9 994.5 997.2 1008.4 1030.0 32948.3 33242.3 33359.3 33612.8 33639.8 1193.2 1197.7 1209.4 1221.5 1235.2 17670.6 18131.2 18170.3 18218.2 18272.8 544414.0 545336.0 554331.0 554806.0 560543.0 71751.6 72225.0 72533.6 72769.6 73052.3 1545.3 1559.8 1568.7 1587.8 1596.1 32468.0 32668.0 32944.7 33462.1 33478.5 60955.8 62457.4 62476.4 62535.0 62597.0 485696.0 489300.0 489550.0 489820.0 490132.0 29391.0 30066.5 30355.4 32202.2 32588.2 48488.3 49227.8 49746.8 50450.0 53656.0 41954.0 43540.6 43769.6 44136.6 44434.6 43058.8 43201.4 43240.1 43572.8 44125.3 40105.8 40903.0 41409.2 42592.4 42852.6 34798.0 36199.6 36223.1 36470.0 36930.0 28213.3 28332.0 28408.2 28411.4 28455.7 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#2] jquery.html Cycles:180 Average:40581.95 Median:23737.32 stddev:134987.02 (568.7%) stddev-sans-first:135332.02 09:09:43 INFO - PROCESS | 16775 | Values: 434.9 447.6 450.6 451.0 452.3 20510.5 22572.2 22591.8 23010.7 23335.6 22612.4 22642.0 22725.0 22882.2 23108.8 6051.8 6122.7 6136.3 6252.1 6307.2 6073.5 6103.4 6131.3 6132.5 6140.2 5898.5 6053.5 6066.2 6081.5 6172.8 6126.4 6170.6 6171.2 6175.3 6176.3 5423.3 5534.8 5573.4 5573.9 5574.4 26393.5 26506.9 26698.9 26736.7 26855.7 2801.7 2936.5 3369.2 3463.4 3515.7 11336.0 11395.5 11492.1 11503.3 11509.7 2103.3 2123.7 2139.6 2148.5 2149.5 97074.0 97592.0 98392.5 99719.0 99867.0 13166.4 13247.9 13289.0 13626.5 13662.0 18124.9 18132.5 18150.9 18191.0 18204.2 9606.3 9639.8 9781.3 9888.2 9981.1 9397.5 9562.0 9599.8 9678.4 9787.8 5395.1 5418.9 5442.0 5508.6 5645.2 1943.8 2000.4 2045.5 2122.8 2137.9 1156.5 1165.5 1186.2 1187.7 1198.7 21426.6 23127.5 23460.9 23641.0 23833.6 1079.2 1096.3 1101.6 1102.6 1119.4 11818.1 11951.9 11953.7 12008.0 12035.9 766865.0 817336.0 818061.0 844822.0 867356.0 97490.5 98697.5 100030.5 119634.4 122398.0 1078.7 1108.4 1124.8 1131.8 1140.7 19634.8 19896.5 20012.3 20042.2 20093.5 47057.0 47185.8 47601.3 47683.5 48116.5 69041.6 70063.3 70195.6 70292.3 70621.0 9398.9 9404.3 9407.7 9453.7 9533.4 9821.5 13015.9 13131.8 13814.0 13998.8 11104.7 11194.9 11204.4 11480.1 12237.0 11276.5 11689.1 11838.7 11973.1 12138.4 11351.4 11413.9 11449.3 12070.6 12155.2 9033.4 9205.5 9257.0 9267.9 9406.8 11398.0 12071.8 12086.2 12172.2 12179.1 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#3] mootools.html Cycles:180 Average:5762.16 Median:5268.14 stddev:3111.66 (59.1%) stddev-sans-first:3103.92 09:09:43 INFO - PROCESS | 16775 | Values: 1501.7 1509.9 1515.9 1526.4 1527.9 7628.4 7889.4 8236.3 8805.9 8833.3 8273.1 8518.7 8531.7 8754.5 8769.3 2409.3 2415.5 2441.8 2445.9 2448.3 2388.4 2390.2 2414.4 2415.9 2449.6 2359.2 2368.9 2382.0 2384.1 2389.2 2340.2 2343.3 2376.6 2379.2 2387.6 2321.7 2340.6 2398.6 2402.2 2407.0 8617.6 8671.0 8715.7 8730.9 8742.1 5284.5 5357.3 5379.2 5422.4 5434.2 3485.3 3488.9 3531.9 3535.3 3641.0 1491.5 1521.7 1524.3 1546.1 1562.8 11594.7 11626.7 11738.1 11789.5 11807.1 4722.4 4739.5 4749.7 4832.1 4886.4 10045.2 10138.2 10144.4 10151.7 10191.4 5483.2 5510.1 5512.2 5513.3 5514.2 4923.5 5026.5 5105.7 5174.1 5174.5 3908.6 3980.3 4022.7 4052.2 4077.3 1244.4 1245.7 1255.3 1261.4 1263.1 1067.4 1084.5 1090.3 1100.5 1110.9 6052.8 6088.1 6123.7 6239.1 6272.7 661.6 662.9 667.4 683.9 684.8 4127.5 4273.7 4296.4 4330.0 4376.2 9948.7 10166.0 10225.5 10242.4 10294.8 10134.2 10289.5 10297.6 10299.3 10310.6 7789.5 7980.7 8080.2 8250.4 8250.5 6036.6 6226.6 6245.3 6397.5 6397.8 9492.6 9578.4 9742.3 9746.5 9769.5 9677.6 9679.2 9797.1 9800.2 9835.7 7242.2 7470.1 7541.1 7604.5 7621.4 8411.0 8419.8 8430.1 8430.6 8434.4 7689.4 7742.3 7822.3 7834.5 7928.8 7689.8 7748.0 7749.5 7766.9 7835.6 6689.0 6747.1 6770.4 6807.7 6831.4 5212.2 5251.8 5334.1 5360.1 5363.0 5434.5 5507.8 5583.3 5594.0 5601.6 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#4] prototype.html Cycles:180 Average:4859.26 Median:5543.70 stddev:1396.32 (25.2%) stddev-sans-first:1359.88 09:09:43 INFO - PROCESS | 16775 | Values: 418.9 420.5 429.1 436.3 436.4 5480.3 5522.4 5530.9 5553.7 5599.0 5348.0 5498.8 5503.1 5515.4 5553.9 4158.9 4230.4 4275.5 4304.7 4335.8 4274.1 4312.9 4318.5 4320.8 4322.7 4289.3 4295.4 4306.7 4319.6 4326.2 4193.2 4238.0 4240.7 4305.8 4335.7 3788.4 3790.5 3801.3 3802.2 3813.1 5391.6 5411.5 5428.9 5462.2 5475.5 4733.4 4957.6 4974.7 4996.2 5009.3 5758.9 5770.6 5772.5 5778.5 5815.5 4232.9 4251.3 4254.5 4265.7 4269.6 5789.4 5961.8 5980.6 6028.8 6032.9 4327.7 4344.8 4366.6 4378.3 4395.3 4382.9 4394.6 4425.1 4432.6 4444.5 4930.8 4945.7 4976.8 4991.6 5002.7 5742.6 5784.7 5809.7 5829.3 5829.5 1464.0 1482.9 1483.5 1484.3 1494.2 979.4 1018.7 1022.1 1034.6 1051.0 5544.4 5560.5 5565.2 5576.7 5583.0 5749.4 5780.9 5793.9 5837.7 5852.8 5437.4 5542.9 5553.9 5557.5 5558.6 3036.8 3047.5 3082.1 3089.6 3099.0 5820.3 5936.9 5990.2 6006.2 6007.5 5800.7 5811.3 5846.3 5877.6 5933.5 5854.0 5888.5 5947.9 5974.0 6013.1 5469.6 5685.5 5696.3 5784.9 5820.7 5626.8 5652.0 5675.1 5683.9 5702.6 5893.5 6105.8 6110.2 6127.9 6155.0 4320.9 4341.5 4342.6 4351.7 4381.5 5782.9 5914.8 5972.5 5974.6 6009.5 5748.8 5755.2 5759.5 5785.6 5798.2 5714.7 5738.5 5768.3 5819.3 5824.6 5470.8 5707.5 5711.8 5747.6 5760.4 5791.3 5824.4 5828.4 5855.3 5857.0 5473.0 5667.9 5672.4 5689.1 5754.6 09:09:43 INFO - PROCESS | 16775 | 09:09:43 INFO - PROCESS | 16775 | [#5] yui.html Cycles:180 Average:18626.26 Median:23031.43 stddev:22518.43 (97.8%) stddev-sans-first:22541.95 09:09:43 INFO - PROCESS | 16775 | Values: 830.7 850.3 856.2 921.5 953.0 16874.3 18137.5 18154.4 19382.3 19401.3 17745.6 18049.8 18528.3 18714.3 18728.5 834.5 851.0 852.6 852.7 853.7 822.1 849.1 849.3 849.8 850.5 871.8 880.7 883.0 883.3 884.1 873.3 876.6 878.8 883.7 885.7 641.3 649.1 649.2 649.3 650.6 15816.1 16228.0 16841.9 16867.9 16874.6 15414.8 16170.8 16342.4 16366.6 16439.8 13090.3 13480.3 13596.2 14048.4 14092.8 4120.7 4149.8 4169.9 4182.4 4230.1 81456.2 82397.0 82630.0 82889.6 83082.0 13421.7 13459.7 13490.9 13541.6 13562.3 25381.2 25473.5 26222.0 26256.2 26465.2 9045.1 9084.4 9156.2 9186.7 9237.5 4886.3 4909.3 5023.3 5039.2 5064.7 4011.3 4073.0 4156.1 4196.9 4251.6 676.4 683.8 691.3 695.0 704.6 850.5 853.8 859.0 866.8 870.7 11237.3 11248.6 11305.9 12178.3 12346.1 866.8 877.6 891.1 902.3 913.3 5477.6 5597.1 5603.9 5672.9 5689.5 80786.0 81753.0 83202.0 83761.0 83940.6 56534.4 61938.1 64430.7 69632.3 70207.0 63115.0 63828.7 64283.4 64292.4 64646.4 11396.7 11680.4 11891.9 11910.7 11941.2 40258.8 40584.6 41557.8 41866.0 43132.8 50529.5 52618.5 52756.7 53646.5 55222.7 14373.8 14533.9 14603.3 14693.5 14714.3 15659.1 15735.5 15830.0 15927.3 15959.8 13795.2 13881.9 13901.8 13925.3 14747.1 15709.1 15792.7 16038.2 16538.3 16559.9 14878.6 15250.8 15568.6 15645.0 15989.0 12153.1 12173.9 12729.7 12734.5 13037.3 11771.5 12249.8 12377.8 12482.9 12650.2 09:09:43 INFO - PROCESS | 16775 | -------- Summary: end -------- 09:09:43 INFO - PROCESS | 16775 | 09:09:44 INFO - TEST-INFO | 16775: exit 0 09:09:44 INFO - TEST-OK | dromaeo_css | took 1111947ms 09:09:44 INFO - TEST-START | kraken 09:09:44 INFO - operating with platform_type : linux_ 09:09:44 INFO - Initialising browser for kraken test... 09:09:44 INFO - TEST-INFO | started process 17141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuci1R8/profile http://localhost:46887/getInfo.html) 09:09:48 INFO - PROCESS | 17141 | __metrics Screen width/height:1600/1200 09:09:48 INFO - PROCESS | 17141 | colorDepth:24 09:09:48 INFO - PROCESS | 17141 | Browser inner width/height: 1024/697 09:09:48 INFO - PROCESS | 17141 | __metrics 09:09:49 INFO - PROCESS | 17141 | 1486660189373 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpuci1R8/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpuci1R8/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpuci1R8/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpuci1R8/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:09:49 ERROR - PROCESS | 17141 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:09:50 INFO - TEST-INFO | 17141: exit 0 09:09:50 INFO - Browser initialized. 09:09:50 INFO - Running cycle 1/1 for kraken test... 09:09:50 INFO - TEST-INFO | started process 17269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuci1R8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:02 INFO - PROCESS | 17269 | RSS: Main: 145084416 09:10:02 INFO - PROCESS | 17269 | 09:10:04 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:05 INFO - PROCESS | 17269 | RSS: Main: 151171072 09:10:05 INFO - PROCESS | 17269 | 09:10:08 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-dft) 09:10:08 INFO - PROCESS | 17269 | RSS: Main: 150122496 09:10:08 INFO - PROCESS | 17269 | 09:10:11 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-fft) 09:10:12 INFO - PROCESS | 17269 | RSS: Main: 150364160 09:10:12 INFO - PROCESS | 17269 | 09:10:14 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-oscillator) 09:10:14 INFO - PROCESS | 17269 | RSS: Main: 150630400 09:10:14 INFO - PROCESS | 17269 | 09:10:17 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:17 INFO - PROCESS | 17269 | RSS: Main: 150147072 09:10:17 INFO - PROCESS | 17269 | 09:10:20 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:21 INFO - PROCESS | 17269 | RSS: Main: 152752128 09:10:21 INFO - PROCESS | 17269 | 09:10:24 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:25 INFO - PROCESS | 17269 | RSS: Main: 150990848 09:10:25 INFO - PROCESS | 17269 | 09:10:28 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46887/tests/kraken/driver.html?testName=json-parse-financial) 09:10:28 INFO - PROCESS | 17269 | RSS: Main: 151793664 09:10:28 INFO - PROCESS | 17269 | 09:10:30 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:30 INFO - PROCESS | 17269 | RSS: Main: 151715840 09:10:30 INFO - PROCESS | 17269 | 09:10:32 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:33 INFO - PROCESS | 17269 | RSS: Main: 152342528 09:10:33 INFO - PROCESS | 17269 | 09:10:35 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:36 INFO - PROCESS | 17269 | RSS: Main: 152461312 09:10:36 INFO - PROCESS | 17269 | 09:10:38 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:39 INFO - PROCESS | 17269 | RSS: Main: 152223744 09:10:39 INFO - PROCESS | 17269 | 09:10:42 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:42 INFO - PROCESS | 17269 | RSS: Main: 152309760 09:10:42 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46887/tests/kraken/driver.html?testName=ai-astar) 09:10:44 INFO - PROCESS | 17269 | RSS: Main: 154349568 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | __start_tp_report 09:10:44 INFO - PROCESS | 17269 | _x_x_mozilla_page_load 09:10:44 INFO - PROCESS | 17269 | _x_x_mozilla_page_load_details 09:10:44 INFO - PROCESS | 17269 | |i|pagename|runs| 09:10:44 INFO - PROCESS | 17269 | |0;ai-astar;106;117;115;113;113;113;115;115;114;115 09:10:44 INFO - PROCESS | 17269 | |1;audio-beat-detection;141;119;120;163;125;120;123;121;136;123 09:10:44 INFO - PROCESS | 17269 | |2;audio-dft;163;165;164;164;160;164;162;163;162;165 09:10:44 INFO - PROCESS | 17269 | |3;audio-fft;76;76;75;115;75;76;76;76;95;75 09:10:44 INFO - PROCESS | 17269 | |4;audio-oscillator;84;83;103;83;82;84;94;84;82;112 09:10:44 INFO - PROCESS | 17269 | |5;imaging-gaussian-blur;118;117;118;118;119;118;119;118;117;118 09:10:44 INFO - PROCESS | 17269 | |6;imaging-darkroom;148;148;148;148;147;148;148;147;148;148 09:10:44 INFO - PROCESS | 17269 | |7;imaging-desaturate;96;97;97;96;96;96;97;96;96;96 09:10:44 INFO - PROCESS | 17269 | |8;json-parse-financial;55;56;61;55;64;55;56;55;58;55 09:10:44 INFO - PROCESS | 17269 | |9;json-stringify-tinderbox;65;63;64;66;64;64;64;64;65;64 09:10:44 INFO - PROCESS | 17269 | |10;stanford-crypto-aes;78;76;76;77;76;76;77;78;77;76 09:10:44 INFO - PROCESS | 17269 | |11;stanford-crypto-ccm;132;123;121;129;129;121;124;119;161;137 09:10:44 INFO - PROCESS | 17269 | |12;stanford-crypto-pbkdf2;160;155;157;156;157;160;155;158;154;159 09:10:44 INFO - PROCESS | 17269 | |13;stanford-crypto-sha256-iterative;60;61;64;60;60;60;61;60;69;61 09:10:44 INFO - PROCESS | 17269 | __end_tp_report 09:10:44 INFO - PROCESS | 17269 | __start_cc_report 09:10:44 INFO - PROCESS | 17269 | _x_x_mozilla_cycle_collect,727 09:10:44 INFO - PROCESS | 17269 | __end_cc_report 09:10:44 INFO - PROCESS | 17269 | __startTimestamp1486660244554__endTimestamp 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | ------- Summary: start ------- 09:10:44 INFO - PROCESS | 17269 | Number of tests: 14 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:2.95 (2.6%) stddev-sans-first:1.33 09:10:44 INFO - PROCESS | 17269 | Values: 106.0 117.0 115.0 113.0 113.0 113.0 115.0 115.0 114.0 115.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:124.00 stddev:14.00 (11.3%) stddev-sans-first:14.17 09:10:44 INFO - PROCESS | 17269 | Values: 141.0 119.0 120.0 163.0 125.0 120.0 123.0 121.0 136.0 123.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#2] audio-dft Cycles:10 Average:163.20 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 09:10:44 INFO - PROCESS | 17269 | Values: 163.0 165.0 164.0 164.0 160.0 164.0 162.0 163.0 162.0 165.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:13.26 (17.4%) stddev-sans-first:13.91 09:10:44 INFO - PROCESS | 17269 | Values: 76.0 76.0 75.0 115.0 75.0 76.0 76.0 76.0 95.0 75.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.50 stddev:10.51 (12.6%) stddev-sans-first:10.99 09:10:44 INFO - PROCESS | 17269 | Values: 84.0 83.0 103.0 83.0 82.0 84.0 94.0 84.0 82.0 112.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:10:44 INFO - PROCESS | 17269 | Values: 118.0 117.0 118.0 118.0 119.0 118.0 119.0 118.0 117.0 118.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:10:44 INFO - PROCESS | 17269 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 148.0 148.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:10:44 INFO - PROCESS | 17269 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:3.13 (5.6%) stddev-sans-first:3.23 09:10:44 INFO - PROCESS | 17269 | Values: 55.0 56.0 61.0 55.0 64.0 55.0 56.0 55.0 58.0 55.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:10:44 INFO - PROCESS | 17269 | Values: 65.0 63.0 64.0 66.0 64.0 64.0 64.0 64.0 65.0 64.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:77.00 stddev:0.82 (1.1%) stddev-sans-first:0.73 09:10:44 INFO - PROCESS | 17269 | Values: 78.0 76.0 76.0 77.0 76.0 76.0 77.0 78.0 77.0 76.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:129.00 stddev:12.39 (9.6%) stddev-sans-first:13.11 09:10:44 INFO - PROCESS | 17269 | Values: 132.0 123.0 121.0 129.0 129.0 121.0 124.0 119.0 161.0 137.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:2.13 (1.4%) stddev-sans-first:1.99 09:10:44 INFO - PROCESS | 17269 | Values: 160.0 155.0 157.0 156.0 157.0 160.0 155.0 158.0 154.0 159.0 09:10:44 INFO - PROCESS | 17269 | 09:10:44 INFO - PROCESS | 17269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.00 stddev:2.88 (4.7%) stddev-sans-first:2.99 09:10:44 INFO - PROCESS | 17269 | Values: 60.0 61.0 64.0 60.0 60.0 60.0 61.0 60.0 69.0 61.0 09:10:44 INFO - PROCESS | 17269 | -------- Summary: end -------- 09:10:44 INFO - PROCESS | 17269 | 09:10:45 INFO - TEST-INFO | 17269: exit 0 09:10:45 INFO - TEST-OK | kraken | took 61425ms 09:10:45 INFO - SUITE-END | took 1173s 09:10:45 INFO - Completed test suite (00:19:33) 09:10:45 INFO - javascript benchmark 09:10:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7688.071389404016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.4789633658615, 3275.181204698824, 3284.293876816484, 3285.0965984354316, 3290.703836654702, 5483.670979741213, 5488.231647569339, 5520.447955204478, 5531.087370583854, 5546.639468434559, 5463.535599474039, 5550.27846379971, 5554.9722251388785, 5557.3331200256025, 5579.163125531162, 4952.603791696664, 4992.575631071363, 4997.275395067713, 5033.697978121306, 5057.57010654093, 5009.373828271466, 5060.291559181717, 5060.418051924021, 5062.240663900426, 5086.618503612225, 4850.757462126897, 4906.386701662293, 5049.242613607951, 5059.924101138486, 5060.898782024376, 4929.0, 5003.049420610072, 5015.899682006339, 5053.545180933734, 5106.285120083154, 4946.752662366867, 5027.899442011139, 5027.899442011176, 5042.520960508746, 5054.1407960646775, 5290.1800220965815, 5425.13197888336, 5441.238226648273, 5579.69311687857, 5601.747921343549, 5719.227904232917, 5759.65442073477, 5826.737796799154, 5831.708414579297, 5924.763009479659, 5924.1113832924975, 5932.940670593325, 5946.791862284799, 5953.13679516472, 5953.821385358447, 5532.640378375433, 5542.334919809648, 5543.085390910535, 5563.276774019392, 5571.108622620402, 5832.737526811304, 5840.591158618856, 5879.7060146993335, 5886.05823068307, 5914.467697907209, 5702.971485142548, 5759.740811663485, 5762.94237057624, 5766.106253530709, 5773.0, 5793.797217097382, 5837.09525023622, 5867.471927526543, 5874.618149820248, 5885.117232415087, 5687.260656114679, 5721.742521586539, 5739.598228124075, 5781.682007489629, 5820.534357251409, 5787.536997040227, 5796.217510636095, 5846.298444186725, 5847.26909136358, 5865.472107510344, 4527.705699129612, 4546.04533048057, 4556.498785133633, 4556.954430455719, 4581.885452863705, 3947.8618248361745, 4004.3192657248337, 4016.2770701274053, 4059.7564146151326, 4079.3065178919655, 5630.774769009194, 5679.716014199274, 5687.544996400278, 5732.0, 5792.160136780228, 5937.940620593825, 5940.435658612425, 5955.821325360246, 5956.106584012433, 5958.523318134538, 5554.250176226238, 5580.358258800209, 5637.238972738628, 5710.65736055838, 5721.141828725725, 5028.069807085701, 5060.7216603086445, 5062.949370506248, 5093.796248150106, 5095.15929871567, 6099.054646529795, 6120.724567394478, 6130.448259656652, 6132.908006379907, 6143.877122457526, 5653.632513886584, 5705.258316418839, 5912.379200184091, 5927.229460170151, 5933.940660593339, 6017.578769486094, 6046.244219472566, 6060.363661815622, 6120.050983828623, 6120.294761999531, 5807.390224026416, 5821.883562328645, 5840.795572154954, 5843.240378750906, 5863.706814659336, 5726.713664316851, 5876.676782776817, 5924.348321684525, 5951.583389162717, 5957.970210148921, 5630.071038278638, 5675.318961724454, 5724.341700704473, 5732.799352022659, 5823.970880145572, 5765.798197063251, 5776.306843178845, 5787.189793428839, 5788.479036886701, 5794.82615521535, 5577.717125061177, 5690.37405885344, 5716.771329146954, 5718.199452076796, 5729.742161602821, 5547.0, 5595.07681232592, 5675.687837168995, 5738.741756620879, 5836.212111364912, 5655.688937108499, 5695.943040569707, 5699.145128230799, 5711.628744131618, 5725.484706376446], "value": 5430.807807418476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9636673616214, 590.5393792841583, 623.8253289079058, 695.0651373902106, 698.7833771530823, 46090.76954615227, 47517.28724069142, 50965.745171274095, 51092.48907510924, 51451.48548514514, 37450.43824342637, 37876.81061594688, 37919.431208531896, 37979.62020379795, 38056.80971595138, 9272.814543709123, 10581.947090264577, 11020.779584408307, 11048.06091482225, 11299.209055366127, 10775.946120269387, 10834.295770774914, 10837.783244335109, 10865.45672716361, 10889.346639201634, 10860.728481787939, 10959.616413425532, 10970.232083754141, 10971.177161712903, 10972.286801357886, 10768.0, 10808.891911080867, 10818.99999999996, 10821.621243256448, 10843.403612801292, 11045.668629941114, 11120.888791112147, 11129.72175695606, 11133.944330278297, 11145.0, 43628.127437451076, 43987.34018989718, 44187.77906110449, 44287.55712442866, 44409.11181776378, 4400.7579583122915, 4501.977490112528, 4526.479454862667, 4558.270676691746, 4623.0522742837975, 31947.840260798548, 31982.360352793046, 32580.674193258, 32796.83601581977, 33266.50100248498, 4684.672072954894, 4791.233402655594, 4812.831550895702, 4821.325014497973, 4863.781129849165, 355778.0, 358011.0, 358342.0, 359762.0, 359857.0, 62865.37134628687, 63012.684936575024, 63292.68353658295, 63445.36554634394, 63608.68195658992, 65216.347836521025, 65474.34525654778, 65638.0, 65892.34107658958, 65985.0, 16714.916425417796, 16947.745783813254, 17108.144592770313, 17129.0, 17174.141292935303, 14654.267286635626, 15361.078335299917, 15454.227288635524, 15474.690506189812, 15475.303611337516, 20570.485737856376, 20589.794102058786, 20598.38204853857, 20749.0, 20757.584848303253, 7235.746748863765, 7376.151742549676, 7460.925390746132, 7462.96268518654, 7478.738244161428, 981.896900825403, 994.4778991029767, 997.152420442618, 1008.4201584089178, 1029.953652085658, 32948.341033179204, 33242.33515329728, 33359.33281334408, 33612.831935840164, 33639.83180084084, 1193.1826698711411, 1197.6766273106211, 1209.3771707570609, 1221.4625564751482, 1235.2279825109306, 17670.558236043944, 18131.18409671568, 18170.27318907255, 18218.180181891847, 18272.817271827378, 544414.0, 545336.0, 554331.0, 554806.0, 560543.0, 71751.64124179346, 72225.0, 72533.637331813, 72769.63615181891, 73052.26947730561, 1545.2659986506544, 1559.8050243719536, 1568.6705791783625, 1587.7538981457892, 1596.146061856901, 32468.0, 32668.0, 32944.67055329512, 33462.12445604034, 33478.497822533165, 60955.78088438295, 62457.375426245155, 62476.375236247055, 62535.0, 62597.0, 485696.0, 489300.0, 489550.0, 489820.0, 490132.0, 29391.0, 30066.54900176543, 30355.392892142474, 32202.194945125622, 32588.185295367806, 48488.27267590918, 49227.75386123046, 49746.751266244886, 50450.0, 53656.0, 41954.0, 43540.56459435365, 43769.56230437655, 44136.558634413246, 44434.555654443044, 43058.784706077524, 43201.3519797197, 43240.135197296506, 43572.78213608912, 44125.33811992758, 40105.79947100246, 40903.0, 41409.1718165641, 42592.36111458269, 42852.5714742861, 34798.0, 36199.63800361963, 36223.094422639646, 36470.0, 36930.0, 28213.294667632654, 28332.0, 28408.193460027458, 28411.43177136487, 28455.715442845307], "value": 21940.31283867734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.9434573505444, 447.6172872194274, 450.56970593083605, 450.95715906988835, 452.2989366481954, 20510.487237819045, 22572.209972650962, 22591.774082259173, 23010.65484017741, 23335.649965250534, 22612.43468913278, 22642.0, 22725.0, 22882.199123030696, 23108.768912310872, 6051.818445446644, 6122.693865306739, 6136.325004249529, 6252.06219067139, 6307.180066591337, 6073.514118870502, 6103.42017508336, 6131.264248290211, 6132.5093992480715, 6140.232470941132, 5898.498627616657, 6053.455189032986, 6066.150738896558, 6081.452669259766, 6172.783952561661, 6126.448619624233, 6170.568060235785, 6171.228596425447, 6175.320714721377, 6176.320604733498, 5423.267858839045, 5534.778608855641, 5573.359063707685, 5573.944260557383, 5574.386817450078, 26393.472130557282, 26506.86746566274, 26698.86650566754, 26736.73263267362, 26855.73144268552, 2801.6778070521946, 2936.4861149299, 3369.2082360645227, 3463.3765922134007, 3515.6835884770494, 11336.0, 11395.54417823286, 11492.138089643227, 11503.309801411859, 11509.712257193554, 2103.3374487036535, 2123.734533183352, 2139.6362618354915, 2148.473623962124, 2149.537849362379, 97074.0, 97591.99999999929, 98392.50803746007, 99719.0, 99867.00398988042, 13166.407511661999, 13247.933760331136, 13289.0, 13626.454941802216, 13661.97535184865, 18124.909375453037, 18132.546686332684, 18150.909245453953, 18191.0, 18204.180811863498, 9606.27952903535, 9639.807203855884, 9781.314899572175, 9888.20894328452, 9981.101700846959, 9397.530123493798, 9562.0, 9599.808003839884, 9678.419294842332, 9787.804243915081, 5395.055865223649, 5418.945810541923, 5442.0, 5508.586855985817, 5645.23789288449, 1943.811087107286, 2000.3998800359834, 2045.5295282085203, 2122.819560337358, 2137.914483420677, 1156.5373850459882, 1165.539611853313, 1186.1815347410259, 1187.6555798818247, 1198.6523908066738, 21426.571468570542, 23127.537449251256, 23460.882695586413, 23641.0, 23833.642495362583, 1079.2048594141056, 1096.3202814255212, 1101.5869049106584, 1102.5534658463334, 1119.3787447966295, 11818.113641476924, 11951.940240298743, 11953.701157471132, 12008.0, 12035.879641203652, 766865.0, 817336.0, 818061.0, 844822.0, 867356.0, 97490.51254743681, 98697.50651246698, 100030.4998475003, 119634.4018279903, 122398.0, 1078.724925144099, 1108.3571528513282, 1124.8425220469142, 1131.7906187355366, 1140.6521011091531, 19634.8036519633, 19896.50258743543, 20012.299569515, 20042.198312067354, 20093.49766255855, 47057.0, 47185.7640711808, 47601.285980709625, 47683.52316476791, 48116.518834811206, 69041.59528268114, 70063.29936700771, 70195.64902175457, 70292.29707702858, 70621.0, 9398.859017114886, 9404.294677899048, 9407.670731524637, 9453.669121580986, 9533.427994320364, 9821.508924553887, 13015.934920325337, 13131.803022954473, 13814.0, 13998.790018149939, 11104.722381940193, 11194.944025279821, 11204.383758893338, 11480.081593472336, 12237.0, 11276.548938042386, 11689.123315751183, 11838.704032399259, 11973.10201734856, 12138.393080345772, 11351.37567433766, 11413.885861141614, 11449.255798373079, 12070.577529786415, 12155.209911355734, 9033.412828166149, 9205.539723013688, 9256.95371523138, 9267.934187568246, 9406.764830879283, 11398.031167350868, 12071.758564828478, 12086.15396922207, 12172.208806427909, 12179.086568507575], "value": 10438.149723385706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.684646224293, 1509.856563626455, 1515.9242037898102, 1526.3818153647774, 1527.8624923756863, 7628.427867909902, 7889.408294377916, 8236.341092712577, 8805.911940880596, 8833.337499687525, 8273.089960104398, 8518.659253629847, 8531.744047678563, 8754.474731516113, 8769.254613357873, 2409.2651741218965, 2415.4927465232236, 2441.841280316774, 2445.902163913441, 2448.3144719478573, 2388.4028992751814, 2390.1873363056557, 2414.4446777241246, 2415.855048697084, 2449.632555116738, 2359.2096647623066, 2368.86971216583, 2382.0233704181287, 2384.0821283805685, 2389.151851092863, 2340.157543284416, 2343.3438637181616, 2376.560336337783, 2379.2267513058237, 2387.6179811230295, 2321.68657231275, 2340.6254999200046, 2398.556267090594, 2402.231285988484, 2406.9879650601633, 8617.61220745068, 8671.0, 8715.738527844174, 8730.86903696445, 8742.12578742127, 5284.471552844723, 5357.330333708286, 5379.220013098118, 5422.3764267109, 5434.212039254286, 3485.337785820686, 3488.947665785015, 3531.858725650971, 3535.257595904863, 3641.035125691694, 1491.4705279625794, 1521.6576270339197, 1524.291204589871, 1546.0955341125455, 1562.8437156284394, 11594.6521604352, 11626.651200463999, 11738.119641026871, 11789.469473873696, 11807.114466414967, 4722.409698787652, 4739.457255701385, 4749.691270067435, 4832.130216561053, 4886.438059623189, 10045.246606504541, 10138.188944884392, 10144.391336519833, 10151.7462063449, 10191.439470829175, 5483.232347471358, 5510.090835012178, 5512.173174023928, 5513.3108361454815, 5514.200440936042, 4923.507649235119, 5026.497350265017, 5105.744712764347, 5174.14626586609, 5174.508421699932, 3908.5895980922164, 3980.283548961215, 4022.6982976276313, 4052.230076285496, 4077.327241005201, 1244.3529364730289, 1245.7383949370553, 1255.265669583304, 1261.3882267100632, 1263.1158189267549, 1067.40758878823, 1084.4848696869083, 1090.3294473898654, 1100.4552746390427, 1110.8944650258375, 6052.757889684363, 6088.1476593276975, 6123.663198524124, 6239.0953311770445, 6272.686365681698, 661.5534514202894, 662.8707402056552, 667.3660022978094, 683.8598087392073, 684.7706018483864, 4127.463429754112, 4273.722208056466, 4296.441462609903, 4330.0, 4376.190404775127, 9948.701538953843, 10166.0, 10225.539850706737, 10242.385456872611, 10294.794104118026, 10134.23993200498, 10289.53697083633, 10297.588096476207, 10299.279050466545, 10310.587576497006, 7789.532628042336, 7980.68077276914, 8080.151584083704, 8250.38122140842, 8250.504969701837, 6036.63780173191, 6226.62640241587, 6245.344238855037, 6397.4562162216735, 6397.808065758035, 9492.572834222614, 9578.425294482353, 9742.31803773729, 9746.463944483121, 9769.462679552693, 9677.612895484383, 9679.177269932135, 9797.118259356692, 9800.166985806287, 9835.704928852147, 7242.239564845615, 7470.0662417197855, 7541.057367829021, 7604.5437273763755, 7621.428392870446, 8411.032731235742, 8419.789505262417, 8430.114837941928, 8430.6206220719, 8434.367422443218, 7689.42329325314, 7742.341900938258, 7822.335101516207, 7834.4907581007055, 7928.7621371356645, 7689.807754806175, 7747.961260193663, 7749.457537972288, 7766.88349674744, 7835.647395867314, 6688.966555167193, 6747.055412242388, 6770.424513916372, 6807.659617019228, 6831.419329356861, 5212.218167274939, 5251.816186433456, 5334.093204155381, 5360.088784906653, 5363.0, 5434.510894019399, 5507.752151153128, 5583.302087239095, 5594.021046316797, 5601.551875850004], "value": 4670.246155383205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.932970724684, 420.53110781478654, 429.14171656686625, 436.2518281147831, 436.3934131557134, 5480.342358916925, 5522.3649280332775, 5530.92147031329, 5553.694546799924, 5598.972005139974, 5348.0, 5498.835034948958, 5503.064479038563, 5515.393306736256, 5553.916691249625, 4158.875233742978, 4230.3865939438765, 4275.508316543606, 4304.708587423768, 4335.848245311415, 4274.123804620061, 4312.892177695551, 4318.5033721122, 4320.768580954428, 4322.675799315049, 4289.270823959934, 4295.4201182840225, 4306.720063195898, 4319.632831209351, 4326.156399502099, 4193.232466572078, 4237.957620423787, 4240.703150779446, 4305.849295274666, 4335.739855608674, 3788.389934277921, 3790.469334293201, 3801.334766415866, 3802.1825307559006, 3813.103920578662, 5391.595630327741, 5411.540019098381, 5428.859939412728, 5462.153366228241, 5475.5072043515875, 4733.431988161408, 4957.553820156168, 4974.726390048546, 4996.200607902754, 5009.273655319958, 5758.88482230353, 5770.596058275923, 5772.538196944234, 5778.508826749731, 5815.505682017034, 4232.873013809591, 4251.256030194734, 4254.489461264637, 4265.7440553566885, 4269.615734583902, 5789.392113828029, 5961.761529538813, 5980.594560278331, 6028.7588496460085, 6032.946017067221, 4327.7186982846015, 4344.761038142869, 4366.563343665672, 4378.255696531597, 4395.27477966132, 4382.9342559861625, 4394.582514661102, 4425.114977004612, 4432.645388368923, 4444.488883778342, 4930.753462326869, 4945.703257804544, 4976.751162441863, 4991.575716064175, 5002.699838009658, 5742.59801813869, 5784.681842498619, 5809.738561764646, 5829.271341082364, 5829.5044921181325, 1463.9707205855823, 1482.910061105087, 1483.494253332868, 1484.317214081513, 1494.2080697230485, 979.3536266064364, 1018.7351288664852, 1022.1158697726413, 1034.6482196053378, 1051.0, 5544.445555444423, 5560.527355174774, 5565.220869078333, 5576.721163941867, 5583.0, 5749.367569567345, 5780.884382312414, 5793.8841223175305, 5837.67892765902, 5852.824415267463, 5437.374701909252, 5542.944570554324, 5553.861763221189, 5557.527610153183, 5558.638688485235, 3036.8481575921555, 3047.4666933286585, 3082.1061892051052, 3089.6137982752157, 3098.98450507746, 5820.2830165101395, 5936.8812623748145, 5990.191324171268, 6006.249218847644, 6007.459328660354, 5800.709964501758, 5811.3026436827, 5846.269216347957, 5877.588568800228, 5933.495652869468, 5853.970730146322, 5888.499477544457, 5947.881042379128, 5974.027271864162, 6013.098035294741, 5469.589780766379, 5685.488306052475, 5696.287964004499, 5784.855378615568, 5820.738066787089, 5626.831195064155, 5651.971740141437, 5675.0636145035605, 5683.914741278967, 5702.600817942704, 5893.469587736953, 6105.84735381619, 6110.236220472441, 6127.877442451215, 6154.969225153845, 4320.891977700583, 4341.500727416387, 4342.609165175149, 4351.73889566627, 4381.474223093249, 5782.85542861415, 5914.822555323347, 5972.522198224218, 5974.551908606785, 6009.549283803644, 5748.780682817635, 5755.223044889054, 5759.481646651821, 5785.623934444247, 5798.246227990503, 5714.742836572447, 5738.540916726568, 5768.307803063659, 5819.272590926134, 5824.621399609012, 5470.781168753365, 5707.543396528351, 5711.828645140652, 5747.597668163356, 5760.395158508296, 5791.333996590446, 5824.3593204748295, 5828.444648764335, 5855.268091488564, 5857.0, 5472.972635136799, 5667.854340840873, 5672.432756724294, 5689.122589545523, 5754.597178197653], "value": 4436.82547232665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.709251761883, 850.2772643253239, 856.1994535109673, 921.4839689773727, 952.995235023825, 16874.325026998922, 18137.546561335974, 18154.3645972391, 19382.321618743346, 19401.320953766623, 17745.64508709828, 18049.81950180501, 18528.258869645233, 18714.251429942786, 18728.531786705338, 834.5284914023557, 851.0213254757017, 852.6163226548047, 852.6972924611766, 853.6798700487317, 822.1408627983772, 849.1381248033251, 849.3332733803934, 849.8257857139303, 850.5067061104576, 871.790770215147, 880.7401816464159, 882.9911700882973, 883.3419102768446, 884.1423818895693, 873.2795443758893, 876.6493402638931, 878.7583414560983, 883.7172104926426, 885.654594708058, 641.272156102822, 649.1334069017867, 649.2241771083557, 649.3149727037973, 650.5998810731413, 15816.130112843788, 16228.0, 16841.915790420968, 16867.915660421742, 16874.578135546588, 15414.845851541566, 16170.75743863843, 16342.428015019535, 16366.590835229215, 16439.83560164395, 13090.345482725921, 13480.258585777778, 13596.184228946295, 14048.43806247749, 14092.788608170886, 4120.711550191488, 4149.80560184084, 4169.937450938239, 4182.393552934838, 4230.090530535918, 81456.18543814545, 82397.0, 82630.0, 82889.58555207246, 83082.0, 13421.731565368638, 13459.663508412368, 13490.932545337211, 13541.59375218745, 13562.321883905764, 25381.238562843144, 25473.490530189294, 26222.0, 26256.21231363062, 26465.206043818715, 9045.095490451034, 9084.364094513452, 9156.221721153777, 9186.724398268063, 9237.538123093818, 4886.315915771724, 4909.2881532177635, 5023.34696489454, 5039.21892106724, 5064.670796398223, 4011.338129208648, 4073.042834933788, 4156.127213285184, 4196.853110141131, 4251.553586873396, 676.4351766275117, 683.7606837606797, 691.3017851969547, 695.02696225285, 704.6476761619191, 850.4642075492524, 853.7566793463833, 858.952757598338, 866.8093019535692, 870.6822009966317, 11237.3257604544, 11248.550057997589, 11305.886941130648, 12178.330191839357, 12346.13577049598, 866.8136350684633, 877.5699907045629, 891.1088911088912, 902.273669695888, 913.3287034029983, 5477.561795056386, 5597.132444471114, 5603.943960560424, 5672.8865422691315, 5689.459501347365, 80786.0, 81753.0, 83202.0, 83761.0, 83940.58029709812, 56534.43465565374, 61938.070928936104, 64430.677846610466, 69632.30367696258, 70207.0, 63115.0, 63828.68085659635, 64283.35716642774, 64292.35707642957, 64646.35353646497, 11396.715082123013, 11680.357580333164, 11891.881081189424, 11910.702232444259, 11941.223820451643, 40258.79870600628, 40584.59415405808, 41557.79221103875, 41866.0, 43132.78433607812, 50529.49470505248, 52618.47381526136, 52756.73621631867, 53646.46353536415, 55222.723886380314, 14373.784393234318, 14533.92733036328, 14603.269836508345, 14693.485727999469, 14714.337854796773, 15659.060456372654, 15735.527934161993, 15830.0, 15927.283272252545, 15959.840401595835, 13795.241261730702, 13881.861181388056, 13901.791473127709, 13925.303734813016, 14747.115173089649, 15709.135997520247, 15792.684146317239, 16038.198090095682, 16538.33846646169, 16559.917200414402, 14878.628034298796, 15250.847491524943, 15568.610784730472, 15645.0, 15989.0, 12153.149279550347, 12173.878261217274, 12729.74540509166, 12734.490620375082, 13037.348132593143, 11771.470283837076, 12249.755004900031, 12377.824106709848, 12482.875171248172, 12650.177738447339], "value": 8011.5039332036295, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 115.0, 113.0, 113.0, 113.0, 115.0, 115.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 120.0, 163.0, 125.0, 120.0, 123.0, 121.0, 136.0, 123.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 164.0, 160.0, 164.0, 162.0, 163.0, 162.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 115.0, 75.0, 76.0, 76.0, 76.0, 95.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 103.0, 83.0, 82.0, 84.0, 94.0, 84.0, 82.0, 112.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 61.0, 55.0, 64.0, 55.0, 56.0, 55.0, 58.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 66.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 77.0, 76.0, 76.0, 77.0, 78.0, 77.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 121.0, 129.0, 129.0, 121.0, 124.0, 119.0, 161.0, 137.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 157.0, 156.0, 157.0, 160.0, 155.0, 158.0, 154.0, 159.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 64.0, 60.0, 60.0, 60.0, 61.0, 60.0, 69.0, 61.0], "value": 61.6, "unit": "score"}]}]} 09:10:45 INFO - Return code: 0 09:10:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:45 ERROR - # TBPL SUCCESS # 09:10:45 INFO - Running post-action listener: _resource_record_post_action 09:10:45 INFO - [mozharness: 2017-02-09 17:10:45.865407Z] Finished run-tests step (success) 09:10:45 INFO - Running post-run listener: _resource_record_post_run 09:10:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 362328064; Read time: 36; Write time: 223800 09:10:45 INFO - TinderboxPrint: CPU usage
13.3% 09:10:45 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 09:10:45 INFO - TinderboxPrint: I/O write bytes / time
362,328,064 / 223,800 09:10:45 INFO - TinderboxPrint: CPU idle
8,228.2 (86.7%) 09:10:45 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 09:10:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:10:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109613056; Read time: 0; Write time: 94656 09:10:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252100608; Read time: 36; Write time: 129144 09:10:46 INFO - Running post-run listener: _upload_blobber_files 09:10:46 INFO - Blob upload gear active. 09:10:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:46 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 09:10:46 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:10:46 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:10:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:47 INFO - (blobuploader) - INFO - Done attempting. 09:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:48 INFO - (blobuploader) - INFO - Done attempting. 09:10:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:52 INFO - (blobuploader) - INFO - Done attempting. 09:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:53 INFO - (blobuploader) - INFO - Done attempting. 09:10:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:53 INFO - Return code: 0 09:10:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c29f0eece0a1c4cd5da6c4d57338b2f676301493be649cdc3685d0b4d673fd66e3043d7643410852975ff4732ad26b2ffba361fb7526d52bc5d37a452c7ac35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53d3c7ffdd8dd5e9b909580ff4ea4ff3fb3b3fa8b7b785127d135aa065a2dba989c0a75bcd845847304a95e510bd13b71e9c328950b5b322e2c5255c16c236de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fba54f9d23762fc7f47f737a318ddd6798fc3246733b61a488b4dbe12bde1037afaa3641fe0fb9d798584e0c2ab22520f2befce2704e0ef96d81bce3aac350", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ac69178aa4172cc11b77e4234166f73cb298e81c92367eae08cd92c2763f3dc5c016d5527f90768c5914a3b517e7ed21c1a3e33a8569d8b01846812ce25c2"} 09:10:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:53 INFO - Contents: 09:10:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c29f0eece0a1c4cd5da6c4d57338b2f676301493be649cdc3685d0b4d673fd66e3043d7643410852975ff4732ad26b2ffba361fb7526d52bc5d37a452c7ac35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53d3c7ffdd8dd5e9b909580ff4ea4ff3fb3b3fa8b7b785127d135aa065a2dba989c0a75bcd845847304a95e510bd13b71e9c328950b5b322e2c5255c16c236de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fba54f9d23762fc7f47f737a318ddd6798fc3246733b61a488b4dbe12bde1037afaa3641fe0fb9d798584e0c2ab22520f2befce2704e0ef96d81bce3aac350", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ac69178aa4172cc11b77e4234166f73cb298e81c92367eae08cd92c2763f3dc5c016d5527f90768c5914a3b517e7ed21c1a3e33a8569d8b01846812ce25c2"} 09:10:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:53 INFO - Copying logs to upload dir... 09:10:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.696698 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 09:10:53.266790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 09:10:53.270069) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c29f0eece0a1c4cd5da6c4d57338b2f676301493be649cdc3685d0b4d673fd66e3043d7643410852975ff4732ad26b2ffba361fb7526d52bc5d37a452c7ac35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53d3c7ffdd8dd5e9b909580ff4ea4ff3fb3b3fa8b7b785127d135aa065a2dba989c0a75bcd845847304a95e510bd13b71e9c328950b5b322e2c5255c16c236de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fba54f9d23762fc7f47f737a318ddd6798fc3246733b61a488b4dbe12bde1037afaa3641fe0fb9d798584e0c2ab22520f2befce2704e0ef96d81bce3aac350", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ac69178aa4172cc11b77e4234166f73cb298e81c92367eae08cd92c2763f3dc5c016d5527f90768c5914a3b517e7ed21c1a3e33a8569d8b01846812ce25c2"} build_url:https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/bxXyMWRFQf-SndmpKA-mVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c29f0eece0a1c4cd5da6c4d57338b2f676301493be649cdc3685d0b4d673fd66e3043d7643410852975ff4732ad26b2ffba361fb7526d52bc5d37a452c7ac35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53d3c7ffdd8dd5e9b909580ff4ea4ff3fb3b3fa8b7b785127d135aa065a2dba989c0a75bcd845847304a95e510bd13b71e9c328950b5b322e2c5255c16c236de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fba54f9d23762fc7f47f737a318ddd6798fc3246733b61a488b4dbe12bde1037afaa3641fe0fb9d798584e0c2ab22520f2befce2704e0ef96d81bce3aac350", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ac69178aa4172cc11b77e4234166f73cb298e81c92367eae08cd92c2763f3dc5c016d5527f90768c5914a3b517e7ed21c1a3e33a8569d8b01846812ce25c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 09:10:53.295846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 09:10:53.296212) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486659014.610947-593231691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 09:10:53.378566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 09:10:53.378937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 09:10:53.379254) ========= ========= Total master_lag: 0.15 =========