builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1500937050.03 results: success (0) revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.027158) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.027559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.027852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.053862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.054161) ========= 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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 15:57:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-07-24 15:57:30 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.189692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.189972) ========= 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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:30.239543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:57:30.239836) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf4634a50775537b4e791b6d294a275b83737472 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev bf4634a50775537b4e791b6d294a275b83737472 --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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 15:57:30,318 truncating revision to first 12 chars 2017-07-24 15:57:30,318 Setting DEBUG logging. 2017-07-24 15:57:30,318 attempt 1/10 2017-07-24 15:57:30,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf4634a50775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 15:57:31,234 unpacking tar archive at: mozilla-central-bf4634a50775/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:57:31.566746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:31.567074) ========= script_repo_revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:31.567457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:31.567725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:57:31.582062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-24 15:57:31.582391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:57:31 INFO - MultiFileLogger online at 20170724 15:57:31 in /builds/slave/test 15:57:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:57:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:57:31 INFO - {'append_to_log': False, 15:57:31 INFO - 'base_work_dir': '/builds/slave/test', 15:57:31 INFO - 'blob_upload_branch': 'Firefox', 15:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:57:31 INFO - 'branch': 'Firefox', 15:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:57:31 INFO - 'code_coverage': False, 15:57:31 INFO - 'config_files': ('talos/linux_config.py',), 15:57:31 INFO - 'default_actions': ('clobber', 15:57:31 INFO - 'read-buildbot-config', 15:57:31 INFO - 'download-and-extract', 15:57:31 INFO - 'populate-webroot', 15:57:31 INFO - 'create-virtualenv', 15:57:31 INFO - 'install', 15:57:31 INFO - 'setup-mitmproxy', 15:57:31 INFO - 'run-tests'), 15:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:57:31 INFO - 'disable_ccov_upload': False, 15:57:31 INFO - 'download_minidump_stackwalk': True, 15:57:31 INFO - 'download_symbols': 'ondemand', 15:57:31 INFO - 'enable_stylo': False, 15:57:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:57:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:57:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:57:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:57:31 INFO - 'gecko_profile': False, 15:57:31 INFO - 'gecko_profile_interval': 0, 15:57:31 INFO - 'installer_path': 'installer.exe', 15:57:31 INFO - 'log_level': 'info', 15:57:31 INFO - 'log_name': 'talos', 15:57:31 INFO - 'log_to_console': True, 15:57:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:57:31 INFO - 'opt_config_files': (), 15:57:31 INFO - 'pip_index': False, 15:57:31 INFO - 'suite': 'dromaeojs-e10s', 15:57:31 INFO - 'system_bits': '32', 15:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:57:31 INFO - 'title': 'talos-linux64-ix-046', 15:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:57:31 INFO - 'use_talos_json': True, 15:57:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:57:31 INFO - 'work_dir': 'build'} 15:57:31 INFO - [mozharness: 2017-07-24 22:57:31.763605Z] Running clobber step. 15:57:31 INFO - Running pre-action listener: _resource_record_pre_action 15:57:31 INFO - Running main action method: clobber 15:57:31 INFO - rmtree: /builds/slave/test/build 15:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:57:33 INFO - Running post-action listener: _resource_record_post_action 15:57:33 INFO - [mozharness: 2017-07-24 22:57:33.316446Z] Finished clobber step (success) 15:57:33 INFO - [mozharness: 2017-07-24 22:57:33.316547Z] Running read-buildbot-config step. 15:57:33 INFO - Running pre-action listener: _resource_record_pre_action 15:57:33 INFO - Running main action method: read_buildbot_config 15:57:33 INFO - Using buildbot properties: 15:57:33 INFO - { 15:57:33 INFO - "project": "", 15:57:33 INFO - "product": "firefox", 15:57:33 INFO - "who": "kwierso@gmail.com", 15:57:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:57:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:57:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:57:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:57:33 INFO - "stage_platform": "linux64-pgo", 15:57:33 INFO - "basedir": "/builds/slave/test", 15:57:33 INFO - "buildnumber": 90, 15:57:33 INFO - "platform": "ubuntu64_hw", 15:57:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:57:33 INFO - "slavebuilddir": "test", 15:57:33 INFO - "taskId": "S9FHnmwQT7uSzw4T98Xbfw", 15:57:33 INFO - "branch": "mozilla-central", 15:57:33 INFO - "script_repo_revision": "production", 15:57:33 INFO - "revision": "bf4634a50775537b4e791b6d294a275b83737472", 15:57:33 INFO - "slavename": "talos-linux64-ix-046", 15:57:33 INFO - "repo_path": "mozilla-central" 15:57:33 INFO - } 15:57:33 INFO - Finding installer, test and symbols from parent task. 15:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9FHnmwQT7uSzw4T98Xbfw'}, attempt #1 15:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9FHnmwQT7uSzw4T98Xbfw'}, attempt #1 15:57:34 INFO - Task dependencies: VhPW1zlGTruhhn1_LjFUDA 15:57:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA'}, attempt #1 15:57:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 15:57:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/test_packages.json 15:57:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.crashreporter-symbols.zip 15:57:34 INFO - Running post-action listener: _resource_record_post_action 15:57:34 INFO - [mozharness: 2017-07-24 22:57:34.662144Z] Finished read-buildbot-config step (success) 15:57:34 INFO - [mozharness: 2017-07-24 22:57:34.662365Z] Running download-and-extract step. 15:57:34 INFO - Running pre-action listener: _resource_record_pre_action 15:57:34 INFO - Running main action method: download_and_extract 15:57:34 INFO - mkdir: /builds/slave/test/build/tests 15:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:34 INFO - trying https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.test_packages.json 15:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:57:35 INFO - Downloaded 989 bytes. 15:57:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:57:35 INFO - Using the following test package requirements: 15:57:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:57:35 INFO - u'common': [u'target.common.tests.zip'], 15:57:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:57:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:57:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:57:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:57:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:57:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:57:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:57:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:57:35 INFO - u'target.web-platform.tests.tar.gz'], 15:57:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:57:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:57:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip 15:57:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:57:35 INFO - Fetch https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip into memory 15:57:36 INFO - Content-Length response header: 73381822 15:57:36 INFO - Bytes received: 73381822 15:57:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip 15:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.common.tests.zip into memory 15:57:49 INFO - Content-Length response header: 73381822 15:57:49 INFO - Bytes received: 73381822 15:58:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.talos.tests.zip 15:58:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:58:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.talos.tests.zip into memory 15:58:04 INFO - Content-Length response header: 14498976 15:58:04 INFO - Bytes received: 14498976 15:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:04 INFO - trying https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 15:58:04 INFO - Downloading https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:58:06 INFO - Downloaded 62932256 bytes. 15:58:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 15:58:06 INFO - mkdir: /builds/slave/test/properties 15:58:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:06 INFO - Contents: 15:58:06 INFO - build_url:https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 15:58:06 INFO - Running post-action listener: _resource_record_post_action 15:58:06 INFO - Running post-action listener: set_extra_try_arguments 15:58:06 INFO - [mozharness: 2017-07-24 22:58:06.122688Z] Finished download-and-extract step (success) 15:58:06 INFO - [mozharness: 2017-07-24 22:58:06.122786Z] Running populate-webroot step. 15:58:06 INFO - Running pre-action listener: _resource_record_pre_action 15:58:06 INFO - Running main action method: populate_webroot 15:58:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:58:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:58:06 INFO - 'tests': ['damp', 'tps']}, 15:58:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:58:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:58:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:58:06 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:06 INFO - 'ts_paint', 15:58:06 INFO - 'tpaint', 15:58:06 INFO - 'sessionrestore', 15:58:06 INFO - 'sessionrestore_many_windows', 15:58:06 INFO - 'sessionrestore_no_auto_restore', 15:58:06 INFO - 'tabpaint']}, 15:58:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:58:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:58:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:06 INFO - 'talos_options': ['--mitmproxy', 15:58:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:06 INFO - '--firstNonBlankPaint'], 15:58:06 INFO - 'tests': ['quantum_pageload_google', 15:58:06 INFO - 'quantum_pageload_youtube', 15:58:06 INFO - 'quantum_pageload_amazon', 15:58:06 INFO - 'quantum_pageload_facebook']}, 15:58:06 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:06 INFO - 'talos_options': ['--stylo', 15:58:06 INFO - '--mitmproxy', 15:58:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:06 INFO - '--firstNonBlankPaint'], 15:58:06 INFO - 'tests': ['quantum_pageload_google', 15:58:06 INFO - 'quantum_pageload_youtube', 15:58:06 INFO - 'quantum_pageload_amazon', 15:58:06 INFO - 'quantum_pageload_facebook']}, 15:58:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:06 INFO - 'tsvgr_opacity', 15:58:06 INFO - 'tart', 15:58:06 INFO - 'tscrollx', 15:58:06 INFO - 'cart', 15:58:06 INFO - 'tsvg_static']}, 15:58:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:58:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:58:06 INFO - 'talos_options': ['--xperf_path', 15:58:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:06 INFO - 'tests': ['tp5n']}}} 15:58:06 INFO - Running post-action listener: _resource_record_post_action 15:58:06 INFO - [mozharness: 2017-07-24 22:58:06.130112Z] Finished populate-webroot step (success) 15:58:06 INFO - [mozharness: 2017-07-24 22:58:06.130202Z] Running create-virtualenv step. 15:58:06 INFO - Running pre-action listener: _resource_record_pre_action 15:58:06 INFO - Running main action method: create_virtualenv 15:58:06 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:58:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:06 INFO - Using real prefix '/usr' 15:58:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:08 INFO - Installing pip.................done. 15:58:08 INFO - Return code: 0 15:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:08 INFO - Reading from file tmpfile_stdout 15:58:08 INFO - Output received: 15:58:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:58:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:08 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:58:08 INFO - Using env: {'DISPLAY': ':0', 15:58:08 INFO - 'HOME': '/home/cltbld', 15:58:08 INFO - 'LANG': 'en_US.UTF-8', 15:58:08 INFO - 'LANGUAGE': 'en_US:en', 15:58:08 INFO - 'LOGNAME': 'cltbld', 15:58:08 INFO - 'MAIL': '/var/mail/cltbld', 15:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:08 INFO - 'MOZ_NO_REMOTE': '1', 15:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:08 INFO - 'NO_EM_RESTART': '1', 15:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:08 INFO - 'PWD': '/builds/slave/test', 15:58:08 INFO - 'SHELL': '/bin/bash', 15:58:08 INFO - 'SHLVL': '1', 15:58:08 INFO - 'TERM': 'linux', 15:58:08 INFO - 'TMOUT': '86400', 15:58:08 INFO - 'USER': 'cltbld', 15:58:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:08 INFO - '_': '/tools/buildbot/bin/python'} 15:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:58:09 INFO - Cleaning up... 15:58:09 INFO - Return code: 0 15:58:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:58:09 INFO - Using env: {'DISPLAY': ':0', 15:58:09 INFO - 'HOME': '/home/cltbld', 15:58:09 INFO - 'LANG': 'en_US.UTF-8', 15:58:09 INFO - 'LANGUAGE': 'en_US:en', 15:58:09 INFO - 'LOGNAME': 'cltbld', 15:58:09 INFO - 'MAIL': '/var/mail/cltbld', 15:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:09 INFO - 'MOZ_NO_REMOTE': '1', 15:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:09 INFO - 'NO_EM_RESTART': '1', 15:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:09 INFO - 'PWD': '/builds/slave/test', 15:58:09 INFO - 'SHELL': '/bin/bash', 15:58:09 INFO - 'SHLVL': '1', 15:58:09 INFO - 'TERM': 'linux', 15:58:09 INFO - 'TMOUT': '86400', 15:58:09 INFO - 'USER': 'cltbld', 15:58:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:09 INFO - '_': '/tools/buildbot/bin/python'} 15:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:09 INFO - Downloading/unpacking psutil>=3.1.1 15:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:10 INFO - Installing collected packages: psutil 15:58:10 INFO - Running setup.py install for psutil 15:58:10 INFO - building 'psutil._psutil_linux' extension 15:58:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:58:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:58:10 INFO - building 'psutil._psutil_posix' extension 15:58:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:58:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:58:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:11 INFO - Successfully installed psutil 15:58:11 INFO - Cleaning up... 15:58:11 INFO - Return code: 0 15:58:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:11 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:58:11 INFO - Using env: {'DISPLAY': ':0', 15:58:11 INFO - 'HOME': '/home/cltbld', 15:58:11 INFO - 'LANG': 'en_US.UTF-8', 15:58:11 INFO - 'LANGUAGE': 'en_US:en', 15:58:11 INFO - 'LOGNAME': 'cltbld', 15:58:11 INFO - 'MAIL': '/var/mail/cltbld', 15:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:11 INFO - 'MOZ_NO_REMOTE': '1', 15:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:11 INFO - 'NO_EM_RESTART': '1', 15:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:11 INFO - 'PWD': '/builds/slave/test', 15:58:11 INFO - 'SHELL': '/bin/bash', 15:58:11 INFO - 'SHLVL': '1', 15:58:11 INFO - 'TERM': 'linux', 15:58:11 INFO - 'TMOUT': '86400', 15:58:11 INFO - 'USER': 'cltbld', 15:58:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:11 INFO - '_': '/tools/buildbot/bin/python'} 15:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:12 INFO - Installing collected packages: mozsystemmonitor 15:58:12 INFO - Running setup.py install for mozsystemmonitor 15:58:12 INFO - Successfully installed mozsystemmonitor 15:58:12 INFO - Cleaning up... 15:58:12 INFO - Return code: 0 15:58:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:12 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:58:12 INFO - Using env: {'DISPLAY': ':0', 15:58:12 INFO - 'HOME': '/home/cltbld', 15:58:12 INFO - 'LANG': 'en_US.UTF-8', 15:58:12 INFO - 'LANGUAGE': 'en_US:en', 15:58:12 INFO - 'LOGNAME': 'cltbld', 15:58:12 INFO - 'MAIL': '/var/mail/cltbld', 15:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:12 INFO - 'MOZ_NO_REMOTE': '1', 15:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:12 INFO - 'NO_EM_RESTART': '1', 15:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:12 INFO - 'PWD': '/builds/slave/test', 15:58:12 INFO - 'SHELL': '/bin/bash', 15:58:12 INFO - 'SHLVL': '1', 15:58:12 INFO - 'TERM': 'linux', 15:58:12 INFO - 'TMOUT': '86400', 15:58:12 INFO - 'USER': 'cltbld', 15:58:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:12 INFO - '_': '/tools/buildbot/bin/python'} 15:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:12 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:14 INFO - warning: no files found matching '*.txt' 15:58:14 INFO - no previously-included directories found matching 'build' 15:58:14 INFO - no previously-included directories found matching 'dist' 15:58:14 INFO - no previously-included directories found matching '.git*' 15:58:14 INFO - Installing collected packages: jsonschema, functools32 15:58:14 INFO - Running setup.py install for functools32 15:58:14 INFO - warning: no files found matching '*.txt' 15:58:14 INFO - no previously-included directories found matching 'build' 15:58:14 INFO - no previously-included directories found matching 'dist' 15:58:14 INFO - no previously-included directories found matching '.git*' 15:58:14 INFO - Successfully installed jsonschema functools32 15:58:14 INFO - Cleaning up... 15:58:14 INFO - Return code: 0 15:58:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:14 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:58:14 INFO - Using env: {'DISPLAY': ':0', 15:58:14 INFO - 'HOME': '/home/cltbld', 15:58:14 INFO - 'LANG': 'en_US.UTF-8', 15:58:14 INFO - 'LANGUAGE': 'en_US:en', 15:58:14 INFO - 'LOGNAME': 'cltbld', 15:58:14 INFO - 'MAIL': '/var/mail/cltbld', 15:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:14 INFO - 'MOZ_NO_REMOTE': '1', 15:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:14 INFO - 'NO_EM_RESTART': '1', 15:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:14 INFO - 'PWD': '/builds/slave/test', 15:58:14 INFO - 'SHELL': '/bin/bash', 15:58:14 INFO - 'SHLVL': '1', 15:58:14 INFO - 'TERM': 'linux', 15:58:14 INFO - 'TMOUT': '86400', 15:58:14 INFO - 'USER': 'cltbld', 15:58:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:14 INFO - '_': '/tools/buildbot/bin/python'} 15:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:58:14 INFO - Cleaning up... 15:58:14 INFO - Return code: 0 15:58:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:14 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:58:14 INFO - Using env: {'DISPLAY': ':0', 15:58:14 INFO - 'HOME': '/home/cltbld', 15:58:14 INFO - 'LANG': 'en_US.UTF-8', 15:58:14 INFO - 'LANGUAGE': 'en_US:en', 15:58:14 INFO - 'LOGNAME': 'cltbld', 15:58:14 INFO - 'MAIL': '/var/mail/cltbld', 15:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:14 INFO - 'MOZ_NO_REMOTE': '1', 15:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:14 INFO - 'NO_EM_RESTART': '1', 15:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:14 INFO - 'PWD': '/builds/slave/test', 15:58:14 INFO - 'SHELL': '/bin/bash', 15:58:14 INFO - 'SHLVL': '1', 15:58:14 INFO - 'TERM': 'linux', 15:58:14 INFO - 'TMOUT': '86400', 15:58:14 INFO - 'USER': 'cltbld', 15:58:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:14 INFO - '_': '/tools/buildbot/bin/python'} 15:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:15 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:16 INFO - Downloading docopt-0.6.1.tar.gz 15:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:16 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:16 INFO - Running setup.py install for blobuploader 15:58:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:16 INFO - Running setup.py install for requests 15:58:16 INFO - Running setup.py install for docopt 15:58:16 INFO - Successfully installed blobuploader requests docopt 15:58:16 INFO - Cleaning up... 15:58:16 INFO - Return code: 0 15:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:58:16 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:58:16 INFO - Using env: {'DISPLAY': ':0', 15:58:16 INFO - 'HOME': '/home/cltbld', 15:58:16 INFO - 'LANG': 'en_US.UTF-8', 15:58:16 INFO - 'LANGUAGE': 'en_US:en', 15:58:16 INFO - 'LOGNAME': 'cltbld', 15:58:16 INFO - 'MAIL': '/var/mail/cltbld', 15:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:16 INFO - 'MOZ_NO_REMOTE': '1', 15:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:16 INFO - 'NO_EM_RESTART': '1', 15:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:16 INFO - 'PWD': '/builds/slave/test', 15:58:16 INFO - 'SHELL': '/bin/bash', 15:58:16 INFO - 'SHLVL': '1', 15:58:16 INFO - 'TERM': 'linux', 15:58:16 INFO - 'TMOUT': '86400', 15:58:16 INFO - 'USER': 'cltbld', 15:58:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:16 INFO - '_': '/tools/buildbot/bin/python'} 15:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:17 INFO - Running setup.py (path:/tmp/pip-gdoIbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:17 INFO - Running setup.py (path:/tmp/pip-E8M1C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:17 INFO - Running setup.py (path:/tmp/pip-9ciQrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:17 INFO - Running setup.py (path:/tmp/pip-qTVO9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:17 INFO - Running setup.py (path:/tmp/pip-icZTAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:17 INFO - Running setup.py (path:/tmp/pip-AAjy36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:17 INFO - Running setup.py (path:/tmp/pip-HLi1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:17 INFO - Running setup.py (path:/tmp/pip-cz8q_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:17 INFO - Running setup.py (path:/tmp/pip-IVIG1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:17 INFO - Running setup.py (path:/tmp/pip-eigsZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:17 INFO - Running setup.py (path:/tmp/pip-q8ydlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:17 INFO - Running setup.py (path:/tmp/pip-IbOjj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:18 INFO - Running setup.py (path:/tmp/pip-fiN3u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:18 INFO - Running setup.py (path:/tmp/pip-RkCRwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:18 INFO - Running setup.py (path:/tmp/pip-g9RJze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:18 INFO - Running setup.py (path:/tmp/pip-klRf8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:18 INFO - Running setup.py (path:/tmp/pip-I86jNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:58:18 INFO - Running setup.py install for manifestparser 15:58:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:58:18 INFO - Running setup.py install for mozcrash 15:58:18 INFO - Running setup.py install for mozdebug 15:58:18 INFO - Running setup.py install for mozdevice 15:58:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:58:18 INFO - Running setup.py install for mozfile 15:58:18 INFO - Running setup.py install for mozhttpd 15:58:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:58:18 INFO - Running setup.py install for mozinfo 15:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozInstall 15:58:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozleak 15:58:19 INFO - Running setup.py install for mozlog 15:58:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for moznetwork 15:58:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozprocess 15:58:19 INFO - Running setup.py install for mozprofile 15:58:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozrunner 15:58:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozscreenshot 15:58:19 INFO - Running setup.py install for moztest 15:58:20 INFO - Running setup.py install for mozversion 15:58:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:58:20 INFO - Cleaning up... 15:58:20 INFO - Return code: 0 15:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:58:20 INFO - Using env: {'DISPLAY': ':0', 15:58:20 INFO - 'HOME': '/home/cltbld', 15:58:20 INFO - 'LANG': 'en_US.UTF-8', 15:58:20 INFO - 'LANGUAGE': 'en_US:en', 15:58:20 INFO - 'LOGNAME': 'cltbld', 15:58:20 INFO - 'MAIL': '/var/mail/cltbld', 15:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:20 INFO - 'MOZ_NO_REMOTE': '1', 15:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:20 INFO - 'NO_EM_RESTART': '1', 15:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:20 INFO - 'PWD': '/builds/slave/test', 15:58:20 INFO - 'SHELL': '/bin/bash', 15:58:20 INFO - 'SHLVL': '1', 15:58:20 INFO - 'TERM': 'linux', 15:58:20 INFO - 'TMOUT': '86400', 15:58:20 INFO - 'USER': 'cltbld', 15:58:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:20 INFO - '_': '/tools/buildbot/bin/python'} 15:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:20 INFO - Running setup.py (path:/tmp/pip-PvXU8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:20 INFO - Running setup.py (path:/tmp/pip-SSGMz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:20 INFO - Running setup.py (path:/tmp/pip-xhUNQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:20 INFO - Running setup.py (path:/tmp/pip-lN3Lq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:20 INFO - Running setup.py (path:/tmp/pip-cOCuWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:20 INFO - Running setup.py (path:/tmp/pip-FfCSeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:20 INFO - Running setup.py (path:/tmp/pip-TEbyFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:20 INFO - Running setup.py (path:/tmp/pip-MB9bL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:20 INFO - Running setup.py (path:/tmp/pip-siqnin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:21 INFO - Running setup.py (path:/tmp/pip-8dxMS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:21 INFO - Running setup.py (path:/tmp/pip-myEvTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:21 INFO - Running setup.py (path:/tmp/pip-m0Q2Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:21 INFO - Running setup.py (path:/tmp/pip-l2Kovz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:21 INFO - Running setup.py (path:/tmp/pip-BfXBqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:21 INFO - Running setup.py (path:/tmp/pip-5DdZha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:21 INFO - Running setup.py (path:/tmp/pip-xajpQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:21 INFO - Running setup.py (path:/tmp/pip-NpKaJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:22 INFO - Downloading blessings-1.6.tar.gz 15:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:58:22 INFO - Installing collected packages: blessings 15:58:22 INFO - Running setup.py install for blessings 15:58:22 INFO - Successfully installed blessings 15:58:22 INFO - Cleaning up... 15:58:22 INFO - Return code: 0 15:58:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:58:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:23 INFO - Reading from file tmpfile_stdout 15:58:23 INFO - Current package versions: 15:58:23 INFO - argparse == 1.2.1 15:58:23 INFO - blessings == 1.6 15:58:23 INFO - blobuploader == 1.2.4 15:58:23 INFO - docopt == 0.6.1 15:58:23 INFO - functools32 == 3.2.3-2 15:58:23 INFO - jsonschema == 2.5.1 15:58:23 INFO - manifestparser == 1.1 15:58:23 INFO - mozInstall == 1.13 15:58:23 INFO - mozcrash == 1.0 15:58:23 INFO - mozdebug == 0.1 15:58:23 INFO - mozdevice == 0.51 15:58:23 INFO - mozfile == 1.2 15:58:23 INFO - mozhttpd == 0.7 15:58:23 INFO - mozinfo == 0.10 15:58:23 INFO - mozleak == 0.1 15:58:23 INFO - mozlog == 3.5 15:58:23 INFO - moznetwork == 0.27 15:58:23 INFO - mozprocess == 0.25 15:58:23 INFO - mozprofile == 0.28 15:58:23 INFO - mozrunner == 6.13 15:58:23 INFO - mozscreenshot == 0.1 15:58:23 INFO - mozsystemmonitor == 0.3 15:58:23 INFO - moztest == 0.8 15:58:23 INFO - mozversion == 1.4 15:58:23 INFO - psutil == 3.1.1 15:58:23 INFO - requests == 1.2.3 15:58:23 INFO - wsgiref == 0.1.2 15:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:23 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:23 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:58:23 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:58:23 INFO - Using env: {'DISPLAY': ':0', 15:58:23 INFO - 'HOME': '/home/cltbld', 15:58:23 INFO - 'LANG': 'en_US.UTF-8', 15:58:23 INFO - 'LANGUAGE': 'en_US:en', 15:58:23 INFO - 'LOGNAME': 'cltbld', 15:58:23 INFO - 'MAIL': '/var/mail/cltbld', 15:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:23 INFO - 'MOZ_NO_REMOTE': '1', 15:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:23 INFO - 'NO_EM_RESTART': '1', 15:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:23 INFO - 'PWD': '/builds/slave/test', 15:58:23 INFO - 'SHELL': '/bin/bash', 15:58:23 INFO - 'SHLVL': '1', 15:58:23 INFO - 'TERM': 'linux', 15:58:23 INFO - 'TMOUT': '86400', 15:58:23 INFO - 'USER': 'cltbld', 15:58:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:23 INFO - '_': '/tools/buildbot/bin/python'} 15:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:58:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:58:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:58:24 INFO - Installing collected packages: marionette-driver, simplejson 15:58:24 INFO - Running setup.py install for marionette-driver 15:58:24 INFO - Running setup.py install for simplejson 15:58:24 INFO - building 'simplejson._speedups' extension 15:58:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:58:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:58:25 INFO - Successfully installed marionette-driver simplejson 15:58:25 INFO - Cleaning up... 15:58:25 INFO - Return code: 0 15:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:25 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/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 0x9c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb90a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd33d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, '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': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:58:25 INFO - Using env: {'DISPLAY': ':0', 15:58:25 INFO - 'HOME': '/home/cltbld', 15:58:25 INFO - 'LANG': 'en_US.UTF-8', 15:58:25 INFO - 'LANGUAGE': 'en_US:en', 15:58:25 INFO - 'LOGNAME': 'cltbld', 15:58:25 INFO - 'MAIL': '/var/mail/cltbld', 15:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:25 INFO - 'MOZ_NO_REMOTE': '1', 15:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:25 INFO - 'NO_EM_RESTART': '1', 15:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:25 INFO - 'PWD': '/builds/slave/test', 15:58:25 INFO - 'SHELL': '/bin/bash', 15:58:25 INFO - 'SHLVL': '1', 15:58:25 INFO - 'TERM': 'linux', 15:58:25 INFO - 'TMOUT': '86400', 15:58:25 INFO - 'USER': 'cltbld', 15:58:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:25 INFO - '_': '/tools/buildbot/bin/python'} 15:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:58:26 INFO - Cleaning up... 15:58:26 INFO - Return code: 0 15:58:26 INFO - Running post-action listener: _resource_record_post_action 15:58:26 INFO - Running post-action listener: _start_resource_monitoring 15:58:26 INFO - Starting resource monitoring. 15:58:26 INFO - [mozharness: 2017-07-24 22:58:26.183150Z] Finished create-virtualenv step (success) 15:58:26 INFO - [mozharness: 2017-07-24 22:58:26.183697Z] Running install step. 15:58:26 INFO - Running pre-action listener: _resource_record_pre_action 15:58:26 INFO - Running main action method: install 15:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:26 INFO - Reading from file tmpfile_stdout 15:58:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:58:26 INFO - Reading from file tmpfile_stdout 15:58:26 INFO - Output received: 15:58:26 INFO - Usage: mozinstall [options] installer 15:58:26 INFO - Options: 15:58:26 INFO - -h, --help show this help message and exit 15:58:26 INFO - -d DEST, --destination=DEST 15:58:26 INFO - Directory to install application into. [default: 15:58:26 INFO - "/builds/slave/test"] 15:58:26 INFO - --app=APP Application being installed. [default: firefox] 15:58:26 INFO - mkdir: /builds/slave/test/build/application 15:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:58:44 INFO - Reading from file tmpfile_stdout 15:58:44 INFO - Output received: 15:58:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:58:44 INFO - Running post-action listener: _resource_record_post_action 15:58:44 INFO - [mozharness: 2017-07-24 22:58:44.369645Z] Finished install step (success) 15:58:44 INFO - [mozharness: 2017-07-24 22:58:44.369991Z] Running setup-mitmproxy step. 15:58:44 INFO - Running pre-action listener: _resource_record_pre_action 15:58:44 INFO - Running main action method: setup_mitmproxy 15:58:44 INFO - Skipping: mitmproxy is not required 15:58:44 INFO - Running post-action listener: _resource_record_post_action 15:58:44 INFO - [mozharness: 2017-07-24 22:58:44.371609Z] Finished setup-mitmproxy step (success) 15:58:44 INFO - [mozharness: 2017-07-24 22:58:44.371924Z] Running run-tests step. 15:58:44 INFO - Running pre-action listener: _resource_record_pre_action 15:58:44 INFO - Running pre-action listener: _set_gcov_prefix 15:58:44 INFO - Running main action method: run_tests 15:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:58:44 INFO - Python 2.7.3 15:58:44 INFO - Return code: 0 15:58:44 INFO - grabbing minidump binary from tooltool 15:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:44 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 0xd30eb0>, '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 0xd31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd32240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:58:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:58:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:58:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:58:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:58:44 INFO - Return code: 0 15:58:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:58:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:58:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:58:44 INFO - ENV: RUST_BACKTRACE is now 1 15:58:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:58:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 15:58:44 INFO - Using env: {'DISPLAY': ':0', 15:58:44 INFO - 'HOME': '/home/cltbld', 15:58:44 INFO - 'LANG': 'en_US.UTF-8', 15:58:44 INFO - 'LANGUAGE': 'en_US:en', 15:58:44 INFO - 'LOGNAME': 'cltbld', 15:58:44 INFO - 'MAIL': '/var/mail/cltbld', 15:58:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:58:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:44 INFO - 'MOZ_NO_REMOTE': '1', 15:58:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:44 INFO - 'NO_EM_RESTART': '1', 15:58:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:44 INFO - 'PWD': '/builds/slave/test', 15:58:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:58:44 INFO - 'RUST_BACKTRACE': '1', 15:58:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:58:44 INFO - 'SHELL': '/bin/bash', 15:58:44 INFO - 'SHLVL': '1', 15:58:44 INFO - 'TERM': 'linux', 15:58:44 INFO - 'TMOUT': '86400', 15:58:44 INFO - 'USER': 'cltbld', 15:58:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181', 15:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:44 INFO - '_': '/tools/buildbot/bin/python'} 15:58:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:58:44 INFO - mozversion application_buildid: 20170724215058 15:58:44 INFO - mozversion application_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:58:44 INFO - mozversion application_display_name: Nightly 15:58:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:58:44 INFO - mozversion application_name: Firefox 15:58:44 INFO - mozversion application_remotingname: firefox 15:58:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:58:44 INFO - mozversion application_vendor: Mozilla 15:58:44 INFO - mozversion application_version: 56.0a1 15:58:44 INFO - mozversion platform_buildid: 20170724215058 15:58:44 INFO - mozversion platform_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:58:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:58:44 INFO - mozversion platform_version: 56.0a1 15:58:44 INFO - using testdate: 1500937124 15:58:44 INFO - actual date: 1500937124 15:58:44 INFO - starting webserver on 'localhost:45762' 15:58:44 INFO - SUITE-START | Running 2 tests 15:58:44 INFO - TEST-START | dromaeo_css 15:58:44 INFO - Initialising browser for dromaeo_css test... 15:58:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45762/getInfo.html -profile /tmp/tmpiociRy/profile 15:58:44 INFO - TEST-INFO | started process 10929 (/builds/slave/test/build/application/firefox/firefox http://localhost:45762/getInfo.html) 15:58:50 INFO - TEST-INFO | 10929: exit 0 15:58:50 INFO - Browser initialized. 15:58:50 INFO - Running cycle 1/1 for dromaeo_css test... 15:58:50 INFO - TEST-INFO | started process 11143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiociRy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:01 INFO - PID 11143 | RSS: Main: 167817216 15:59:01 INFO - PID 11143 | 16:02:00 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45762/tests/dromaeo/cssquery-ext.html) 16:02:01 INFO - PID 11143 | RSS: Main: 172445696 16:02:01 INFO - PID 11143 | 16:05:02 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-ext.html (next: http://localhost:45762/tests/dromaeo/cssquery-jquery.html) 16:05:03 INFO - PID 11143 | RSS: Main: 171089920 16:05:03 INFO - PID 11143 | 16:08:05 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45762/tests/dromaeo/cssquery-mootools.html) 16:08:05 INFO - PID 11143 | RSS: Main: 173367296 16:08:05 INFO - PID 11143 | 16:11:07 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45762/tests/dromaeo/cssquery-prototype.html) 16:11:07 INFO - PID 11143 | RSS: Main: 171003904 16:11:07 INFO - PID 11143 | 16:14:11 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45762/tests/dromaeo/cssquery-yui.html) 16:14:11 INFO - PID 11143 | RSS: Main: 173109248 16:14:11 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | Cycle 1(1): loaded http://localhost:45762/tests/dromaeo/cssquery-yui.html (next: http://localhost:45762/tests/dromaeo/cssquery-dojo.html) 16:17:13 INFO - PID 11143 | RSS: Main: 173522944 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | __start_tp_report 16:17:13 INFO - PID 11143 | _x_x_mozilla_page_load 16:17:13 INFO - PID 11143 | _x_x_mozilla_page_load_details 16:17:13 INFO - PID 11143 | |i|pagename|runs| 16:17:13 INFO - PID 11143 | |0;dojo.html;3325.8669653213874;3352.1116904020437;3380.3070370574032;3381.763276570638;3418.931621367573;5945.256842894638;5956.761729530814;5974.850628734283;6043.576949613529;6044.032954727245;5977.282726072866;6039.879202415949;6065.272167339915;6067.908981365283;6148.10852426399;5349.893002139955;5384.757685904144;5388.757505912224;5390.73046347683;5416.4312747161575;5248.947510524884;5328.8401347959625;5367;5398.8920221595545;5410.756515956772;5293.02079115363;5351.411344752074;5374.892502149954;5402.8919421611345;5405.783768649249;5264.52619264268;5311.468853114658;5349.786008559653;5391.892162156735;5392.0294347017525;5276.551493123089;5343.465653434625;5343.877785665015;5371.811986580451;5381.569474442035;5977.641341519523;6002.189704389939;6038.396160383971;6046.09308603713;6075.088736689488;6411.0383442483535;6432.774852880174;6485.2541957675;6551.967240163816;6564.737410503574;6566.967165164144;6660;6666.966665166643;6672.332766723337;6680.632565208912;6098.39016098391;6131.570790044654;6175.87648247037;6181.103739957681;6203.844903877439;6588.96705516479;6656.800295991128;6665.200175978816;6680.899786503109;6739.93260067393;6404.583702059351;6457.2896981332015;6489.70796314167;6494.512911531559;6502.902456463157;6530.8040758777315;6544.803655890331;6613.702383392759;6631.502637302222;6647.501437392215;6421.389967953037;6459.9010806029255;6477.1579694639395;6482.092507049017;6542.476601871839;6510;6513.316101809337;6540.640264785387;6567.376099270562;6570.868582628321;4761.738104404221;4781.641376896747;4820.493848145894;4827.348307978448;4839.540243676845;4227.217964676544;4296.9570304297185;4298.398224248608;4328.935065974013;4363.694541382073;6253.78111766086;6295.6537390443045;6325;6327.746890124344;6335.873282534416;6539.8365040873405;6547.639879806657;6627.768028119089;6628.972509261072;6635.369639884203;6190.102435146879;6192;6244.625322480666;6259.6870156492905;6274.2784579773;5405.027095122916;5428.8099916503525;5463.590230732711;5467.699276539828;5469.288992430958;6857.657117144223;6889.069975553236;6925.445964322842;6967.09427774386;6974.128233970754;6483.610983341015;6490.935090649033;6544.901826472512;6574.868502629825;6601.603903765789;6868.553544019623;6911.516193866381;6929.272426395358;6935.237123916264;6940.13248343957;6356.9046464304;6430.614163150226;6449.032645103272;6514.967425162844;6516.771912983023;6482;6564.113844630913;6609.768658096944;6622.569532980341;6667.966660166668;6334.081558173947;6376.936230637634;6382.106505089384;6396.392342727433;6430.967845160744;6300.464460520907;6356.523260755369;6361.17304750398;6379.52153588492;6387.297397286202;6288.151099601679;6295.653739044396;6307.590006649553;6374.107624932606;6375.649339286384;6348.111264423077;6410.262819775599;6424.967875160594;6461.030845373231;6466;6182.598131121463;6207.037909124093;6232.376762323732;6245.500359971283;6266.811995640138 16:17:13 INFO - PID 11143 | |1;ext.html;837.3552364679197;869.5956380283167;891.0688330694423;912.0879120879121;918.0727465260086;44833.55166448335;45516.089678206416;45592;45799.54200457995;45963.540364596345;40852.59147408525;40923.795381023054;41015;41032.17935641285;41099.79450102753;6858.211305699859;6926.549774264682;6942.271061538541;6950.548214366076;6960.860782784342;6841.17905851296;6922.65386730664;6930.861382772341;6950.756723514678;6969.616671083114;6909.239983601799;7455.440841936849;7733.53598784072;7743.845123097534;7747.806304842367;7673.731419400322;7676.232376762335;7685.846283074307;7692.884606730903;7707;7451.143118541383;7504;7627.69489220436;7652.808679782995;7653.502522336031;41641;42062.36906446406;42083.7895810522;42118.789406052776;42220.15559688789;3523.8766643167364;3568.107973006748;3569.446735755962;3572.9995601231435;3575.249197668493;31739.841300793578;31973.360532789447;32019.51970720441;32082.679173208202;32155.19612009695;4997.250412438127;5020.347354843847;5027.673201241944;5086.440491545964;5102.464241254652;248207;262742;262791;262922.6853865738;263835;54602.63493412617;54795.726021369635;54805.45194548083;54920.45079549153;54946;56643;56852;56875.14687279694;56883.71558142183;56969.14546281809;16829.41097061597;17164;17173.141342932802;17173.7423938641;17186.570335741457;14048.438062477386;14050.578482645536;14064.226467544178;14064.71870562583;14079.507217247346;15340.079595224099;15398.07611543311;15399.384024639114;15533.922330388275;15591;5887.61730487517;6019;6035.486983606443;6058.787942421994;6183.412575805291;1057.360297020307;1091.47063674118;1092.6995076354067;1095.2606990281529;1106.4523061084815;29927.401451971273;30545.694543054284;31036;31610.367792644018;31768.682313176574;1173.9823902641467;1175.9647210583696;1187.2579637726421;1187.804012337972;1192.260798305039;16393.59016024585;16951.237194326284;17314.307427703003;17327.393541226247;17451.912740436215;282052;285470;285652;285800;285852;54946.72526637421;55853.72073139608;62537.68731156315;62734.372656273765;63014.36985630177;1510.6752048309665;1518.8177418709824;1527.1829571179367;1536.0399750156153;1546.0337289194254;28549.714502855535;29116.856917438225;29730.55404168896;30075.849620751756;30319.696803031686;41525.169496610506;41794.79102604589;41951.58048419477;41968.580314196464;41975.370369445096;216283;216585;216872;217095;217235;36604.26791464209;36609;36666;36692.24808139454;36698;45075.549244508446;45102.54897451115;45410.54589454063;46067.539324606325;46337.3049404266;32338.35323293568;33865.83067084649;33989.83005084959;34012.48981265332;34394.82802585971;32173.839130804197;32953.17617059593;33092.33815323632;33136.33727325392;33227.83386083054;38518.2296354077;38807.80596097114;39209.41185882157;39374.409383859835;39382.60617393904;30926.22684432907;32430.513542296412;35264.64735352614;35712.92861214168;35760.46359304665;25939.0921317753;26281.4743705121;26506.602400963617;27140.32149196286;27378.315542111606 16:17:13 INFO - PID 11143 | |2;jquery.html;554.6921458590481;567.6764244380702;573.7475510775258;575.7409165875357;591.3938213331335;22702.88648556755;22770.658440123392;23444.29667109985;23533;23594.292171234847;26744.866275668643;27356.179314620593;27412.588811167847;27459.588106178424;27484;6273.592216505924;6357.713902874381;6407.135036770046;6422.03669449584;6443.452306553949;5609.52319052881;6082.695865206744;6100.481459075984;6100.542459315569;6101.755929762827;6070.48400885923;6071.332153463116;6071.666058366788;6075.63546187228;6076.513878889678;5994.46049855513;6007.399260073979;6027.60820546663;6040;6044.546659000549;5605.971970140124;5611.494965453129;5629.183768353607;5632.127020311858;5651.689157096358;28906.566401503784;30219.244518886982;30296;30617.693823061705;30746.385072298428;2091.5712278982774;2140.35789263222;2141.0365335599045;2144.2923835134525;2145.6137895178863;19553.706694399596;20128;20184.49538761543;20189.19243230269;20204.595908081905;2373.2576300822143;2401.5797235483897;2437.390652336916;2441.475082857194;2457.7542245775458;150160;152182;152201.9999999989;152261;152471.23764381217;15025.248737563297;15578.143202123765;15691.843081569266;15713.921430392775;15907.681846363008;23252.186173483846;23758.64362034571;23852.52294954126;23909.16317928864;23935;10165.814349914655;10179.643712470177;10281.794364112677;10359.94820025895;10475.319104258198;9238.214751746176;9292.210162136294;9294.117058879396;9354.158125768578;9440.150386465251;9640.90359096414;9678.612855485702;9779.549134387844;9865.301079982453;9912.851307230398;2805.2846524136216;2831.0506842954373;2834.8724307406214;2844.900428484993;2861.8282903025884;1050.6900464363032;1056.3186744549723;1061.4215252687304;1072.7210925159359;1078.7896360209684;20495.385138445872;21214.25750098739;21391.67912481314;21688;25596.23211303664;1112.5382966068992;1116.4529380603446;1120.6918097523246;1148.7128217945515;1149.3793351590048;11913.404329783649;12284.938575307246;12424.440900159334;12427.813582796265;12681.746365072831;555485;556670;570144;575148;576444;140142.29928850493;142461.28769356088;143899.28050359682;145673.27163364115;146034;1341.2824139085542;1342.9865701343058;1357.8166947461966;1372.0601388049217;1377.758892193862;19742.210311587376;19914;19927.202911883363;20041.599168016266;20109.89945050324;53203.467965319855;60215.09677354756;63547.682261588394;66921;67551.3244867545;73103.63448182725;73319.26680733338;73556.26443735494;73839;74327.62836185785;14639.19484428324;14743.18912459825;14846.257687115385;15104.79161667086;15119.092854428769;23935;23944.161954332212;24278.15026474065;24355.878220608785;24368.390790230387;19243.230270789012;19273.807261927763;19300.32448864283;19443.902780486573;19447.70828437546;15595.986260893005;15626.218689065274;16699.582510437336;18039.729404058686;18155.001474919005;19013.80986190176;20206;20271.59456810826;20473.590528189652;20527;14720.705585888436;14895.47865824691;15045.699086018438;15122.848771512145;15139.243037848284;19256.711149333052;19321.51696207606;19477.220911163397;19508;19528.31650892212 16:17:13 INFO - PID 11143 | |3;mootools.html;1452.382737336632;1477.5567329801056;1499.5426394949538;1501.8122734658168;1508.630385555539;14896.627584310398;15370.154641494713;15503.767443488343;15518.146501942389;15545.53363399097;14828.332725027372;15213.4675286365;15773.290201940912;15784.44754433595;15804.367825286974;2481.4416756229884;2538.4796116796015;2545.0328875027462;2546.961795573068;2547.223096955428;2381.57131716291;2406.4946361264156;2477.306354220821;2580.2646245819947;2694.1648089092446;2678.4375281190974;2685.8657067146664;2715.470483255756;2715.6876959149654;2715.891364345434;2624.527585034693;2628.9999999999905;2636.6967798703204;2652.045263705065;2669.1058495403868;2451.36264571211;2485.763852434016;2578.9484210315877;2665;2666.919992400212;14834;15009;15033.624159395993;15034.398624055024;15043.548693539211;7602.125755538129;7905.051393832777;7908.130105688369;7910.367170626336;7913.841723165505;4960.1567733485035;5011.473795251519;5192.766325515361;5196.948030519684;5197.636165468381;1873.8219869112413;1895.658781419344;1899.43017094871;1940.7088936659472;1951.0829909942304;25457.745422545908;25575;25616.615750763565;25667;25707.35731606706;6516.283208847023;6616.801495955129;6781.186257649114;6807.5575087619145;6819.454443644497;16924.238409271613;18080.819191808176;18100.818991810178;18107;18132;7809.414293927978;7971.800704982422;7993.360531157494;7997.920020799834;8000.8799868002025;7308.96345518269;7323.816904577428;7352.228016058344;7437.219091995371;7550.056242969629;5196.350456192976;5301.920471192935;5313.44208858072;5321.494458026481;5322.121849894724;1523.2536057331827;1548.2723120133744;1549.8450154984412;1551.4337266897726;1558.462330495977;900.3922352412096;909.1408618855119;916.8945571259258;926.9443833370019;950.4107453378949;7454.813629659302;7729.652165652559;7774.805629859299;7923;7935.841283174304;712.9786106416816;757.9962100189464;768.2624680306856;770.6801677303969;779.4582764978398;4705.317728929286;4967.3294105296045;5755.539556835527;6023.584882100637;6345.650989195547;21015.8949205253;21495.140194392363;21769.891150544147;21879.12483500642;21912.45218869509;20332.69500957487;21027.8948605256;21131.47171320729;21180.682289765668;21198.576028479343;11959.521619135137;12119.75760484803;12144.514219431123;12145.939270303768;12163.939180304042;8316.459430137022;8839.425437346808;8855.60149793248;9030.864537032081;9216.677416290666;18155.636887262444;18613.720794188368;18785.6242875139;18944.810551894858;18993.24027038903;17844.643107138043;18238.08809559543;18887.90556047211;19483.12325945364;19711.60576788485;12791.680207994874;13911.234882081582;14002.43990240379;14020.509282175075;14080;13989.300534973007;14135.929320353333;14265.928670356581;14280.500182493563;14372.640683982983;11354.489047992694;11675.182737208654;11877.22798018126;11908.52365905354;12124.211926224767;10996.890031099907;11490.368029758443;11531.654050378502;11554.364509951698;11610;10579.36523808574;10615.150787936793;10924.563017479211;10948.397838118979;10961.232713710282;7344.742933997284;7580.431467640059;7635.847283054419;7705;7800.882986755317;7625.199354067965;7821.960890195513;7843.529388236724;7872.56700881457;7986.520808751494 16:17:13 INFO - PID 11143 | |4;prototype.html;480.94228692556896;502.3845788908586;509.60505608153676;514.7529185990725;519.1589624807812;5884.616730224256;5954.851128721784;6046.697665116738;6051.757929682813;6135.435463956696;5888.528917686585;5936.762529498815;6018.8194354169445;6023.30731965823;6043.697815109249;4820.493848145947;4836.395450568679;4848.806047758086;4863.951360486403;4874.97562512187;4791.976040119795;4808.951910480903;4820.831270905519;4858.635602329822;4898.118338699032;4832.646858879501;4837.782299796518;4839.854804355875;4869.440014398337;4905.705657660534;4791.329213910038;4842.176829938937;4856.757162141914;4866.204360598738;4867.4889136640495;4454.621357184643;4539.9570193412765;4562.5665561771575;4565.908681826378;4608.654350923694;5830.5044071254;5918.6621284592775;5939.792107276267;6008.03871380577;6063.575549711522;5728.398518155575;5798.971005144989;5814.633561113135;5873.122170136645;5937.782754535353;6436.613803171778;6461.967690161519;6466.482681385478;6504.77233296837;6505.381988711112;5097.7960881564695;5154.974225128851;5158.6667199552185;5160.122779127557;5195.402528709209;6689.130413046321;6702.530822842403;6739.898901516482;6748.426383757386;6753.4259587935085;5302.151655735064;5306.54894333986;5316.122839731478;5342.6260161788305;5367.892642147213;5358.27663265462;5367.624266301322;5375.919361209585;5404.864878378072;5409.891802163935;5796.420357964254;5822.737976791054;5842.357340692521;5870.148828419855;5884.911726324109;6229.13793448056;6395.720855828853;6447.580907241015;6447.9355206447335;6541.47668186544;1804.6571151481176;1849.9075046247633;1857.1364315593314;1879.436169149277;1884.2086323743786;1101.251149218539;1319.1755153029358;1335.6927906581345;1336.4720935230723;1373.8351397832323;6003;6109.5112391008615;6135.386461353829;6182.227221597301;6216.906746398808;6579.30917253691;6599;6605;6649.734010639617;6693.464522838161;6177.62934223948;6199.132121502993;6256.280527739277;6272.498200143978;6299.370062993664;3486.4944583035317;3496.8426420810615;3504.632013638582;3525.347810655037;3548.520949671813;6821.522493425413;6841.418479429205;6843.62360070191;6856.211535673362;6921.335285914858;6772.864542709118;6812.591244525344;6817.284185160586;6827.317268273133;6852.875608561362;6856.177258728984;6932.618705971119;6951.304869513008;6958.93041069593;7000.47496437759;6486.286508484157;6565.901511477427;6609.867802644017;6614.173228346457;6645.401913827779;6579.6840631874775;6605.310229736749;6628.83427914306;6635.6350400728425;6642.667866606554;6920.5847649141215;6924.896126558005;6961;6976.511644184859;7034.944758286298;4956.975215123901;4959.975200123977;4975.756060984754;4979.526944940225;4985.551300382983;6649.700763465559;6656.5340426169705;6657.267700553032;6659.53383263167;6697.397234248941;6444.548881578245;6446.646204296962;6476.222853257639;6486.740530378732;6533.314002029719;6317.96841015792;6386.944290375738;6393.936060639334;6411;6419.935800641933;6302;6341.841453963688;6407.519436042408;6409.391107844747;6411.935880641134;5915.994280972331;6446.743639726058;6452.322506136788;6469.385408386196;6505.154329937078;6154.169187159855;6168.198134242699;6169.691515424301;6196.969015154896;6266.342034086538 16:17:13 INFO - PID 11143 | |5;yui.html;917.403687603058;926.3098991251519;939.6382392778779;943.231266517788;965.0976337124789;18001.7299740504;18991.62016759666;19020.714689279674;19052.33316833911;21955.121795128216;19901.203951841908;20319.593608127827;20527.07628156733;20581.073851676672;20607.896960515212;1013.062916801959;1107.4518113533773;1107.8559787227648;1111.22214449885;1112.1269803204486;1095.1950316517352;1096.9780604387906;1098.0447011100355;1099.0383414512303;1100.350793032111;1159.1422347462858;1160.9941950290238;1161.2684009074271;1163.9941800290987;1167.6146871532374;1135.6763322453144;1141.8458508101426;1143.816989281715;1144.4277861069424;1145.73075327298;845.7885528617845;849.142366210126;852.8038551133274;853.2704537620369;853.63293783673;18254;18319.175637096363;18490.167942442622;19876;20031.298904538417;20823.271185508587;21005.36983890486;21140.682889756667;21266.893665531727;21322.573548529097;16027.679446411006;16154.192290385552;16325.10211938343;16335.754963675436;16390.590235244093;3524.3832329342263;3558.1104723819044;3565.6434356564396;3594.2991116732246;3594.982025089884;132237.3388133053;138604.30697846547;138881.3055934714;140086;143500;15068.849311506963;15592;16133.274002669908;16272.918635406748;16291.755623665655;31012.22469438282;31318.06045818629;31340;31486.212844679067;32058.83970580132;8858.86711699325;8859.601317940707;8936.106389361012;8944.50805205707;9046.954765226132;4498.145352383102;4578.244589642672;4581.862544123682;4587.747673877969;4592.2422800238255;5354.223637572531;5376.838694839161;5501.504864562208;5556.055470569932;5560.165975103767;1030.8144533983955;1037.3775734559204;1062.134360496193;1062.7874425115008;1065.307550092446;670.9966450167718;678.7488629207224;684.3977299976088;711.5019486359465;714.5498336048256;11620.825687614693;11658.358790266448;11942.223755455867;12865.549705760253;12889.291088990009;674.1236392689484;698.200560358397;718.9496735228588;724.9565026098451;726.5604309392742;5597.888042239132;5660.433956604306;5671.234383358276;5767.394423585547;5932.851678708067;121847;124168;126364;127122;129195.35402323116;113175.81417672284;114146.42926785313;116896;117867.41066294613;120375;91800;97373.5131324353;98865.50567247262;98892.99999999856;100983;12875.871241287841;13076.934615326862;13395.933020334836;13430;13445.798313025116;46230.76884615555;46799.298010529186;47714.76142619265;49558.752206238736;49631;84723;84871;85187;86427.56786216029;88601.55699221462;19006;19413;19755.111020003846;20018.399448016582;20395.4901127473;21714.457138571663;21781.564368712854;21789.564208716052;21954.780452195275;22164.224252151096;19419.3203237886;19569.60860782748;19729.60540789205;19840.801591983894;20066.89966550158;16702.58243543921;16870.746938796172;17021.404250851658;19299.324523641604;19894.403167904988;17567.209475573374;19110.904445477685;19512.21951121939;19731.40805775829;19940.3020894268;14334.713305734036;14428;15021.399144034116;15306.617334566725;15569.610759731097;14342.067765595202;14382.568522944328;14411.855881441052;14612.634684132981;14665.56003319902 16:17:13 INFO - PID 11143 | __end_tp_report 16:17:13 INFO - PID 11143 | __start_cc_report 16:17:13 INFO - PID 11143 | _x_x_mozilla_cycle_collect,344 16:17:13 INFO - PID 11143 | __end_cc_report 16:17:13 INFO - PID 11143 | __startTimestamp1500938233671__endTimestamp 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | ------- Summary: start ------- 16:17:13 INFO - PID 11143 | Number of tests: 6 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#0] dojo.html Cycles:165 Average:6033.81 Median:6327.75 stddev:770.68 (12.2%) stddev-sans-first:743.18 16:17:13 INFO - PID 11143 | Values: 3325.9 3352.1 3380.3 3381.8 3418.9 5945.3 5956.8 5974.9 6043.6 6044.0 5977.3 6039.9 6065.3 6067.9 6148.1 5349.9 5384.8 5388.8 5390.7 5416.4 5248.9 5328.8 5367.0 5398.9 5410.8 5293.0 5351.4 5374.9 5402.9 5405.8 5264.5 5311.5 5349.8 5391.9 5392.0 5276.6 5343.5 5343.9 5371.8 5381.6 5977.6 6002.2 6038.4 6046.1 6075.1 6411.0 6432.8 6485.3 6552.0 6564.7 6567.0 6660.0 6667.0 6672.3 6680.6 6098.4 6131.6 6175.9 6181.1 6203.8 6589.0 6656.8 6665.2 6680.9 6739.9 6404.6 6457.3 6489.7 6494.5 6502.9 6530.8 6544.8 6613.7 6631.5 6647.5 6421.4 6459.9 6477.2 6482.1 6542.5 6510.0 6513.3 6540.6 6567.4 6570.9 4761.7 4781.6 4820.5 4827.3 4839.5 4227.2 4297.0 4298.4 4328.9 4363.7 6253.8 6295.7 6325.0 6327.7 6335.9 6539.8 6547.6 6627.8 6629.0 6635.4 6190.1 6192.0 6244.6 6259.7 6274.3 5405.0 5428.8 5463.6 5467.7 5469.3 6857.7 6889.1 6925.4 6967.1 6974.1 6483.6 6490.9 6544.9 6574.9 6601.6 6868.6 6911.5 6929.3 6935.2 6940.1 6356.9 6430.6 6449.0 6515.0 6516.8 6482.0 6564.1 6609.8 6622.6 6668.0 6334.1 6376.9 6382.1 6396.4 6431.0 6300.5 6356.5 6361.2 6379.5 6387.3 6288.2 6295.7 6307.6 6374.1 6375.6 6348.1 6410.3 6425.0 6461.0 6466.0 6182.6 6207.0 6232.4 6245.5 6266.8 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#1] ext.html Cycles:180 Average:43460.19 Median:36606.63 stddev:66491.23 (181.6%) stddev-sans-first:66600.73 16:17:13 INFO - PID 11143 | Values: 837.4 869.6 891.1 912.1 918.1 44833.6 45516.1 45592.0 45799.5 45963.5 40852.6 40923.8 41015.0 41032.2 41099.8 6858.2 6926.5 6942.3 6950.5 6960.9 6841.2 6922.7 6930.9 6950.8 6969.6 6909.2 7455.4 7733.5 7743.8 7747.8 7673.7 7676.2 7685.8 7692.9 7707.0 7451.1 7504.0 7627.7 7652.8 7653.5 41641.0 42062.4 42083.8 42118.8 42220.2 3523.9 3568.1 3569.4 3573.0 3575.2 31739.8 31973.4 32019.5 32082.7 32155.2 4997.3 5020.3 5027.7 5086.4 5102.5 248207.0 262742.0 262791.0 262922.7 263835.0 54602.6 54795.7 54805.5 54920.5 54946.0 56643.0 56852.0 56875.1 56883.7 56969.1 16829.4 17164.0 17173.1 17173.7 17186.6 14048.4 14050.6 14064.2 14064.7 14079.5 15340.1 15398.1 15399.4 15533.9 15591.0 5887.6 6019.0 6035.5 6058.8 6183.4 1057.4 1091.5 1092.7 1095.3 1106.5 29927.4 30545.7 31036.0 31610.4 31768.7 1174.0 1176.0 1187.3 1187.8 1192.3 16393.6 16951.2 17314.3 17327.4 17451.9 282052.0 285470.0 285652.0 285800.0 285852.0 54946.7 55853.7 62537.7 62734.4 63014.4 1510.7 1518.8 1527.2 1536.0 1546.0 28549.7 29116.9 29730.6 30075.8 30319.7 41525.2 41794.8 41951.6 41968.6 41975.4 216283.0 216585.0 216872.0 217095.0 217235.0 36604.3 36609.0 36666.0 36692.2 36698.0 45075.5 45102.5 45410.5 46067.5 46337.3 32338.4 33865.8 33989.8 34012.5 34394.8 32173.8 32953.2 33092.3 33136.3 33227.8 38518.2 38807.8 39209.4 39374.4 39382.6 30926.2 32430.5 35264.6 35712.9 35760.5 25939.1 26281.5 26506.6 27140.3 27378.3 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#2] jquery.html Cycles:180 Average:38703.87 Median:23011.42 stddev:95692.87 (415.8%) stddev-sans-first:95918.44 16:17:13 INFO - PID 11143 | Values: 554.7 567.7 573.7 575.7 591.4 22702.9 22770.7 23444.3 23533.0 23594.3 26744.9 27356.2 27412.6 27459.6 27484.0 6273.6 6357.7 6407.1 6422.0 6443.5 5609.5 6082.7 6100.5 6100.5 6101.8 6070.5 6071.3 6071.7 6075.6 6076.5 5994.5 6007.4 6027.6 6040.0 6044.5 5606.0 5611.5 5629.2 5632.1 5651.7 28906.6 30219.2 30296.0 30617.7 30746.4 2091.6 2140.4 2141.0 2144.3 2145.6 19553.7 20128.0 20184.5 20189.2 20204.6 2373.3 2401.6 2437.4 2441.5 2457.8 150160.0 152182.0 152202.0 152261.0 152471.2 15025.2 15578.1 15691.8 15713.9 15907.7 23252.2 23758.6 23852.5 23909.2 23935.0 10165.8 10179.6 10281.8 10359.9 10475.3 9238.2 9292.2 9294.1 9354.2 9440.2 9640.9 9678.6 9779.5 9865.3 9912.9 2805.3 2831.1 2834.9 2844.9 2861.8 1050.7 1056.3 1061.4 1072.7 1078.8 20495.4 21214.3 21391.7 21688.0 25596.2 1112.5 1116.5 1120.7 1148.7 1149.4 11913.4 12284.9 12424.4 12427.8 12681.7 555485.0 556670.0 570144.0 575148.0 576444.0 140142.3 142461.3 143899.3 145673.3 146034.0 1341.3 1343.0 1357.8 1372.1 1377.8 19742.2 19914.0 19927.2 20041.6 20109.9 53203.5 60215.1 63547.7 66921.0 67551.3 73103.6 73319.3 73556.3 73839.0 74327.6 14639.2 14743.2 14846.3 15104.8 15119.1 23935.0 23944.2 24278.2 24355.9 24368.4 19243.2 19273.8 19300.3 19443.9 19447.7 15596.0 15626.2 16699.6 18039.7 18155.0 19013.8 20206.0 20271.6 20473.6 20527.0 14720.7 14895.5 15045.7 15122.8 15139.2 19256.7 19321.5 19477.2 19508.0 19528.3 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#3] mootools.html Cycles:180 Average:9473.48 Median:2512.12 stddev:6671.41 (265.6%) stddev-sans-first:6662.90 16:17:13 INFO - PID 11143 | Values: 1452.4 1477.6 1499.5 1501.8 1508.6 14896.6 15370.2 15503.8 15518.1 15545.5 14828.3 15213.5 15773.3 15784.4 15804.4 2481.4 2538.5 2545.0 2547.0 2547.2 2381.6 2406.5 2477.3 2580.3 2694.2 2678.4 2685.9 2715.5 2715.7 2715.9 2624.5 2629.0 2636.7 2652.0 2669.1 2451.4 2485.8 2578.9 2665.0 2666.9 14834.0 15009.0 15033.6 15034.4 15043.5 7602.1 7905.1 7908.1 7910.4 7913.8 4960.2 5011.5 5192.8 5196.9 5197.6 1873.8 1895.7 1899.4 1940.7 1951.1 25457.7 25575.0 25616.6 25667.0 25707.4 6516.3 6616.8 6781.2 6807.6 6819.5 16924.2 18080.8 18100.8 18107.0 18132.0 7809.4 7971.8 7993.4 7997.9 8000.9 7309.0 7323.8 7352.2 7437.2 7550.1 5196.4 5301.9 5313.4 5321.5 5322.1 1523.3 1548.3 1549.8 1551.4 1558.5 900.4 909.1 916.9 926.9 950.4 7454.8 7729.7 7774.8 7923.0 7935.8 713.0 758.0 768.3 770.7 779.5 4705.3 4967.3 5755.5 6023.6 6345.7 21015.9 21495.1 21769.9 21879.1 21912.5 20332.7 21027.9 21131.5 21180.7 21198.6 11959.5 12119.8 12144.5 12145.9 12163.9 8316.5 8839.4 8855.6 9030.9 9216.7 18155.6 18613.7 18785.6 18944.8 18993.2 17844.6 18238.1 18887.9 19483.1 19711.6 12791.7 13911.2 14002.4 14020.5 14080.0 13989.3 14135.9 14265.9 14280.5 14372.6 11354.5 11675.2 11877.2 11908.5 12124.2 10996.9 11490.4 11531.7 11554.4 11610.0 10579.4 10615.2 10924.6 10948.4 10961.2 7344.7 7580.4 7635.8 7705.0 7800.9 7625.2 7822.0 7843.5 7872.6 7986.5 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#4] prototype.html Cycles:180 Average:5538.82 Median:6086.54 stddev:1538.45 (25.3%) stddev-sans-first:1495.19 16:17:13 INFO - PID 11143 | Values: 480.9 502.4 509.6 514.8 519.2 5884.6 5954.9 6046.7 6051.8 6135.4 5888.5 5936.8 6018.8 6023.3 6043.7 4820.5 4836.4 4848.8 4864.0 4875.0 4792.0 4809.0 4820.8 4858.6 4898.1 4832.6 4837.8 4839.9 4869.4 4905.7 4791.3 4842.2 4856.8 4866.2 4867.5 4454.6 4540.0 4562.6 4565.9 4608.7 5830.5 5918.7 5939.8 6008.0 6063.6 5728.4 5799.0 5814.6 5873.1 5937.8 6436.6 6462.0 6466.5 6504.8 6505.4 5097.8 5155.0 5158.7 5160.1 5195.4 6689.1 6702.5 6739.9 6748.4 6753.4 5302.2 5306.5 5316.1 5342.6 5367.9 5358.3 5367.6 5375.9 5404.9 5409.9 5796.4 5822.7 5842.4 5870.1 5884.9 6229.1 6395.7 6447.6 6447.9 6541.5 1804.7 1849.9 1857.1 1879.4 1884.2 1101.3 1319.2 1335.7 1336.5 1373.8 6003.0 6109.5 6135.4 6182.2 6216.9 6579.3 6599.0 6605.0 6649.7 6693.5 6177.6 6199.1 6256.3 6272.5 6299.4 3486.5 3496.8 3504.6 3525.3 3548.5 6821.5 6841.4 6843.6 6856.2 6921.3 6772.9 6812.6 6817.3 6827.3 6852.9 6856.2 6932.6 6951.3 6958.9 7000.5 6486.3 6565.9 6609.9 6614.2 6645.4 6579.7 6605.3 6628.8 6635.6 6642.7 6920.6 6924.9 6961.0 6976.5 7034.9 4957.0 4960.0 4975.8 4979.5 4985.6 6649.7 6656.5 6657.3 6659.5 6697.4 6444.5 6446.6 6476.2 6486.7 6533.3 6318.0 6386.9 6393.9 6411.0 6419.9 6302.0 6341.8 6407.5 6409.4 6411.9 5916.0 6446.7 6452.3 6469.4 6505.2 6154.2 6168.2 6169.7 6197.0 6266.3 16:17:13 INFO - PID 11143 | 16:17:13 INFO - PID 11143 | [#5] yui.html Cycles:180 Average:26283.00 Median:19743.26 stddev:36993.12 (187.4%) stddev-sans-first:37047.86 16:17:13 INFO - PID 11143 | Values: 917.4 926.3 939.6 943.2 965.1 18001.7 18991.6 19020.7 19052.3 21955.1 19901.2 20319.6 20527.1 20581.1 20607.9 1013.1 1107.5 1107.9 1111.2 1112.1 1095.2 1097.0 1098.0 1099.0 1100.4 1159.1 1161.0 1161.3 1164.0 1167.6 1135.7 1141.8 1143.8 1144.4 1145.7 845.8 849.1 852.8 853.3 853.6 18254.0 18319.2 18490.2 19876.0 20031.3 20823.3 21005.4 21140.7 21266.9 21322.6 16027.7 16154.2 16325.1 16335.8 16390.6 3524.4 3558.1 3565.6 3594.3 3595.0 132237.3 138604.3 138881.3 140086.0 143500.0 15068.8 15592.0 16133.3 16272.9 16291.8 31012.2 31318.1 31340.0 31486.2 32058.8 8858.9 8859.6 8936.1 8944.5 9047.0 4498.1 4578.2 4581.9 4587.7 4592.2 5354.2 5376.8 5501.5 5556.1 5560.2 1030.8 1037.4 1062.1 1062.8 1065.3 671.0 678.7 684.4 711.5 714.5 11620.8 11658.4 11942.2 12865.5 12889.3 674.1 698.2 718.9 725.0 726.6 5597.9 5660.4 5671.2 5767.4 5932.9 121847.0 124168.0 126364.0 127122.0 129195.4 113175.8 114146.4 116896.0 117867.4 120375.0 91800.0 97373.5 98865.5 98893.0 100983.0 12875.9 13076.9 13395.9 13430.0 13445.8 46230.8 46799.3 47714.8 49558.8 49631.0 84723.0 84871.0 85187.0 86427.6 88601.6 19006.0 19413.0 19755.1 20018.4 20395.5 21714.5 21781.6 21789.6 21954.8 22164.2 19419.3 19569.6 19729.6 19840.8 20066.9 16702.6 16870.7 17021.4 19299.3 19894.4 17567.2 19110.9 19512.2 19731.4 19940.3 14334.7 14428.0 15021.4 15306.6 15569.6 14342.1 14382.6 14411.9 14612.6 14665.6 16:17:13 INFO - PID 11143 | -------- Summary: end -------- 16:17:13 INFO - PID 11143 | 16:17:14 INFO - TEST-INFO | 11143: exit 0 16:17:14 INFO - TEST-OK | dromaeo_css | took 1109645ms 16:17:14 INFO - TEST-START | kraken 16:17:14 INFO - Initialising browser for kraken test... 16:17:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45762/getInfo.html -profile /tmp/tmpX2ZDQp/profile 16:17:14 INFO - TEST-INFO | started process 11520 (/builds/slave/test/build/application/firefox/firefox http://localhost:45762/getInfo.html) 16:17:20 INFO - TEST-INFO | 11520: exit 0 16:17:20 INFO - Browser initialized. 16:17:20 INFO - Running cycle 1/1 for kraken test... 16:17:20 INFO - TEST-INFO | started process 11728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX2ZDQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:31 INFO - PID 11728 | RSS: Main: 164110336 16:17:31 INFO - PID 11728 | 16:17:34 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45762/tests/kraken/driver.html?testName=audio-beat-detection) 16:17:34 INFO - PID 11728 | RSS: Main: 169611264 16:17:34 INFO - PID 11728 | 16:17:37 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45762/tests/kraken/driver.html?testName=audio-dft) 16:17:38 INFO - PID 11728 | RSS: Main: 170491904 16:17:38 INFO - PID 11728 | 16:17:41 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45762/tests/kraken/driver.html?testName=audio-fft) 16:17:41 INFO - PID 11728 | RSS: Main: 164724736 16:17:41 INFO - PID 11728 | 16:17:43 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45762/tests/kraken/driver.html?testName=audio-oscillator) 16:17:44 INFO - PID 11728 | RSS: Main: 165421056 16:17:44 INFO - PID 11728 | 16:17:46 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45762/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:17:47 INFO - PID 11728 | RSS: Main: 165244928 16:17:47 INFO - PID 11728 | 16:17:50 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45762/tests/kraken/driver.html?testName=imaging-darkroom) 16:17:50 INFO - PID 11728 | RSS: Main: 169275392 16:17:50 INFO - PID 11728 | 16:17:54 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45762/tests/kraken/driver.html?testName=imaging-desaturate) 16:17:54 INFO - PID 11728 | RSS: Main: 170192896 16:17:54 INFO - PID 11728 | 16:17:57 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45762/tests/kraken/driver.html?testName=json-parse-financial) 16:17:58 INFO - PID 11728 | RSS: Main: 168767488 16:17:58 INFO - PID 11728 | 16:17:59 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45762/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:00 INFO - PID 11728 | RSS: Main: 168534016 16:18:00 INFO - PID 11728 | 16:18:02 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:02 INFO - PID 11728 | RSS: Main: 168849408 16:18:02 INFO - PID 11728 | 16:18:04 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:05 INFO - PID 11728 | RSS: Main: 169422848 16:18:05 INFO - PID 11728 | 16:18:08 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:08 INFO - PID 11728 | RSS: Main: 168574976 16:18:08 INFO - PID 11728 | 16:18:11 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:12 INFO - PID 11728 | RSS: Main: 169545728 16:18:12 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | Cycle 1(1): loaded http://localhost:45762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45762/tests/kraken/driver.html?testName=ai-astar) 16:18:14 INFO - PID 11728 | RSS: Main: 171122688 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | __start_tp_report 16:18:14 INFO - PID 11728 | _x_x_mozilla_page_load 16:18:14 INFO - PID 11728 | _x_x_mozilla_page_load_details 16:18:14 INFO - PID 11728 | |i|pagename|runs| 16:18:14 INFO - PID 11728 | |0;ai-astar;104;108;95;108;108;109;111;110;111;111 16:18:14 INFO - PID 11728 | |1;audio-beat-detection;138;111;138;180;115;138;145;119;164;115 16:18:14 INFO - PID 11728 | |2;audio-dft;163;162;161;163;163;163;163;162;163;162 16:18:14 INFO - PID 11728 | |3;audio-fft;74;75;76;171;76;75;74;74;168;75 16:18:14 INFO - PID 11728 | |4;audio-oscillator;80;81;135;80;80;81;126;80;81;124 16:18:14 INFO - PID 11728 | |5;imaging-gaussian-blur;115;113;115;113;114;114;114;114;114;118 16:18:14 INFO - PID 11728 | |6;imaging-darkroom;149;150;149;148;148;148;149;148;148;148 16:18:14 INFO - PID 11728 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;95;94 16:18:14 INFO - PID 11728 | |8;json-parse-financial;48;47;48;47;47;47;49;48;47;47 16:18:14 INFO - PID 11728 | |9;json-stringify-tinderbox;55;54;54;55;53;54;53;54;55;54 16:18:14 INFO - PID 11728 | |10;stanford-crypto-aes;76;76;77;74;77;75;76;76;75;75 16:18:14 INFO - PID 11728 | |11;stanford-crypto-ccm;121;127;120;132;124;121;135;125;120;159 16:18:14 INFO - PID 11728 | |12;stanford-crypto-pbkdf2;183;185;171;167;174;167;170;167;167;167 16:18:14 INFO - PID 11728 | |13;stanford-crypto-sha256-iterative;62;63;65;61;60;66;61;62;61;64 16:18:14 INFO - PID 11728 | __end_tp_report 16:18:14 INFO - PID 11728 | __start_cc_report 16:18:14 INFO - PID 11728 | _x_x_mozilla_cycle_collect,881 16:18:14 INFO - PID 11728 | __end_cc_report 16:18:14 INFO - PID 11728 | __startTimestamp1500938294354__endTimestamp 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | ------- Summary: start ------- 16:18:14 INFO - PID 11728 | Number of tests: 14 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.50 stddev:4.88 (4.4%) stddev-sans-first:5.01 16:18:14 INFO - PID 11728 | Values: 104.0 108.0 95.0 108.0 108.0 109.0 111.0 110.0 111.0 111.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:138.00 stddev:22.63 (16.4%) stddev-sans-first:23.99 16:18:14 INFO - PID 11728 | Values: 138.0 111.0 138.0 180.0 115.0 138.0 145.0 119.0 164.0 115.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 16:18:14 INFO - PID 11728 | Values: 163.0 162.0 161.0 163.0 163.0 163.0 163.0 162.0 163.0 162.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:39.91 (53.2%) stddev-sans-first:41.68 16:18:14 INFO - PID 11728 | Values: 74.0 75.0 76.0 171.0 76.0 75.0 74.0 74.0 168.0 75.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:80.00 stddev:23.31 (29.1%) stddev-sans-first:24.10 16:18:14 INFO - PID 11728 | Values: 80.0 81.0 135.0 80.0 80.0 81.0 126.0 80.0 81.0 124.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.50 16:18:14 INFO - PID 11728 | Values: 115.0 113.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 118.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 16:18:14 INFO - PID 11728 | Values: 149.0 150.0 149.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:18:14 INFO - PID 11728 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:0.71 (1.5%) stddev-sans-first:0.73 16:18:14 INFO - PID 11728 | Values: 48.0 47.0 48.0 47.0 47.0 47.0 49.0 48.0 47.0 47.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 16:18:14 INFO - PID 11728 | Values: 55.0 54.0 54.0 55.0 53.0 54.0 53.0 54.0 55.0 54.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 16:18:14 INFO - PID 11728 | Values: 76.0 76.0 77.0 74.0 77.0 75.0 76.0 76.0 75.0 75.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.00 stddev:11.91 (9.5%) stddev-sans-first:12.33 16:18:14 INFO - PID 11728 | Values: 121.0 127.0 120.0 132.0 124.0 121.0 135.0 125.0 120.0 159.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:170.50 stddev:6.86 (4.0%) stddev-sans-first:5.96 16:18:14 INFO - PID 11728 | Values: 183.0 185.0 171.0 167.0 174.0 167.0 170.0 167.0 167.0 167.0 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:2.07 16:18:14 INFO - PID 11728 | Values: 62.0 63.0 65.0 61.0 60.0 66.0 61.0 62.0 61.0 64.0 16:18:14 INFO - PID 11728 | -------- Summary: end -------- 16:18:14 INFO - PID 11728 | 16:18:14 INFO - PID 11728 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:18:15 INFO - TEST-INFO | 11728: exit 0 16:18:15 INFO - TEST-OK | kraken | took 60688ms 16:18:15 INFO - SUITE-END | took 1170s 16:18:15 INFO - Completed test suite (00:19:30) 16:18:15 INFO - javascript benchmark 16:18:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8785.551757742789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.8669653213874, 3352.1116904020437, 3380.3070370574032, 3381.763276570638, 3418.931621367573, 5945.256842894638, 5956.761729530814, 5974.850628734283, 6043.576949613529, 6044.032954727245, 5977.282726072866, 6039.879202415949, 6065.272167339915, 6067.908981365283, 6148.10852426399, 5349.893002139955, 5384.757685904144, 5388.757505912224, 5390.73046347683, 5416.4312747161575, 5248.947510524884, 5328.8401347959625, 5367.0, 5398.8920221595545, 5410.756515956772, 5293.02079115363, 5351.411344752074, 5374.892502149954, 5402.8919421611345, 5405.783768649249, 5264.52619264268, 5311.468853114658, 5349.786008559653, 5391.892162156735, 5392.0294347017525, 5276.551493123089, 5343.465653434625, 5343.877785665015, 5371.811986580451, 5381.569474442035, 5977.641341519523, 6002.189704389939, 6038.396160383971, 6046.09308603713, 6075.088736689488, 6411.0383442483535, 6432.774852880174, 6485.2541957675, 6551.967240163816, 6564.737410503574, 6566.967165164144, 6660.0, 6666.966665166643, 6672.332766723337, 6680.632565208912, 6098.39016098391, 6131.570790044654, 6175.87648247037, 6181.103739957681, 6203.844903877439, 6588.96705516479, 6656.800295991128, 6665.200175978816, 6680.899786503109, 6739.93260067393, 6404.583702059351, 6457.2896981332015, 6489.70796314167, 6494.512911531559, 6502.902456463157, 6530.8040758777315, 6544.803655890331, 6613.702383392759, 6631.502637302222, 6647.501437392215, 6421.389967953037, 6459.9010806029255, 6477.1579694639395, 6482.092507049017, 6542.476601871839, 6510.0, 6513.316101809337, 6540.640264785387, 6567.376099270562, 6570.868582628321, 4761.738104404221, 4781.641376896747, 4820.493848145894, 4827.348307978448, 4839.540243676845, 4227.217964676544, 4296.9570304297185, 4298.398224248608, 4328.935065974013, 4363.694541382073, 6253.78111766086, 6295.6537390443045, 6325.0, 6327.746890124344, 6335.873282534416, 6539.8365040873405, 6547.639879806657, 6627.768028119089, 6628.972509261072, 6635.369639884203, 6190.102435146879, 6192.0, 6244.625322480666, 6259.6870156492905, 6274.2784579773, 5405.027095122916, 5428.8099916503525, 5463.590230732711, 5467.699276539828, 5469.288992430958, 6857.657117144223, 6889.069975553236, 6925.445964322842, 6967.09427774386, 6974.128233970754, 6483.610983341015, 6490.935090649033, 6544.901826472512, 6574.868502629825, 6601.603903765789, 6868.553544019623, 6911.516193866381, 6929.272426395358, 6935.237123916264, 6940.13248343957, 6356.9046464304, 6430.614163150226, 6449.032645103272, 6514.967425162844, 6516.771912983023, 6482.0, 6564.113844630913, 6609.768658096944, 6622.569532980341, 6667.966660166668, 6334.081558173947, 6376.936230637634, 6382.106505089384, 6396.392342727433, 6430.967845160744, 6300.464460520907, 6356.523260755369, 6361.17304750398, 6379.52153588492, 6387.297397286202, 6288.151099601679, 6295.653739044396, 6307.590006649553, 6374.107624932606, 6375.649339286384, 6348.111264423077, 6410.262819775599, 6424.967875160594, 6461.030845373231, 6466.0, 6182.598131121463, 6207.037909124093, 6232.376762323732, 6245.500359971283, 6266.811995640138], "value": 5975.227424130472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.3552364679197, 869.5956380283167, 891.0688330694423, 912.0879120879121, 918.0727465260086, 44833.55166448335, 45516.089678206416, 45592.0, 45799.54200457995, 45963.540364596345, 40852.59147408525, 40923.795381023054, 41015.0, 41032.17935641285, 41099.79450102753, 6858.211305699859, 6926.549774264682, 6942.271061538541, 6950.548214366076, 6960.860782784342, 6841.17905851296, 6922.65386730664, 6930.861382772341, 6950.756723514678, 6969.616671083114, 6909.239983601799, 7455.440841936849, 7733.53598784072, 7743.845123097534, 7747.806304842367, 7673.731419400322, 7676.232376762335, 7685.846283074307, 7692.884606730903, 7707.0, 7451.143118541383, 7504.0, 7627.69489220436, 7652.808679782995, 7653.502522336031, 41641.0, 42062.36906446406, 42083.7895810522, 42118.789406052776, 42220.15559688789, 3523.8766643167364, 3568.107973006748, 3569.446735755962, 3572.9995601231435, 3575.249197668493, 31739.841300793578, 31973.360532789447, 32019.51970720441, 32082.679173208202, 32155.19612009695, 4997.250412438127, 5020.347354843847, 5027.673201241944, 5086.440491545964, 5102.464241254652, 248207.0, 262742.0, 262791.0, 262922.6853865738, 263835.0, 54602.63493412617, 54795.726021369635, 54805.45194548083, 54920.45079549153, 54946.0, 56643.0, 56852.0, 56875.14687279694, 56883.71558142183, 56969.14546281809, 16829.41097061597, 17164.0, 17173.141342932802, 17173.7423938641, 17186.570335741457, 14048.438062477386, 14050.578482645536, 14064.226467544178, 14064.71870562583, 14079.507217247346, 15340.079595224099, 15398.07611543311, 15399.384024639114, 15533.922330388275, 15591.0, 5887.61730487517, 6019.0, 6035.486983606443, 6058.787942421994, 6183.412575805291, 1057.360297020307, 1091.47063674118, 1092.6995076354067, 1095.2606990281529, 1106.4523061084815, 29927.401451971273, 30545.694543054284, 31036.0, 31610.367792644018, 31768.682313176574, 1173.9823902641467, 1175.9647210583696, 1187.2579637726421, 1187.804012337972, 1192.260798305039, 16393.59016024585, 16951.237194326284, 17314.307427703003, 17327.393541226247, 17451.912740436215, 282052.0, 285470.0, 285652.0, 285800.0, 285852.0, 54946.72526637421, 55853.72073139608, 62537.68731156315, 62734.372656273765, 63014.36985630177, 1510.6752048309665, 1518.8177418709824, 1527.1829571179367, 1536.0399750156153, 1546.0337289194254, 28549.714502855535, 29116.856917438225, 29730.55404168896, 30075.849620751756, 30319.696803031686, 41525.169496610506, 41794.79102604589, 41951.58048419477, 41968.580314196464, 41975.370369445096, 216283.0, 216585.0, 216872.0, 217095.0, 217235.0, 36604.26791464209, 36609.0, 36666.0, 36692.24808139454, 36698.0, 45075.549244508446, 45102.54897451115, 45410.54589454063, 46067.539324606325, 46337.3049404266, 32338.35323293568, 33865.83067084649, 33989.83005084959, 34012.48981265332, 34394.82802585971, 32173.839130804197, 32953.17617059593, 33092.33815323632, 33136.33727325392, 33227.83386083054, 38518.2296354077, 38807.80596097114, 39209.41185882157, 39374.409383859835, 39382.60617393904, 30926.22684432907, 32430.513542296412, 35264.64735352614, 35712.92861214168, 35760.46359304665, 25939.0921317753, 26281.4743705121, 26506.602400963617, 27140.32149196286, 27378.315542111606], "value": 18573.85308228529, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6921458590481, 567.6764244380702, 573.7475510775258, 575.7409165875357, 591.3938213331335, 22702.88648556755, 22770.658440123392, 23444.29667109985, 23533.0, 23594.292171234847, 26744.866275668643, 27356.179314620593, 27412.588811167847, 27459.588106178424, 27484.0, 6273.592216505924, 6357.713902874381, 6407.135036770046, 6422.03669449584, 6443.452306553949, 5609.52319052881, 6082.695865206744, 6100.481459075984, 6100.542459315569, 6101.755929762827, 6070.48400885923, 6071.332153463116, 6071.666058366788, 6075.63546187228, 6076.513878889678, 5994.46049855513, 6007.399260073979, 6027.60820546663, 6040.0, 6044.546659000549, 5605.971970140124, 5611.494965453129, 5629.183768353607, 5632.127020311858, 5651.689157096358, 28906.566401503784, 30219.244518886982, 30296.0, 30617.693823061705, 30746.385072298428, 2091.5712278982774, 2140.35789263222, 2141.0365335599045, 2144.2923835134525, 2145.6137895178863, 19553.706694399596, 20128.0, 20184.49538761543, 20189.19243230269, 20204.595908081905, 2373.2576300822143, 2401.5797235483897, 2437.390652336916, 2441.475082857194, 2457.7542245775458, 150160.0, 152182.0, 152201.9999999989, 152261.0, 152471.23764381217, 15025.248737563297, 15578.143202123765, 15691.843081569266, 15713.921430392775, 15907.681846363008, 23252.186173483846, 23758.64362034571, 23852.52294954126, 23909.16317928864, 23935.0, 10165.814349914655, 10179.643712470177, 10281.794364112677, 10359.94820025895, 10475.319104258198, 9238.214751746176, 9292.210162136294, 9294.117058879396, 9354.158125768578, 9440.150386465251, 9640.90359096414, 9678.612855485702, 9779.549134387844, 9865.301079982453, 9912.851307230398, 2805.2846524136216, 2831.0506842954373, 2834.8724307406214, 2844.900428484993, 2861.8282903025884, 1050.6900464363032, 1056.3186744549723, 1061.4215252687304, 1072.7210925159359, 1078.7896360209684, 20495.385138445872, 21214.25750098739, 21391.67912481314, 21688.0, 25596.23211303664, 1112.5382966068992, 1116.4529380603446, 1120.6918097523246, 1148.7128217945515, 1149.3793351590048, 11913.404329783649, 12284.938575307246, 12424.440900159334, 12427.813582796265, 12681.746365072831, 555485.0, 556670.0, 570144.0, 575148.0, 576444.0, 140142.29928850493, 142461.28769356088, 143899.28050359682, 145673.27163364115, 146034.0, 1341.2824139085542, 1342.9865701343058, 1357.8166947461966, 1372.0601388049217, 1377.758892193862, 19742.210311587376, 19914.0, 19927.202911883363, 20041.599168016266, 20109.89945050324, 53203.467965319855, 60215.09677354756, 63547.682261588394, 66921.0, 67551.3244867545, 73103.63448182725, 73319.26680733338, 73556.26443735494, 73839.0, 74327.62836185785, 14639.19484428324, 14743.18912459825, 14846.257687115385, 15104.79161667086, 15119.092854428769, 23935.0, 23944.161954332212, 24278.15026474065, 24355.878220608785, 24368.390790230387, 19243.230270789012, 19273.807261927763, 19300.32448864283, 19443.902780486573, 19447.70828437546, 15595.986260893005, 15626.218689065274, 16699.582510437336, 18039.729404058686, 18155.001474919005, 19013.80986190176, 20206.0, 20271.59456810826, 20473.590528189652, 20527.0, 14720.705585888436, 14895.47865824691, 15045.699086018438, 15122.848771512145, 15139.243037848284, 19256.711149333052, 19321.51696207606, 19477.220911163397, 19508.0, 19528.31650892212], "value": 12495.596328394473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.382737336632, 1477.5567329801056, 1499.5426394949538, 1501.8122734658168, 1508.630385555539, 14896.627584310398, 15370.154641494713, 15503.767443488343, 15518.146501942389, 15545.53363399097, 14828.332725027372, 15213.4675286365, 15773.290201940912, 15784.44754433595, 15804.367825286974, 2481.4416756229884, 2538.4796116796015, 2545.0328875027462, 2546.961795573068, 2547.223096955428, 2381.57131716291, 2406.4946361264156, 2477.306354220821, 2580.2646245819947, 2694.1648089092446, 2678.4375281190974, 2685.8657067146664, 2715.470483255756, 2715.6876959149654, 2715.891364345434, 2624.527585034693, 2628.9999999999905, 2636.6967798703204, 2652.045263705065, 2669.1058495403868, 2451.36264571211, 2485.763852434016, 2578.9484210315877, 2665.0, 2666.919992400212, 14834.0, 15009.0, 15033.624159395993, 15034.398624055024, 15043.548693539211, 7602.125755538129, 7905.051393832777, 7908.130105688369, 7910.367170626336, 7913.841723165505, 4960.1567733485035, 5011.473795251519, 5192.766325515361, 5196.948030519684, 5197.636165468381, 1873.8219869112413, 1895.658781419344, 1899.43017094871, 1940.7088936659472, 1951.0829909942304, 25457.745422545908, 25575.0, 25616.615750763565, 25667.0, 25707.35731606706, 6516.283208847023, 6616.801495955129, 6781.186257649114, 6807.5575087619145, 6819.454443644497, 16924.238409271613, 18080.819191808176, 18100.818991810178, 18107.0, 18132.0, 7809.414293927978, 7971.800704982422, 7993.360531157494, 7997.920020799834, 8000.8799868002025, 7308.96345518269, 7323.816904577428, 7352.228016058344, 7437.219091995371, 7550.056242969629, 5196.350456192976, 5301.920471192935, 5313.44208858072, 5321.494458026481, 5322.121849894724, 1523.2536057331827, 1548.2723120133744, 1549.8450154984412, 1551.4337266897726, 1558.462330495977, 900.3922352412096, 909.1408618855119, 916.8945571259258, 926.9443833370019, 950.4107453378949, 7454.813629659302, 7729.652165652559, 7774.805629859299, 7923.0, 7935.841283174304, 712.9786106416816, 757.9962100189464, 768.2624680306856, 770.6801677303969, 779.4582764978398, 4705.317728929286, 4967.3294105296045, 5755.539556835527, 6023.584882100637, 6345.650989195547, 21015.8949205253, 21495.140194392363, 21769.891150544147, 21879.12483500642, 21912.45218869509, 20332.69500957487, 21027.8948605256, 21131.47171320729, 21180.682289765668, 21198.576028479343, 11959.521619135137, 12119.75760484803, 12144.514219431123, 12145.939270303768, 12163.939180304042, 8316.459430137022, 8839.425437346808, 8855.60149793248, 9030.864537032081, 9216.677416290666, 18155.636887262444, 18613.720794188368, 18785.6242875139, 18944.810551894858, 18993.24027038903, 17844.643107138043, 18238.08809559543, 18887.90556047211, 19483.12325945364, 19711.60576788485, 12791.680207994874, 13911.234882081582, 14002.43990240379, 14020.509282175075, 14080.0, 13989.300534973007, 14135.929320353333, 14265.928670356581, 14280.500182493563, 14372.640683982983, 11354.489047992694, 11675.182737208654, 11877.22798018126, 11908.52365905354, 12124.211926224767, 10996.890031099907, 11490.368029758443, 11531.654050378502, 11554.364509951698, 11610.0, 10579.36523808574, 10615.150787936793, 10924.563017479211, 10948.397838118979, 10961.232713710282, 7344.742933997284, 7580.431467640059, 7635.847283054419, 7705.0, 7800.882986755317, 7625.199354067965, 7821.960890195513, 7843.529388236724, 7872.56700881457, 7986.520808751494], "value": 6721.526513752405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.94228692556896, 502.3845788908586, 509.60505608153676, 514.7529185990725, 519.1589624807812, 5884.616730224256, 5954.851128721784, 6046.697665116738, 6051.757929682813, 6135.435463956696, 5888.528917686585, 5936.762529498815, 6018.8194354169445, 6023.30731965823, 6043.697815109249, 4820.493848145947, 4836.395450568679, 4848.806047758086, 4863.951360486403, 4874.97562512187, 4791.976040119795, 4808.951910480903, 4820.831270905519, 4858.635602329822, 4898.118338699032, 4832.646858879501, 4837.782299796518, 4839.854804355875, 4869.440014398337, 4905.705657660534, 4791.329213910038, 4842.176829938937, 4856.757162141914, 4866.204360598738, 4867.4889136640495, 4454.621357184643, 4539.9570193412765, 4562.5665561771575, 4565.908681826378, 4608.654350923694, 5830.5044071254, 5918.6621284592775, 5939.792107276267, 6008.03871380577, 6063.575549711522, 5728.398518155575, 5798.971005144989, 5814.633561113135, 5873.122170136645, 5937.782754535353, 6436.613803171778, 6461.967690161519, 6466.482681385478, 6504.77233296837, 6505.381988711112, 5097.7960881564695, 5154.974225128851, 5158.6667199552185, 5160.122779127557, 5195.402528709209, 6689.130413046321, 6702.530822842403, 6739.898901516482, 6748.426383757386, 6753.4259587935085, 5302.151655735064, 5306.54894333986, 5316.122839731478, 5342.6260161788305, 5367.892642147213, 5358.27663265462, 5367.624266301322, 5375.919361209585, 5404.864878378072, 5409.891802163935, 5796.420357964254, 5822.737976791054, 5842.357340692521, 5870.148828419855, 5884.911726324109, 6229.13793448056, 6395.720855828853, 6447.580907241015, 6447.9355206447335, 6541.47668186544, 1804.6571151481176, 1849.9075046247633, 1857.1364315593314, 1879.436169149277, 1884.2086323743786, 1101.251149218539, 1319.1755153029358, 1335.6927906581345, 1336.4720935230723, 1373.8351397832323, 6003.0, 6109.5112391008615, 6135.386461353829, 6182.227221597301, 6216.906746398808, 6579.30917253691, 6599.0, 6605.0, 6649.734010639617, 6693.464522838161, 6177.62934223948, 6199.132121502993, 6256.280527739277, 6272.498200143978, 6299.370062993664, 3486.4944583035317, 3496.8426420810615, 3504.632013638582, 3525.347810655037, 3548.520949671813, 6821.522493425413, 6841.418479429205, 6843.62360070191, 6856.211535673362, 6921.335285914858, 6772.864542709118, 6812.591244525344, 6817.284185160586, 6827.317268273133, 6852.875608561362, 6856.177258728984, 6932.618705971119, 6951.304869513008, 6958.93041069593, 7000.47496437759, 6486.286508484157, 6565.901511477427, 6609.867802644017, 6614.173228346457, 6645.401913827779, 6579.6840631874775, 6605.310229736749, 6628.83427914306, 6635.6350400728425, 6642.667866606554, 6920.5847649141215, 6924.896126558005, 6961.0, 6976.511644184859, 7034.944758286298, 4956.975215123901, 4959.975200123977, 4975.756060984754, 4979.526944940225, 4985.551300382983, 6649.700763465559, 6656.5340426169705, 6657.267700553032, 6659.53383263167, 6697.397234248941, 6444.548881578245, 6446.646204296962, 6476.222853257639, 6486.740530378732, 6533.314002029719, 6317.96841015792, 6386.944290375738, 6393.936060639334, 6411.0, 6419.935800641933, 6302.0, 6341.841453963688, 6407.519436042408, 6409.391107844747, 6411.935880641134, 5915.994280972331, 6446.743639726058, 6452.322506136788, 6469.385408386196, 6505.154329937078, 6154.169187159855, 6168.198134242699, 6169.691515424301, 6196.969015154896, 6266.342034086538], "value": 5089.966352891859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.403687603058, 926.3098991251519, 939.6382392778779, 943.231266517788, 965.0976337124789, 18001.7299740504, 18991.62016759666, 19020.714689279674, 19052.33316833911, 21955.121795128216, 19901.203951841908, 20319.593608127827, 20527.07628156733, 20581.073851676672, 20607.896960515212, 1013.062916801959, 1107.4518113533773, 1107.8559787227648, 1111.22214449885, 1112.1269803204486, 1095.1950316517352, 1096.9780604387906, 1098.0447011100355, 1099.0383414512303, 1100.350793032111, 1159.1422347462858, 1160.9941950290238, 1161.2684009074271, 1163.9941800290987, 1167.6146871532374, 1135.6763322453144, 1141.8458508101426, 1143.816989281715, 1144.4277861069424, 1145.73075327298, 845.7885528617845, 849.142366210126, 852.8038551133274, 853.2704537620369, 853.63293783673, 18254.0, 18319.175637096363, 18490.167942442622, 19876.0, 20031.298904538417, 20823.271185508587, 21005.36983890486, 21140.682889756667, 21266.893665531727, 21322.573548529097, 16027.679446411006, 16154.192290385552, 16325.10211938343, 16335.754963675436, 16390.590235244093, 3524.3832329342263, 3558.1104723819044, 3565.6434356564396, 3594.2991116732246, 3594.982025089884, 132237.3388133053, 138604.30697846547, 138881.3055934714, 140086.0, 143500.0, 15068.849311506963, 15592.0, 16133.274002669908, 16272.918635406748, 16291.755623665655, 31012.22469438282, 31318.06045818629, 31340.0, 31486.212844679067, 32058.83970580132, 8858.86711699325, 8859.601317940707, 8936.106389361012, 8944.50805205707, 9046.954765226132, 4498.145352383102, 4578.244589642672, 4581.862544123682, 4587.747673877969, 4592.2422800238255, 5354.223637572531, 5376.838694839161, 5501.504864562208, 5556.055470569932, 5560.165975103767, 1030.8144533983955, 1037.3775734559204, 1062.134360496193, 1062.7874425115008, 1065.307550092446, 670.9966450167718, 678.7488629207224, 684.3977299976088, 711.5019486359465, 714.5498336048256, 11620.825687614693, 11658.358790266448, 11942.223755455867, 12865.549705760253, 12889.291088990009, 674.1236392689484, 698.200560358397, 718.9496735228588, 724.9565026098451, 726.5604309392742, 5597.888042239132, 5660.433956604306, 5671.234383358276, 5767.394423585547, 5932.851678708067, 121847.0, 124168.0, 126364.0, 127122.0, 129195.35402323116, 113175.81417672284, 114146.42926785313, 116896.0, 117867.41066294613, 120375.0, 91800.0, 97373.5131324353, 98865.50567247262, 98892.99999999856, 100983.0, 12875.871241287841, 13076.934615326862, 13395.933020334836, 13430.0, 13445.798313025116, 46230.76884615555, 46799.298010529186, 47714.76142619265, 49558.752206238736, 49631.0, 84723.0, 84871.0, 85187.0, 86427.56786216029, 88601.55699221462, 19006.0, 19413.0, 19755.111020003846, 20018.399448016582, 20395.4901127473, 21714.457138571663, 21781.564368712854, 21789.564208716052, 21954.780452195275, 22164.224252151096, 19419.3203237886, 19569.60860782748, 19729.60540789205, 19840.801591983894, 20066.89966550158, 16702.58243543921, 16870.746938796172, 17021.404250851658, 19299.324523641604, 19894.403167904988, 17567.209475573374, 19110.904445477685, 19512.21951121939, 19731.40805775829, 19940.3020894268, 14334.713305734036, 14428.0, 15021.399144034116, 15306.617334566725, 15569.610759731097, 14342.067765595202, 14382.568522944328, 14411.855881441052, 14612.634684132981, 14665.56003319902], "value": 9691.455917623696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 95.0, 108.0, 108.0, 109.0, 111.0, 110.0, 111.0, 111.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 138.0, 180.0, 115.0, 138.0, 145.0, 119.0, 164.0, 115.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 171.0, 76.0, 75.0, 74.0, 74.0, 168.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 135.0, 80.0, 80.0, 81.0, 126.0, 80.0, 81.0, 124.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 47.0, 47.0, 47.0, 49.0, 48.0, 47.0, 47.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 54.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 74.0, 77.0, 75.0, 76.0, 76.0, 75.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 127.0, 120.0, 132.0, 124.0, 121.0, 135.0, 125.0, 120.0, 159.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 171.0, 167.0, 174.0, 167.0, 170.0, 167.0, 167.0, 167.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 61.0, 60.0, 66.0, 61.0, 62.0, 61.0, 64.0], "value": 62.5, "unit": "score"}]}]} 16:18:15 INFO - Return code: 0 16:18:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:18:15 INFO - # TBPL SUCCESS # 16:18:15 INFO - Running post-action listener: _package_coverage_data 16:18:15 INFO - Running post-action listener: _resource_record_post_action 16:18:15 INFO - [mozharness: 2017-07-24 23:18:15.665802Z] Finished run-tests step (success) 16:18:15 INFO - Running post-run listener: _resource_record_post_run 16:18:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 437719040; Read time: 28; Write time: 299048 16:18:15 INFO - TinderboxPrint: CPU usage
13.1% 16:18:15 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 16:18:15 INFO - TinderboxPrint: I/O write bytes / time
437,719,040 / 299,048 16:18:15 INFO - TinderboxPrint: CPU idle
8,241.1 (86.9%) 16:18:15 INFO - TinderboxPrint: CPU user
1,190.8 (12.6%) 16:18:15 INFO - TinderboxPrint: Swap in / out
0 / 0 16:18:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116543488; Read time: 0; Write time: 112492 16:18:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:18:15 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321175552; Read time: 16; Write time: 186556 16:18:16 INFO - Running post-run listener: _upload_blobber_files 16:18:16 INFO - Blob upload gear active. 16:18:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:18:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:18:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:18:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:18:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:17 INFO - (blobuploader) - INFO - Done attempting. 16:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:18 INFO - (blobuploader) - INFO - Done attempting. 16:18:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:18:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:19 INFO - (blobuploader) - INFO - Done attempting. 16:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:22 INFO - (blobuploader) - INFO - Done attempting. 16:18:22 INFO - (blobuploader) - INFO - Iteration through files over. 16:18:22 INFO - Return code: 0 16:18:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:18:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:18:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38f37415fb53dd5bafe3e2c772caf0c47d4ace02d33b34db424b4e3c4ced1e0b39c8c4101897a8a249b7350f78fe4de0ffba6fb91ee766df6a3109eb114bd661", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b12753c347431f0a95e86825b1c65b1b57ca6581366a5ac8cfa767a53fe8632692f33273c8670d4705cc9229cc19a51d363886c1945227e03939408ab63a0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596e0a87938ac5b2301a57607d460c225af078dac8a180a1543639ec4da880ea306785b61deeda5614661075a8c45ec81072eeb9904f0b2c4c30e4bc39c73a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec8d418efede376c76c227415b9d1fc2eacfea5fe623842afc18b27af27a4a2fb887c2e11ca649943d0f5887bf1c58fbe5037e8574633aeb4ebc64491d6d5ba"} 16:18:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:18:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:18:22 INFO - Contents: 16:18:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38f37415fb53dd5bafe3e2c772caf0c47d4ace02d33b34db424b4e3c4ced1e0b39c8c4101897a8a249b7350f78fe4de0ffba6fb91ee766df6a3109eb114bd661", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b12753c347431f0a95e86825b1c65b1b57ca6581366a5ac8cfa767a53fe8632692f33273c8670d4705cc9229cc19a51d363886c1945227e03939408ab63a0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596e0a87938ac5b2301a57607d460c225af078dac8a180a1543639ec4da880ea306785b61deeda5614661075a8c45ec81072eeb9904f0b2c4c30e4bc39c73a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec8d418efede376c76c227415b9d1fc2eacfea5fe623842afc18b27af27a4a2fb887c2e11ca649943d0f5887bf1c58fbe5037e8574633aeb4ebc64491d6d5ba"} 16:18:22 INFO - Running post-run listener: copy_logs_to_upload_dir 16:18:22 INFO - Copying logs to upload dir... 16:18:22 INFO - mkdir: /builds/slave/test/build/upload/logs 16:18:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.171959 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-24 16:18:22.786850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 16:18:22.790460) ========= 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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38f37415fb53dd5bafe3e2c772caf0c47d4ace02d33b34db424b4e3c4ced1e0b39c8c4101897a8a249b7350f78fe4de0ffba6fb91ee766df6a3109eb114bd661", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b12753c347431f0a95e86825b1c65b1b57ca6581366a5ac8cfa767a53fe8632692f33273c8670d4705cc9229cc19a51d363886c1945227e03939408ab63a0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596e0a87938ac5b2301a57607d460c225af078dac8a180a1543639ec4da880ea306785b61deeda5614661075a8c45ec81072eeb9904f0b2c4c30e4bc39c73a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec8d418efede376c76c227415b9d1fc2eacfea5fe623842afc18b27af27a4a2fb887c2e11ca649943d0f5887bf1c58fbe5037e8574633aeb4ebc64491d6d5ba"} build_url:https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/VhPW1zlGTruhhn1_LjFUDA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38f37415fb53dd5bafe3e2c772caf0c47d4ace02d33b34db424b4e3c4ced1e0b39c8c4101897a8a249b7350f78fe4de0ffba6fb91ee766df6a3109eb114bd661", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b12753c347431f0a95e86825b1c65b1b57ca6581366a5ac8cfa767a53fe8632692f33273c8670d4705cc9229cc19a51d363886c1945227e03939408ab63a0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a596e0a87938ac5b2301a57607d460c225af078dac8a180a1543639ec4da880ea306785b61deeda5614661075a8c45ec81072eeb9904f0b2c4c30e4bc39c73a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec8d418efede376c76c227415b9d1fc2eacfea5fe623842afc18b27af27a4a2fb887c2e11ca649943d0f5887bf1c58fbe5037e8574633aeb4ebc64491d6d5ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 16:18:22.814603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:18:22.814912) ========= 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=652eb03db935cfc1c15ebda0000001ad-1500929354.771597-884769181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:18:22.899958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 16:18:22.900277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 16:18:22.900582) ========= ========= Total master_lag: 0.19 =========