builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1502733003.92 results: success (0) revision: 6213fec03a47275d8fcbf79b951547e3993d677f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:03.915333) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:03.915882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:03.916171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:03.977986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:03.978252) ========= 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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 10:50:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.3M=0s 2017-08-14 10:50:04 (53.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130583 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:04.155421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:04.155730) ========= 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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.053709 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:04.249279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:04.252539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6213fec03a47275d8fcbf79b951547e3993d677f --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 6213fec03a47275d8fcbf79b951547e3993d677f --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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 10:50:04,608 truncating revision to first 12 chars 2017-08-14 10:50:04,608 Setting DEBUG logging. 2017-08-14 10:50:04,608 attempt 1/10 2017-08-14 10:50:04,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6213fec03a47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 10:50:05,136 unpacking tar archive at: mozilla-central-6213fec03a47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943529 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:05.235312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:05.235644) ========= script_repo_revision: 6213fec03a47275d8fcbf79b951547e3993d677f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:05.236053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:05.236320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 10:50:05.279756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-14 10:50:05.280026) ========= /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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:05 INFO - MultiFileLogger online at 20170814 10:50:05 in /builds/slave/test 10:50:05 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 10:50:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:05 INFO - {'append_to_log': False, 10:50:05 INFO - 'base_work_dir': '/builds/slave/test', 10:50:05 INFO - 'blob_upload_branch': 'Firefox', 10:50:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:05 INFO - 'branch': 'Firefox', 10:50:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:05 INFO - 'code_coverage': False, 10:50:05 INFO - 'config_files': ('talos/linux_config.py',), 10:50:05 INFO - 'default_actions': ('clobber', 10:50:05 INFO - 'read-buildbot-config', 10:50:05 INFO - 'download-and-extract', 10:50:05 INFO - 'populate-webroot', 10:50:05 INFO - 'create-virtualenv', 10:50:05 INFO - 'install', 10:50:05 INFO - 'setup-mitmproxy', 10:50:05 INFO - 'run-tests'), 10:50:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:05 INFO - 'disable_ccov_upload': False, 10:50:05 INFO - 'download_minidump_stackwalk': True, 10:50:05 INFO - 'download_symbols': 'ondemand', 10:50:05 INFO - 'enable_stylo': False, 10:50:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:05 INFO - 'gecko_profile': False, 10:50:05 INFO - 'gecko_profile_interval': 0, 10:50:05 INFO - 'installer_path': 'installer.exe', 10:50:05 INFO - 'log_level': 'info', 10:50:05 INFO - 'log_name': 'talos', 10:50:05 INFO - 'log_to_console': True, 10:50:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:05 INFO - 'opt_config_files': (), 10:50:05 INFO - 'pip_index': False, 10:50:05 INFO - 'suite': 'dromaeojs-e10s', 10:50:05 INFO - 'system_bits': '32', 10:50:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:05 INFO - 'title': 'talos-linux64-ix-077', 10:50:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:05 INFO - 'use_talos_json': True, 10:50:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:05 INFO - 'work_dir': 'build'} 10:50:05 INFO - [mozharness: 2017-08-14 17:50:05.847597Z] Running clobber step. 10:50:05 INFO - Running pre-action listener: _resource_record_pre_action 10:50:05 INFO - Running main action method: clobber 10:50:05 INFO - rmtree: /builds/slave/test/build 10:50:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:07 INFO - Running post-action listener: _resource_record_post_action 10:50:07 INFO - [mozharness: 2017-08-14 17:50:07.842228Z] Finished clobber step (success) 10:50:07 INFO - [mozharness: 2017-08-14 17:50:07.842388Z] Running read-buildbot-config step. 10:50:07 INFO - Running pre-action listener: _resource_record_pre_action 10:50:07 INFO - Running main action method: read_buildbot_config 10:50:07 INFO - Using buildbot properties: 10:50:07 INFO - { 10:50:07 INFO - "project": "", 10:50:07 INFO - "product": "firefox", 10:50:07 INFO - "who": "ffxbld@noreply.mozilla.org", 10:50:07 INFO - "installer_path": "public/build/target.tar.bz2", 10:50:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:50:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:50:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:50:07 INFO - "stage_platform": "linux64-stylo", 10:50:07 INFO - "basedir": "/builds/slave/test", 10:50:07 INFO - "buildnumber": 29, 10:50:07 INFO - "platform": "ubuntu64_hw_stylo", 10:50:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:50:07 INFO - "slavebuilddir": "test", 10:50:07 INFO - "taskId": "aEL-XHShTvuu33yQmzfv_Q", 10:50:07 INFO - "branch": "mozilla-central", 10:50:07 INFO - "script_repo_revision": "production", 10:50:07 INFO - "revision": "6213fec03a47275d8fcbf79b951547e3993d677f", 10:50:07 INFO - "slavename": "talos-linux64-ix-077", 10:50:07 INFO - "repo_path": "mozilla-central" 10:50:07 INFO - } 10:50:07 INFO - Finding installer, test and symbols from parent task. 10:50:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEL-XHShTvuu33yQmzfv_Q'}, attempt #1 10:50:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEL-XHShTvuu33yQmzfv_Q'}, attempt #1 10:50:08 INFO - Task dependencies: EbW8bYmORB6jS9ruD6W6qg 10:50:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg'}, attempt #1 10:50:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json 10:50:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip 10:50:09 INFO - Running post-action listener: _resource_record_post_action 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.334806Z] Finished read-buildbot-config step (success) 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.334912Z] Running download-and-extract step. 10:50:09 INFO - Running pre-action listener: _resource_record_pre_action 10:50:09 INFO - Running main action method: download_and_extract 10:50:09 INFO - mkdir: /builds/slave/test/build/tests 10:50: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')]} 10:50:09 INFO - trying https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json 10:50:09 INFO - Downloading https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:50:10 INFO - Downloaded 989 bytes. 10:50:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:50:10 INFO - Using the following test package requirements: 10:50:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:50:10 INFO - u'common': [u'target.common.tests.zip'], 10:50:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:50:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:50:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:50:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:50:10 INFO - u'mozbase': [u'target.common.tests.zip'], 10:50:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:50:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:50:10 INFO - u'web-platform': [u'target.common.tests.zip', 10:50:10 INFO - u'target.web-platform.tests.tar.gz'], 10:50:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:50:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:50:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip 10:50:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:50:10 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip into memory 10:50:12 INFO - Content-Length response header: 54034742 10:50:12 INFO - Bytes received: 54034742 10:50:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:50:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip 10:50:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:50:23 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip into memory 10:50:26 INFO - Content-Length response header: 54034742 10:50:26 INFO - Bytes received: 54034742 10:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip 10:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip into memory 10:50:39 INFO - Content-Length response header: 14496050 10:50:39 INFO - Bytes received: 14496050 10:50:39 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')]} 10:50:39 INFO - trying https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:50:41 INFO - Downloaded 61721141 bytes. 10:50:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:41 INFO - mkdir: /builds/slave/test/properties 10:50:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:41 INFO - Contents: 10:50:41 INFO - build_url:https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:41 INFO - Running post-action listener: _resource_record_post_action 10:50:41 INFO - Running post-action listener: set_extra_try_arguments 10:50:41 INFO - [mozharness: 2017-08-14 17:50:41.952243Z] Finished download-and-extract step (success) 10:50:41 INFO - [mozharness: 2017-08-14 17:50:41.952342Z] Running populate-webroot step. 10:50:41 INFO - Running pre-action listener: _resource_record_pre_action 10:50:41 INFO - Running main action method: populate_webroot 10:50:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:50:41 INFO - 'tests': ['damp', 'tps']}, 10:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:50:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:50:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:50:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:41 INFO - 'ts_paint', 10:50:41 INFO - 'tpaint', 10:50:41 INFO - 'sessionrestore', 10:50:41 INFO - 'sessionrestore_many_windows', 10:50:41 INFO - 'sessionrestore_no_auto_restore', 10:50:41 INFO - 'tabpaint']}, 10:50:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:50:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:50:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:41 INFO - 'tsvgr_opacity', 10:50:41 INFO - 'tart', 10:50:41 INFO - 'tscrollx', 10:50:41 INFO - 'tsvg_static']}, 10:50:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:50:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:41 INFO - 'talos_options': ['--mitmproxy', 10:50:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:41 INFO - '--firstNonBlankPaint'], 10:50:41 INFO - 'tests': ['tp6_google', 10:50:41 INFO - 'tp6_youtube', 10:50:41 INFO - 'tp6_amazon', 10:50:41 INFO - 'tp6_facebook']}, 10:50:41 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:41 INFO - 'talos_options': ['--stylo', 10:50:41 INFO - '--mitmproxy', 10:50:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:41 INFO - '--firstNonBlankPaint'], 10:50:41 INFO - 'tests': ['tp6_google', 10:50:41 INFO - 'tp6_youtube', 10:50:41 INFO - 'tp6_amazon', 10:50:41 INFO - 'tp6_facebook']}, 10:50:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:41 INFO - 'talos_options': ['--stylo', 10:50:41 INFO - '--stylo-threads=1', 10:50:41 INFO - '--mitmproxy', 10:50:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:41 INFO - '--firstNonBlankPaint'], 10:50:41 INFO - 'tests': ['tp6_google', 10:50:41 INFO - 'tp6_youtube', 10:50:41 INFO - 'tp6_amazon', 10:50:41 INFO - 'tp6_facebook']}, 10:50:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:50:41 INFO - 'talos_options': ['--xperf_path', 10:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:41 INFO - 'tests': ['tp5n']}}} 10:50:41 INFO - Running post-action listener: _resource_record_post_action 10:50:41 INFO - [mozharness: 2017-08-14 17:50:41.965566Z] Finished populate-webroot step (success) 10:50:41 INFO - [mozharness: 2017-08-14 17:50:41.965658Z] Running create-virtualenv step. 10:50:41 INFO - Running pre-action listener: _resource_record_pre_action 10:50:41 INFO - Running main action method: create_virtualenv 10:50:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:41 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 10:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:50:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:42 INFO - Using real prefix '/usr' 10:50:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:44 INFO - Installing pip.................done. 10:50:44 INFO - Return code: 0 10:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:50:44 INFO - Reading from file tmpfile_stdout 10:50:44 INFO - Output received: 10:50:44 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) 10:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50: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')]} 10:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:44 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:44 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 10:50:44 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 10:50:44 INFO - Using env: {'DISPLAY': ':0', 10:50:44 INFO - 'HOME': '/home/cltbld', 10:50:44 INFO - 'LANG': 'en_US.UTF-8', 10:50:44 INFO - 'LANGUAGE': 'en_US:en', 10:50:44 INFO - 'LOGNAME': 'cltbld', 10:50:44 INFO - 'MAIL': '/var/mail/cltbld', 10:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:44 INFO - 'MOZ_NO_REMOTE': '1', 10:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:44 INFO - 'NO_EM_RESTART': '1', 10:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:44 INFO - 'PWD': '/builds/slave/test', 10:50:44 INFO - 'SHELL': '/bin/bash', 10:50:44 INFO - 'SHLVL': '1', 10:50:44 INFO - 'TERM': 'linux', 10:50:44 INFO - 'TMOUT': '86400', 10:50:44 INFO - 'USER': 'cltbld', 10:50:44 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:44 INFO - '_': '/tools/buildbot/bin/python'} 10:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:45 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 10:50:45 INFO - Cleaning up... 10:50:45 INFO - Return code: 0 10:50:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:45 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')]} 10:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:45 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')]} 10:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:45 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:45 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 10:50:45 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 10:50:45 INFO - Using env: {'DISPLAY': ':0', 10:50:45 INFO - 'HOME': '/home/cltbld', 10:50:45 INFO - 'LANG': 'en_US.UTF-8', 10:50:45 INFO - 'LANGUAGE': 'en_US:en', 10:50:45 INFO - 'LOGNAME': 'cltbld', 10:50:45 INFO - 'MAIL': '/var/mail/cltbld', 10:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:45 INFO - 'MOZ_NO_REMOTE': '1', 10:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:45 INFO - 'NO_EM_RESTART': '1', 10:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:45 INFO - 'PWD': '/builds/slave/test', 10:50:45 INFO - 'SHELL': '/bin/bash', 10:50:45 INFO - 'SHLVL': '1', 10:50:45 INFO - 'TERM': 'linux', 10:50:45 INFO - 'TMOUT': '86400', 10:50:45 INFO - 'USER': 'cltbld', 10:50:45 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:45 INFO - '_': '/tools/buildbot/bin/python'} 10:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:45 INFO - Downloading/unpacking psutil>=3.1.1 10:50:45 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 10:50:45 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 10:50:45 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 10:50:45 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 10:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:46 INFO - Installing collected packages: psutil 10:50:46 INFO - Running setup.py install for psutil 10:50:46 INFO - building 'psutil._psutil_linux' extension 10:50:46 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 10:50:47 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 10:50:47 INFO - building 'psutil._psutil_posix' extension 10:50:47 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 10:50:47 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 10:50:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:48 INFO - Successfully installed psutil 10:50:48 INFO - Cleaning up... 10:50:48 INFO - Return code: 0 10:50:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:48 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')]} 10:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:48 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')]} 10:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:48 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:48 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 10:50:48 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 10:50:48 INFO - Using env: {'DISPLAY': ':0', 10:50:48 INFO - 'HOME': '/home/cltbld', 10:50:48 INFO - 'LANG': 'en_US.UTF-8', 10:50:48 INFO - 'LANGUAGE': 'en_US:en', 10:50:48 INFO - 'LOGNAME': 'cltbld', 10:50:48 INFO - 'MAIL': '/var/mail/cltbld', 10:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:48 INFO - 'MOZ_NO_REMOTE': '1', 10:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:48 INFO - 'NO_EM_RESTART': '1', 10:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:48 INFO - 'PWD': '/builds/slave/test', 10:50:48 INFO - 'SHELL': '/bin/bash', 10:50:48 INFO - 'SHLVL': '1', 10:50:48 INFO - 'TERM': 'linux', 10:50:48 INFO - 'TMOUT': '86400', 10:50:48 INFO - 'USER': 'cltbld', 10:50:48 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:48 INFO - '_': '/tools/buildbot/bin/python'} 10:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50:48 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 10:50:48 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 10:50:48 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 10:50:48 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 10:50:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:49 INFO - Installing collected packages: mozsystemmonitor 10:50:49 INFO - Running setup.py install for mozsystemmonitor 10:50:49 INFO - Successfully installed mozsystemmonitor 10:50:49 INFO - Cleaning up... 10:50:49 INFO - Return code: 0 10:50:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:49 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')]} 10:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:49 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')]} 10:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:49 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 10:50:49 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 10:50:49 INFO - Using env: {'DISPLAY': ':0', 10:50:49 INFO - 'HOME': '/home/cltbld', 10:50:49 INFO - 'LANG': 'en_US.UTF-8', 10:50:49 INFO - 'LANGUAGE': 'en_US:en', 10:50:49 INFO - 'LOGNAME': 'cltbld', 10:50:49 INFO - 'MAIL': '/var/mail/cltbld', 10:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:49 INFO - 'MOZ_NO_REMOTE': '1', 10:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:49 INFO - 'NO_EM_RESTART': '1', 10:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:49 INFO - 'PWD': '/builds/slave/test', 10:50:49 INFO - 'SHELL': '/bin/bash', 10:50:49 INFO - 'SHLVL': '1', 10:50:49 INFO - 'TERM': 'linux', 10:50:49 INFO - 'TMOUT': '86400', 10:50:49 INFO - 'USER': 'cltbld', 10:50:49 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:49 INFO - '_': '/tools/buildbot/bin/python'} 10:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:50 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 10:50:50 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 10:50:50 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 10:50:50 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 10:50:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:51 INFO - warning: no files found matching '*.txt' 10:50:51 INFO - no previously-included directories found matching 'build' 10:50:51 INFO - no previously-included directories found matching 'dist' 10:50:51 INFO - no previously-included directories found matching '.git*' 10:50:51 INFO - Installing collected packages: jsonschema, functools32 10:50:51 INFO - Running setup.py install for functools32 10:50:51 INFO - warning: no files found matching '*.txt' 10:50:51 INFO - no previously-included directories found matching 'build' 10:50:51 INFO - no previously-included directories found matching 'dist' 10:50:51 INFO - no previously-included directories found matching '.git*' 10:50:51 INFO - Successfully installed jsonschema functools32 10:50:51 INFO - Cleaning up... 10:50:51 INFO - Return code: 0 10:50:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:51 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')]} 10:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:51 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')]} 10:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:51 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:51 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 10:50:51 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 10:50:51 INFO - Using env: {'DISPLAY': ':0', 10:50:51 INFO - 'HOME': '/home/cltbld', 10:50:51 INFO - 'LANG': 'en_US.UTF-8', 10:50:51 INFO - 'LANGUAGE': 'en_US:en', 10:50:51 INFO - 'LOGNAME': 'cltbld', 10:50:51 INFO - 'MAIL': '/var/mail/cltbld', 10:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:51 INFO - 'MOZ_NO_REMOTE': '1', 10:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:51 INFO - 'NO_EM_RESTART': '1', 10:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:51 INFO - 'PWD': '/builds/slave/test', 10:50:51 INFO - 'SHELL': '/bin/bash', 10:50:51 INFO - 'SHLVL': '1', 10:50:51 INFO - 'TERM': 'linux', 10:50:51 INFO - 'TMOUT': '86400', 10:50:51 INFO - 'USER': 'cltbld', 10:50:51 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:51 INFO - '_': '/tools/buildbot/bin/python'} 10:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:51 INFO - Cleaning up... 10:50:51 INFO - Return code: 0 10:50:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:51 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')]} 10:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:51 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')]} 10:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:51 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:51 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 10:50:51 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 10:50:51 INFO - Using env: {'DISPLAY': ':0', 10:50:51 INFO - 'HOME': '/home/cltbld', 10:50:51 INFO - 'LANG': 'en_US.UTF-8', 10:50:51 INFO - 'LANGUAGE': 'en_US:en', 10:50:51 INFO - 'LOGNAME': 'cltbld', 10:50:51 INFO - 'MAIL': '/var/mail/cltbld', 10:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:51 INFO - 'MOZ_NO_REMOTE': '1', 10:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:51 INFO - 'NO_EM_RESTART': '1', 10:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:51 INFO - 'PWD': '/builds/slave/test', 10:50:51 INFO - 'SHELL': '/bin/bash', 10:50:51 INFO - 'SHLVL': '1', 10:50:51 INFO - 'TERM': 'linux', 10:50:51 INFO - 'TMOUT': '86400', 10:50:51 INFO - 'USER': 'cltbld', 10:50:51 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:51 INFO - '_': '/tools/buildbot/bin/python'} 10:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 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 10:50:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50:53 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 10:50:53 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 10:50:53 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 10:50:53 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 10:50:53 INFO - Downloading docopt-0.6.1.tar.gz 10:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:53 INFO - Running setup.py install for blobuploader 10:50:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:53 INFO - Running setup.py install for requests 10:50:53 INFO - Running setup.py install for docopt 10:50:53 INFO - Successfully installed blobuploader requests docopt 10:50:53 INFO - Cleaning up... 10:50:54 INFO - Return code: 0 10:50:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:54 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')]} 10:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:54 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')]} 10:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:54 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:54 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 10:50:54 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 10:50:54 INFO - Using env: {'DISPLAY': ':0', 10:50:54 INFO - 'HOME': '/home/cltbld', 10:50:54 INFO - 'LANG': 'en_US.UTF-8', 10:50:54 INFO - 'LANGUAGE': 'en_US:en', 10:50:54 INFO - 'LOGNAME': 'cltbld', 10:50:54 INFO - 'MAIL': '/var/mail/cltbld', 10:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:54 INFO - 'MOZ_NO_REMOTE': '1', 10:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:54 INFO - 'NO_EM_RESTART': '1', 10:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:54 INFO - 'PWD': '/builds/slave/test', 10:50:54 INFO - 'SHELL': '/bin/bash', 10:50:54 INFO - 'SHLVL': '1', 10:50:54 INFO - 'TERM': 'linux', 10:50:54 INFO - 'TMOUT': '86400', 10:50:54 INFO - 'USER': 'cltbld', 10:50:54 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:54 INFO - '_': '/tools/buildbot/bin/python'} 10:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:54 INFO - Running setup.py (path:/tmp/pip-8jyVXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:54 INFO - Running setup.py (path:/tmp/pip-H1b0Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:54 INFO - Running setup.py (path:/tmp/pip-XImqFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:54 INFO - Running setup.py (path:/tmp/pip-sk4_Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:54 INFO - Running setup.py (path:/tmp/pip-VHiHf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:54 INFO - Running setup.py (path:/tmp/pip-0EZdSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:54 INFO - Running setup.py (path:/tmp/pip-2wwJaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:54 INFO - Running setup.py (path:/tmp/pip-Ev6SlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:54 INFO - Running setup.py (path:/tmp/pip-aFXcAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:54 INFO - Running setup.py (path:/tmp/pip-kmLqSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:54 INFO - Running setup.py (path:/tmp/pip-UfABw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:55 INFO - Running setup.py (path:/tmp/pip-MSle3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:55 INFO - Running setup.py (path:/tmp/pip-VDDsAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:55 INFO - Running setup.py (path:/tmp/pip-FNLoyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:55 INFO - Running setup.py (path:/tmp/pip-dKcdM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:55 INFO - Running setup.py (path:/tmp/pip-p_71Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:55 INFO - Running setup.py (path:/tmp/pip-nd4GRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:55 INFO - Running setup.py install for manifestparser 10:50:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:55 INFO - Running setup.py install for mozcrash 10:50:55 INFO - Running setup.py install for mozdebug 10:50:55 INFO - Running setup.py install for mozdevice 10:50:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:55 INFO - Running setup.py install for mozfile 10:50:56 INFO - Running setup.py install for mozhttpd 10:50:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozinfo 10:50:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozInstall 10:50:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozleak 10:50:56 INFO - Running setup.py install for mozlog 10:50:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for moznetwork 10:50:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozprocess 10:50:56 INFO - Running setup.py install for mozprofile 10:50:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozrunner 10:50:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:56 INFO - Running setup.py install for mozscreenshot 10:50:57 INFO - Running setup.py install for moztest 10:50:57 INFO - Running setup.py install for mozversion 10:50:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:57 INFO - Cleaning up... 10:50:57 INFO - Return code: 0 10:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:57 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')]} 10:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:57 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')]} 10:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:57 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:50:57 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 10:50:57 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 10:50:57 INFO - Using env: {'DISPLAY': ':0', 10:50:57 INFO - 'HOME': '/home/cltbld', 10:50:57 INFO - 'LANG': 'en_US.UTF-8', 10:50:57 INFO - 'LANGUAGE': 'en_US:en', 10:50:57 INFO - 'LOGNAME': 'cltbld', 10:50:57 INFO - 'MAIL': '/var/mail/cltbld', 10:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:57 INFO - 'MOZ_NO_REMOTE': '1', 10:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:57 INFO - 'NO_EM_RESTART': '1', 10:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:57 INFO - 'PWD': '/builds/slave/test', 10:50:57 INFO - 'SHELL': '/bin/bash', 10:50:57 INFO - 'SHLVL': '1', 10:50:57 INFO - 'TERM': 'linux', 10:50:57 INFO - 'TMOUT': '86400', 10:50:57 INFO - 'USER': 'cltbld', 10:50:57 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:57 INFO - '_': '/tools/buildbot/bin/python'} 10:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:57 INFO - Running setup.py (path:/tmp/pip-Jm06Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:57 INFO - Running setup.py (path:/tmp/pip-LT4ZsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:57 INFO - Running setup.py (path:/tmp/pip-7ntFe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:57 INFO - Running setup.py (path:/tmp/pip-OOBygb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:57 INFO - Running setup.py (path:/tmp/pip-SY8XMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:57 INFO - Running setup.py (path:/tmp/pip-Ng5Cpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:57 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)) 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:57 INFO - Running setup.py (path:/tmp/pip-d6LBcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:58 INFO - Running setup.py (path:/tmp/pip-8zhZts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:58 INFO - Running setup.py (path:/tmp/pip-627iOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:58 INFO - Running setup.py (path:/tmp/pip-VbjlLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:58 INFO - Running setup.py (path:/tmp/pip-AtYAbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:58 INFO - Running setup.py (path:/tmp/pip-d2LxmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:58 INFO - Running setup.py (path:/tmp/pip-_357MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:58 INFO - Running setup.py (path:/tmp/pip-SU132H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:58 INFO - Running setup.py (path:/tmp/pip-iXro8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:58 INFO - Running setup.py (path:/tmp/pip-UzNz4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:58 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)) 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:58 INFO - Running setup.py (path:/tmp/pip-CpfBHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:58 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)) 10:50:58 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)) 10:50:58 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)) 10:50:58 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)) 10:50:58 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)) 10:50:58 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)) 10:50:58 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)) 10:50:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:59 INFO - Downloading blessings-1.6.tar.gz 10:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:59 INFO - Installing collected packages: blessings 10:50:59 INFO - Running setup.py install for blessings 10:51:00 INFO - Successfully installed blessings 10:51:00 INFO - Cleaning up... 10:51:00 INFO - Return code: 0 10:51:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:00 INFO - Reading from file tmpfile_stdout 10:51:00 INFO - Current package versions: 10:51:00 INFO - argparse == 1.2.1 10:51:00 INFO - blessings == 1.6 10:51:00 INFO - blobuploader == 1.2.4 10:51:00 INFO - docopt == 0.6.1 10:51:00 INFO - functools32 == 3.2.3-2 10:51:00 INFO - jsonschema == 2.5.1 10:51:00 INFO - manifestparser == 1.1 10:51:00 INFO - mozInstall == 1.13 10:51:00 INFO - mozcrash == 1.0 10:51:00 INFO - mozdebug == 0.1 10:51:00 INFO - mozdevice == 0.51 10:51:00 INFO - mozfile == 1.2 10:51:00 INFO - mozhttpd == 0.7 10:51:00 INFO - mozinfo == 0.10 10:51:00 INFO - mozleak == 0.1 10:51:00 INFO - mozlog == 3.5 10:51:00 INFO - moznetwork == 0.27 10:51:00 INFO - mozprocess == 0.25 10:51:00 INFO - mozprofile == 0.28 10:51:00 INFO - mozrunner == 6.13 10:51:00 INFO - mozscreenshot == 0.1 10:51:00 INFO - mozsystemmonitor == 0.3 10:51:00 INFO - moztest == 0.8 10:51:00 INFO - mozversion == 1.4 10:51:00 INFO - psutil == 3.1.1 10:51:00 INFO - requests == 1.2.3 10:51:00 INFO - wsgiref == 0.1.2 10:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:00 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')]} 10:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:00 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')]} 10:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:00 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:51:00 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 10:51:00 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 10:51:00 INFO - Using env: {'DISPLAY': ':0', 10:51:00 INFO - 'HOME': '/home/cltbld', 10:51:00 INFO - 'LANG': 'en_US.UTF-8', 10:51:00 INFO - 'LANGUAGE': 'en_US:en', 10:51:00 INFO - 'LOGNAME': 'cltbld', 10:51:00 INFO - 'MAIL': '/var/mail/cltbld', 10:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:00 INFO - 'MOZ_NO_REMOTE': '1', 10:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:00 INFO - 'NO_EM_RESTART': '1', 10:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:00 INFO - 'PWD': '/builds/slave/test', 10:51:00 INFO - 'SHELL': '/bin/bash', 10:51:00 INFO - 'SHLVL': '1', 10:51:00 INFO - 'TERM': 'linux', 10:51:00 INFO - 'TMOUT': '86400', 10:51:00 INFO - 'USER': 'cltbld', 10:51:00 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:00 INFO - '_': '/tools/buildbot/bin/python'} 10:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 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)) 10:51:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:51:01 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)) 10:51:01 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)) 10:51:01 INFO - Installing collected packages: simplejson 10:51:01 INFO - Running setup.py install for simplejson 10:51:01 INFO - building 'simplejson._speedups' extension 10:51:01 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 10:51:02 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 10:51:02 INFO - Successfully installed simplejson 10:51:02 INFO - Cleaning up... 10:51:02 INFO - Return code: 0 10:51:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:02 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')]} 10:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:02 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')]} 10:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:02 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fdb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, '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': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', '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 10:51:02 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 10:51:02 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 10:51:02 INFO - Using env: {'DISPLAY': ':0', 10:51:02 INFO - 'HOME': '/home/cltbld', 10:51:02 INFO - 'LANG': 'en_US.UTF-8', 10:51:02 INFO - 'LANGUAGE': 'en_US:en', 10:51:02 INFO - 'LOGNAME': 'cltbld', 10:51:02 INFO - 'MAIL': '/var/mail/cltbld', 10:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:02 INFO - 'MOZ_NO_REMOTE': '1', 10:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:02 INFO - 'NO_EM_RESTART': '1', 10:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:02 INFO - 'PWD': '/builds/slave/test', 10:51:02 INFO - 'SHELL': '/bin/bash', 10:51:02 INFO - 'SHLVL': '1', 10:51:02 INFO - 'TERM': 'linux', 10:51:02 INFO - 'TMOUT': '86400', 10:51:02 INFO - 'USER': 'cltbld', 10:51:02 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:02 INFO - '_': '/tools/buildbot/bin/python'} 10:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:02 INFO - Cleaning up... 10:51:03 INFO - Return code: 0 10:51:03 INFO - Running post-action listener: _resource_record_post_action 10:51:03 INFO - Running post-action listener: _start_resource_monitoring 10:51:03 INFO - Starting resource monitoring. 10:51:03 INFO - [mozharness: 2017-08-14 17:51:03.031693Z] Finished create-virtualenv step (success) 10:51:03 INFO - [mozharness: 2017-08-14 17:51:03.032683Z] Running install step. 10:51:03 INFO - Running pre-action listener: _resource_record_pre_action 10:51:03 INFO - Running main action method: install 10:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:03 INFO - Reading from file tmpfile_stdout 10:51:03 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:03 INFO - Reading from file tmpfile_stdout 10:51:03 INFO - Output received: 10:51:03 INFO - Usage: mozinstall [options] installer 10:51:03 INFO - Options: 10:51:03 INFO - -h, --help show this help message and exit 10:51:03 INFO - -d DEST, --destination=DEST 10:51:03 INFO - Directory to install application into. [default: 10:51:03 INFO - "/builds/slave/test"] 10:51:03 INFO - --app=APP Application being installed. [default: firefox] 10:51:03 INFO - mkdir: /builds/slave/test/build/application 10:51:03 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'] 10:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:51:21 INFO - Reading from file tmpfile_stdout 10:51:21 INFO - Output received: 10:51:21 INFO - /builds/slave/test/build/application/firefox/firefox 10:51:21 INFO - Running post-action listener: _resource_record_post_action 10:51:21 INFO - [mozharness: 2017-08-14 17:51:21.296103Z] Finished install step (success) 10:51:21 INFO - [mozharness: 2017-08-14 17:51:21.296386Z] Running setup-mitmproxy step. 10:51:21 INFO - Running pre-action listener: _resource_record_pre_action 10:51:21 INFO - Running main action method: setup_mitmproxy 10:51:21 INFO - Skipping: mitmproxy is not required 10:51:21 INFO - Running post-action listener: _resource_record_post_action 10:51:21 INFO - [mozharness: 2017-08-14 17:51:21.297607Z] Finished setup-mitmproxy step (success) 10:51:21 INFO - [mozharness: 2017-08-14 17:51:21.297830Z] Running run-tests step. 10:51:21 INFO - Running pre-action listener: _resource_record_pre_action 10:51:21 INFO - Running pre-action listener: _set_gcov_prefix 10:51:21 INFO - Running main action method: run_tests 10:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:21 INFO - Python 2.7.3 10:51:21 INFO - Return code: 0 10:51:21 INFO - grabbing minidump binary from tooltool 10:51:21 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')]} 10:51:21 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 0x1500f00>, '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 0x14fbba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fc050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:21 INFO - Return code: 0 10:51:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:51:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:21 INFO - ENV: RUST_BACKTRACE is now full 10:51:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:51:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:21 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 10:51:21 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 10:51:21 INFO - Using env: {'DISPLAY': ':0', 10:51:21 INFO - 'HOME': '/home/cltbld', 10:51:21 INFO - 'LANG': 'en_US.UTF-8', 10:51:21 INFO - 'LANGUAGE': 'en_US:en', 10:51:21 INFO - 'LOGNAME': 'cltbld', 10:51:21 INFO - 'MAIL': '/var/mail/cltbld', 10:51:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:21 INFO - 'MOZ_NO_REMOTE': '1', 10:51:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:21 INFO - 'NO_EM_RESTART': '1', 10:51:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:21 INFO - 'PWD': '/builds/slave/test', 10:51:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:21 INFO - 'RUST_BACKTRACE': 'full', 10:51:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:51:21 INFO - 'SHELL': '/bin/bash', 10:51:21 INFO - 'SHLVL': '1', 10:51:21 INFO - 'STYLO_FORCE_ENABLED': '1', 10:51:21 INFO - 'TERM': 'linux', 10:51:21 INFO - 'TMOUT': '86400', 10:51:21 INFO - 'USER': 'cltbld', 10:51:21 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974', 10:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:21 INFO - '_': '/tools/buildbot/bin/python'} 10:51:21 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 10:51:21 INFO - mozversion application_buildid: 20170814165937 10:51:21 INFO - mozversion application_changeset: 6213fec03a47275d8fcbf79b951547e3993d677f 10:51:21 INFO - mozversion application_display_name: Nightly 10:51:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:21 INFO - mozversion application_name: Firefox 10:51:21 INFO - mozversion application_remotingname: firefox 10:51:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:51:21 INFO - mozversion application_vendor: Mozilla 10:51:21 INFO - mozversion application_version: 57.0a1 10:51:21 INFO - mozversion platform_buildid: 20170814165937 10:51:21 INFO - mozversion platform_changeset: 6213fec03a47275d8fcbf79b951547e3993d677f 10:51:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:51:21 INFO - mozversion platform_version: 57.0a1 10:51:21 INFO - using testdate: 1502733081 10:51:21 INFO - actual date: 1502733081 10:51:21 INFO - starting webserver on 'localhost:40331' 10:51:21 INFO - SUITE-START | Running 2 tests 10:51:21 INFO - TEST-START | dromaeo_css 10:51:21 INFO - Initialising browser for dromaeo_css test... 10:51:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40331/getInfo.html -profile /tmp/tmpk9yNgo/profile 10:51:21 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox http://localhost:40331/getInfo.html) 10:51:28 INFO - TEST-INFO | 3332: exit 0 10:51:28 INFO - Browser initialized. 10:51:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:28 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk9yNgo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:29 INFO - PID 3560 | 10:51:29 INFO - PID 3560 | (/builds/slave/test/build/application/firefox/firefox:3614): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:51:29 INFO - PID 3560 | 10:51:39 INFO - PID 3560 | RSS: Main: 171479040 10:51:39 INFO - PID 3560 | 10:54:39 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40331/tests/dromaeo/cssquery-ext.html) 10:54:40 INFO - PID 3560 | RSS: Main: 176054272 10:54:40 INFO - PID 3560 | 10:57:42 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-ext.html (next: http://localhost:40331/tests/dromaeo/cssquery-jquery.html) 10:57:43 INFO - PID 3560 | RSS: Main: 173232128 10:57:43 INFO - PID 3560 | 11:00:44 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40331/tests/dromaeo/cssquery-mootools.html) 11:00:45 INFO - PID 3560 | RSS: Main: 175767552 11:00:45 INFO - PID 3560 | 11:03:47 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40331/tests/dromaeo/cssquery-prototype.html) 11:03:48 INFO - PID 3560 | RSS: Main: 173776896 11:03:48 INFO - PID 3560 | 11:06:51 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40331/tests/dromaeo/cssquery-yui.html) 11:06:52 INFO - PID 3560 | RSS: Main: 177266688 11:06:52 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | Cycle 1(1): loaded http://localhost:40331/tests/dromaeo/cssquery-yui.html (next: http://localhost:40331/tests/dromaeo/cssquery-dojo.html) 11:09:54 INFO - PID 3560 | RSS: Main: 177876992 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | __start_tp_report 11:09:54 INFO - PID 3560 | _x_x_mozilla_page_load 11:09:54 INFO - PID 3560 | _x_x_mozilla_page_load_details 11:09:54 INFO - PID 3560 | |i|pagename|runs| 11:09:54 INFO - PID 3560 | |0;dojo.html;3160.1783536280573;3183.4906414973607;3207.1180425383022;3232.4020056289582;3235.175030367256;6112.235970503687;6137.416945390187;6181.196444462219;6208.348123447029;6278.246610406746;6234.438900498954;6246.937530624692;6279.277883043452;6291.4652254558305;6365.013422919444;5553.250311207976;5655.802046928358;5750.798722044729;5757.337906140785;5769.451902069297;5600.439956004408;5617.8033768818095;5712.171735098408;5725.770969161229;5768.36547979724;5682.829515114532;5758.078707406816;5762.625429347079;5782.681952492611;5785.190073389729;5689.772409103631;5701.828945131652;5771.913421298684;5776.191333213354;5794.797182098607;5531.612787104904;5550.72246387679;5637.802676906289;5649.604527683064;5727;6036.63780173191;6137.631742095488;6147.2930612979635;6174.320824709278;6176.011838105882;6548.607083575001;6619.404253617149;6642.368974947372;6660.300668429793;6717.09319241901;6711.463082953352;6732.326767323278;6801.965990170067;6817.250102488722;6832.282610325894;6054.273487181566;6223.159873417076;6245.812625621239;6302.8424289392215;6318.842028949267;6806.047153398528;6896.517243792987;6970.686319115652;6971.965140174267;6985.93014069863;6506.31683673217;6546.803595892131;6578.473722102316;6587.110740050128;6598.835029124214;6568.934310656928;6591;6667.19993600771;6692.732290708317;6694.196696396463;6565.048068030109;6587.670616469158;6674.399304062657;6677;6681.966590167018;6552.049952756824;6658.43403310724;6672.966635166793;6756.4932630052945;6761.121054262914;5378.838634840961;5427.29445172133;5428.619996600279;5432.728363581805;5435.864103397446;4614.769261536977;4654.464736555272;4660.324252983299;4664.416947881515;4693.436787585511;5796.072628379439;5797.739101740347;5862.091375836752;5862.882742345215;5863.472287494146;6569.474442044625;6672.733090676318;6739.090222819955;6763.526553141233;6763.560368576027;5730.7421166047625;5786.623869448473;5803.129530570448;5807.216025836543;5808.6224395414165;5729.88540229193;5892.823215303548;5896.498797602252;5901.793437229677;5928.673922934194;6435.871282574229;6447.097406363113;6456.192975878015;6539.50953678476;6546.836329091716;6588.538802283986;6663.733450661919;6718.496112791658;6737.797866064026;6761.966190169018;6529.738810447719;6548.214214294315;6549.7380104795275;6552.57408268461;6563.1796025496815;6579.276279609335;6585.80242592723;6596.5052621052655;6688.264290928091;6688.933110668831;6683.866322673616;6722.394984451423;6796.218434879855;6800.52396332252;6820.965895170492;6269.843253918689;6366.554341196257;6392.232932047998;6476.4495017924;6557.114789503356;6507.674616269073;6525.086487891794;6530.8040758777315;6540.345965403612;6546.24718157418;6376.107344971801;6408.070829729756;6466.870662586816;6476.287608362982;6478.773242936474;6477.773277935438;6520.804375868732;6585.440237579859;6592.967035164794;6624.138861947916;6214.5028397728975;6307.05394190875;6328.0507923809955;6340.207474065742;6417 11:09:54 INFO - PID 3560 | |1;ext.html;803.1205829616572;838.3125836813812;857.4212406625526;859.2610355094614;1170.262734477279;31768.68231317689;32774.83612581937;44109.33835992463;44759.32861007079;44778.552214477924;44196.337054944204;44654;44702.10595788082;44820.775896120555;44837.103257934825;7650.464467487292;7735.574543400111;7749;7769.533827970312;7799.298063174313;7658.349040331578;7772.145064042951;7780.02749656293;7780.221977802231;7780.649870755801;7784.883226751604;7792.727254546092;7796.1814009529035;7808.80477988052;7812.453128281023;7754.030746156731;7764.883526747103;7779.260970207822;7786.532808031537;7789.454738168331;7609.505382150142;7652;7665.846683066363;7673.923260767377;7680.34717049046;40836.795816021026;41291.587084129074;41324.793376032925;41381.1723765523;41449.1710165795;3590.35373632746;3617.819109044537;3620.0225938996587;3627.2564124354444;3636.090977255686;32842.17894552655;32934.67065329364;32938.50592241118;33014.83492582546;33091.172720681934;5073.39119305682;5079.212722028092;5095;5095.159298715707;5100.438951715309;203268;203723.99999999852;204133;204248;204727;47948.7602561985;48022.5197748018;48362.27456588154;48369.75815120902;48482.27276590854;49498.75250623796;50126.49873501218;50149.74925125351;50189.74905125524;50225.49774502281;14674.339654715563;14932.70134597302;14948.177850218342;14953.925230373778;14977.326020329112;12115.454804533818;12124.878751212551;12159.878401216052;12168.878311216775;12220.083493738006;12679.873201268054;12930.870691293156;12972.80540791889;13047.086703930823;13143.14569552976;5472.534834539029;5477.75350109246;5499.752511136929;5507.586930980113;5512;985.0986347492108;992.7016020630651;1018.1549314069305;1025.9384436933808;1029.8815636201782;22873.543744954964;22900.885495572416;22968.310950671508;23208.883955580113;23266.185683500997;1119.8208286674094;1134.121056181466;1137.0960086731068;1142.1205671632797;1146.060230610891;12301.32342721159;12304.507819687113;12307.93846030782;12378.81431778524;12436.81344779829;215472;216357;216778;258811;260616;62963.37036629575;63224.683876580326;63247;63474.682626586575;63502.36497635057;1515;1554.1063888264293;1562.421903895566;1563.1558958162466;1580.138824340737;28290.717092828807;28311.575326370534;28315.575266370608;28333.57499637466;29053.12840614785;40792.38811417772;40961.59038409697;41082.589174107874;41235.793821030704;41265;225711;227305;227476;227550;228707;37942.430863536516;38065.23869522649;38344.233115338095;38356.616433835305;39061.609383905794;46716.53283467122;47499.76250118727;47517;47913.281300781215;48251;33882.152946175556;34360;34556.82721586376;34868.47697284492;34903.65096349004;33439;33514.32971340511;33522.16194595155;33631;34453.483197752554;35953.101172470895;36669.166541673345;36834;36938.261234775695;36991.8150409257;32356.267718967378;32676.50985235271;32805.507917381736;33007;33436.66563334336;23388.883055584614;23595.174168904006;23676.289711308687;25666;25679.358016049748 11:09:54 INFO - PID 3560 | |2;jquery.html;578.3146970839558;579.5132089045201;582.7086456771614;586.8591538030871;588.1589327262014;21545.24591639293;23026.88486557567;23890.044398224072;23895.880520597395;23905.402364940885;25712.742872571267;27863.442731145416;27919.58120628187;27929.301767455825;28087.157385278424;6664.833379165523;6774.085498457719;6805.081314022618;6810.557313774613;6813.148356455443;6094.360092190323;6542.836429089287;6561.737530498798;6565.868682626345;6576.342365763409;6535.869282614345;6552.180977377828;6556.27880933097;6559.245686746014;6572.145621069254;6551.574147680433;6554.311797261266;6556.44270237028;6567.802965911006;6570;6073.42302481268;6087.1173679816175;6087.421694938974;6095.420935011211;6096.786612468542;29132.126036218946;30066.398672026437;30612.387752245053;31093.37813243745;31144.37711245785;1966.429735376739;1995.600879824041;1997.800219978005;2003.9599208015904;2004.3085135628185;19939.80060199394;20413.693794592946;20451.2842050529;20489.795102048938;20528.794712052837;2386.284114765581;2401.387646150238;2421.418859473731;2432.586460301753;2442.7068751749903;140588;143497.2825135878;146069.26965365213;146777;147575;14707.852921470861;15325.46360877364;15382.538523844303;15820.367185312458;15971.121588312755;24080.87959560191;24283.150089746774;24376.146834860694;24393.512129757306;24432;10151.593936242467;10203.183745300357;10225.335353202167;10234.232432567587;10345.068943795095;9300.162985331353;9328.300377471716;9343.486108263975;9366.29752768545;9449.338546301831;7901.960490197513;9398.624055037859;9439.858402123973;9493.477858717699;9515.90484095164;2761.4891245119716;2778;2787.4982503149627;2825.901093461719;2870.0815738963333;976.2336565795816;991.5637119667467;995.7759504111517;997.5062344139698;1015.1016350529686;19492.8050719491;19899.204031838854;19995;20012.799872001095;20222.930728330004;1045.2004216774174;1053.3363980692116;1056.8520407143005;1060.3955745225148;1065.8188108021654;11189.608363707232;11247.550097995989;11355.37545435009;11387.259828111146;11446.94276528612;482993;492164;492758;496743;506707;123639;124435;128645;129474.35262823626;130130.99999999811;1249.237964841446;1256.4032084759665;1293.8447386313514;1295.546558704446;1298.448159532195;21059.262925797524;21113.26103586367;21179.364619061453;21290.148394064065;21703.45741356479;58808.705956471655;59363.70318148382;59595.70202148962;60068.39931600628;61079.694601528485;76085.23914760782;76711;76777;76929.23070769444;77171.22828771641;12549.372531373212;13198.60404187876;13224.338783061;14569.198694071927;14967.326470308644;23762.643560346954;24935.251942441755;24987.625185621866;25006;25049.624255635816;18654.813451865306;19091.522711932314;19114.139863706445;19154.329598463988;19319;17347.392841250497;17588.472345829647;17717.557061073578;17731.37940172088;17979.73030404571;19427.222911083398;19684.114214860077;19753.802461975196;19906.50233744168;19965.101570429655;14549.781753273497;14753.92623036878;14826.25868706582;14857.925710371379;14861.331240094005;19113.13990870442;19292.807071929103;19305.613887721887;19376.2249510018;19384.418467445998 11:09:54 INFO - PID 3560 | |3;mootools.html;1375.9931200343997;1418.6027912184593;1431.1699214455616;1447.3269929482788;1451.056813071504;12165.817512737316;13840.861591384084;14445.277736113192;14478.13131212128;14495.420183192673;12417.813732794015;12582.748345033095;14126.505572304972;14623.561293161221;14670.779938300933;2672.973270267292;2715.8642067896526;2716.3209197700576;2716.8641567921622;2717.714639962805;2571.061562529682;2574.3306740247485;2648.311439025848;2650.9204723858315;2657.9734202658015;2675.665541807274;2712.22701530064;2716.578930265812;2717.8505182215067;2718.0215122555965;2567.56351420259;2591.922242332733;2594.597837335207;2597.974020259811;2598.6881574211025;2570.4088059746364;2573.4595734895693;2576.587745960656;2589.896404143832;2590.8834102465435;13326.000549958791;13593.660158496017;13624;13663.658408539866;13711.108777929403;7418.443616728713;7662;7698.153203147649;7704.3451306639;7704.576248306341;4893.143699852547;4965.106280869442;4970.552650261494;5130.4613015633195;5199.688018718851;1906.3423119023914;1929.8359639430664;1945.785963544009;1970.2808474906699;1977.7626684797772;23887.163949261867;23968;24000;24008.63987040196;24070.398240043964;6056.424639659225;6253.874922501615;6269.185005949289;6383.648899310582;6476.319986401454;16242.10668413225;16258.18709064542;16274.023558586523;16298.103604301878;16314.428994985119;7624.771256862303;7787.06555213378;7797.883031754528;7798.298153166129;7816.648250828613;6998.720051197997;7189.065421495172;7235.674394652253;7254.274572542704;7266.890996635055;5007.84976450707;5132.255822905732;5184.792608295701;5212.218167274939;5232.3459567554055;1350.7973803929292;1377.0704774277324;1446.4214314274163;1474.7198032374029;1500.3698446652431;906.582971832951;911.8768966189613;915.9175674189355;926.2358554192817;928.9442633442015;7515.586642734593;7677.309042186118;7730.458867879194;7731.884021739678;7888.171741967011;976.0434773921596;976.6728146071146;981.617169303972;993.9006099390003;1000.2448151645607;4029.6171863672903;5583.302087239095;5611.158326251095;5650.802221922213;5783.421657834267;18953;19382.4185274442;20386.28647997313;20477.89761051215;20516.07677654509;19725.704114438297;19949.800501994796;19999.200031998847;20004.599908001757;20027.49931251701;10439.843402348972;10808.621698240524;10836.945815270874;10843.62047328324;10873.565057397616;8126.943497345307;8444.76563084049;8678.132186781271;8787.604557794786;8879.733607991771;17515.299388024847;17711.46865594034;17746.5563360917;17768.289268429635;17802.287908483515;17704.911475443056;17715.468535943943;17764.46706598804;17859.73210401871;18263.634727305114;10241.948790256001;10501.737456563647;10510.527026283682;10519.579216831242;10533.315334503539;12701.618951431472;12758.553450629184;12927.741445171232;13217.206967581977;13226.140300880412;10903.236773425784;11084.889151108708;11131.833022504507;11255.887441125484;11326.433678315887;10579.10077643409;10724.571017159225;10769.192310576582;10859.728506787393;11105.500252488819;9363.250939924927;9432.292578056537;9484.288678349014;9519;9522.428654280766;6760.864782704417;6981.860362792614;7262.128544574685;7490.662920168715;7538.509996850187;7169;7211.819704507429;7272.454565907472;7281.05346304977;7320.853582928418 11:09:54 INFO - PID 3560 | |4;prototype.html;503.8992201559689;504.01465135659777;528.9894202115958;530.2735252703797;540.4622400711293;6240.313565507796;6309.49524038077;6342.619442833422;6430.131932189153;6434.485241180706;6059.606125601833;6230.7196176172065;6255.937440625592;6268.705936433535;6311.431971122598;4993.176125939216;5003.874903127415;5041.621878359119;5094.949050509485;5107.38711354638;4860.829870954517;4995.775190116454;5011.348524691785;5086.97456512717;5095.719735414551;4955.256711493269;4978.601711863061;4991.900161996758;5054.519820617035;5086.745662716868;4994.325766021613;4997.375328083989;5038.39539255288;5059.215821547666;5067.695938243717;4478.910421791578;4485.798139083749;4521.819127234907;4545.659075569345;4553.476350219734;6147.231596050494;6158;6191.628502289877;6202;6222.471089957359;5770.19217309577;5785.566082543826;5811.157382179603;5832.154337621064;5854.677992710399;6521.413072823469;6583.473322134218;6610.669466526654;6624.86750264992;6636.966815165942;4935.111679897617;4940.925886111711;4948.331975183341;4950.4307004694565;4972.290101894476;6995.79012629622;7027.89458158128;7056.894146587805;7098.361147496698;7128.964355178191;4991.3511243538105;5047.87380315495;5071.8985620287385;5084.237364395371;5092.516210959953;5070.340855688811;5129.692218466904;5149.073166830007;5180.611454140954;5190.532852043334;5757.539396848242;5811.476967072899;5826.883462330815;5828.968936153176;5852.268466441695;6658.800235992928;6678.198616166092;6711.563748356341;6777.288384719632;6826.214985276657;1685.5449028762412;1729.8702597305;1737.200887591722;1737.6003519190656;1778.2442461953617;1221.8472690913636;1226.6565361698738;1229.1887354346088;1232.7657745028416;1244.7074937389707;5843.123531470228;5858.941410585925;5877.882442351129;5909.113632955005;5918.704064796743;6642.383543437361;6773.45812335012;6780.288069752703;6791.558548694319;6834.794956151323;5870.178175055496;5879.764809407661;5881.676507792113;5899.876044623932;5906.49794767441;3617.981910090485;3622.5109610202812;3632.182758879231;3646.2707458508403;3659.780413175218;6616.669166541654;6642.435392991553;6649.235337936199;6658.368699668516;6691.899621505681;7023;7027.297270272932;7060.576365418091;7061.717531298793;7067.6112813795735;6503.512236582275;6632.270450250565;6652.234992975773;6667.599944003278;6687.255137123227;6785.491088168308;6847.760328388682;6876.381125698511;6887.345702158287;6905.240423553305;6743.29195434492;6832.487563432862;6844.486663500158;6873.041183262746;6893.586384816927;6523.217213934358;6566.474682025331;6571.835704107436;6587.80236592903;6597.175353080865;5570.944290557205;5577.5537956962535;5605.775768969359;5608.298962629671;5611.597100724819;6820.897686534607;6914.377706006484;6916.965415172892;6934.895976560457;6954.269801670752;6703.832404189934;6724.327567243432;6730.764423245163;6748.358905903931;6767.695453704497;6656.83357916056;6672.199336079701;6690.866182676416;6697.129373181455;6778.830529236809;6282.528810339151;6352.428281454691;6381.617102973836;6391.648459334781;6479.611223326616;6570.6057636540045;6572.967135164294;6609.173853268341;6639.136912201383;6674.866502670016;6415.967920160369;6432.9385651367;6447.194100737408;6454.870902582016;6460.806175814733 11:09:54 INFO - PID 3560 | |5;yui.html;915.0712027292295;927.582587835474;938.9389689670171;941.4868896451434;946.8863736351639;19238.615227695438;19999;20023.799762002374;20069.498262543406;20104;18451.815481845177;18822;20607.587848243027;20662.793372066273;20742.170313187453;1036.1296510930836;1049.7323182588468;1051.2168434516295;1054.5254635414055;1054.978900421995;972.1590823937314;1049.9632512862051;1056.8520407143005;1057.3602970203033;1060.0777323728366;1098.2531878322736;1103.779244151169;1106.4191299567751;1111.1222134513764;1111.5442668505873;1104.7956128116284;1108.839218313348;1108.9667309980714;1110.0509064749604;1110.1784679337231;807.9959600201961;809.7692157735077;812.8577498937722;813.0609146435876;813.800618848386;19763.505912352164;19787.80212197874;19829.405117846345;19898.104585293695;20693;19528.51178720529;19960.70058949117;20037.398878033535;20536.897315513477;21645.458863528536;16493.17534123289;16750.329986800636;16976.15119244045;16982.575435614086;17070.48788536346;3614.7831130132276;3642.5811031731423;3643.2167084076787;3643.85424583019;3645.2891686121216;128755.35622321829;129728.35135824261;130037;131642.3417882914;132840.33579832135;16822.495325140266;16884.409045683344;16995.40516081931;17299.56751081233;17343.653126937643;30940.381192376477;31339;31676;31729.365412692077;31804.68195318017;8722.171393717714;8781.2535934445;8802.471851688919;8838.204561589358;8853.822923541493;4036.1120553478186;4187.120704651997;4197.97901010493;4209.957900420956;4209.957900421018;5019.874503137451;5205.375354957354;5237.895242095136;5361.8123365682795;5369.087255166631;1087.1194332590626;1133.6145710458484;1145.6734830573246;1146.6502716671328;1147.690123666622;692.8891377379595;695.2630211975322;707.6426404665611;714.1893950366372;724.1672077111364;12489.562865299671;12489.93755031219;12714.427850746739;12741.617751467471;12946.67633309156;704.1585305559909;717.0427479315173;717.7990162754437;723.1791916175179;734.7208060936916;5494.148406996922;5950.851228719317;5971.641701497924;5993.130996005555;6077.817665470043;99504.50247748716;100998;108847.45576272227;111400;114313.99901003425;90735.54632226797;95421.52289238648;96305;96654.51672741592;98615;79348.60325698335;84707.5764621173;85088;87506.68739968905;87813.12186878177;11153.386563739072;11179.496922638338;11322.433878305887;11332.773344532898;11440.370779607201;40937.59062409338;41087.05757686319;41437.79281103575;41508.377374340016;43597.34603980879;51536;51811.222831658306;52559.73720131375;52602.47397526129;53651;16057.11685857289;16631.33474661;16895.91552042232;16959.660806783548;17014.659706806044;18443.81556184421;18815.435536933914;18878.15048322801;18884.43346699601;18887.05564721731;16242.756358654866;16469.176541172656;16579.419720309732;16613.833861661227;16619.169041547633;14697.338619761922;14731.116133032052;14815.851841481448;14872.107673539622;14918.85081149218;16720.498385048468;17456.389026384015;18951.810481895005;19062.61874762525;19344.516387090436;12950.481980720666;13138.277394742998;13666.52167174144;13703.314834258048;13906.165630062229;14684.41262349494;15188.772168417261;15192.696146077238;15312.157831319384;15339.233038347815 11:09:54 INFO - PID 3560 | __end_tp_report 11:09:54 INFO - PID 3560 | __start_cc_report 11:09:54 INFO - PID 3560 | _x_x_mozilla_cycle_collect,373 11:09:54 INFO - PID 3560 | __end_cc_report 11:09:54 INFO - PID 3560 | __startTimestamp1502734194515__endTimestamp 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | ------- Summary: start ------- 11:09:54 INFO - PID 3560 | Number of tests: 6 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#0] dojo.html Cycles:165 Average:6153.41 Median:6392.23 stddev:720.78 (11.3%) stddev-sans-first:683.67 11:09:54 INFO - PID 3560 | Values: 3160.2 3183.5 3207.1 3232.4 3235.2 6112.2 6137.4 6181.2 6208.3 6278.2 6234.4 6246.9 6279.3 6291.5 6365.0 5553.3 5655.8 5750.8 5757.3 5769.5 5600.4 5617.8 5712.2 5725.8 5768.4 5682.8 5758.1 5762.6 5782.7 5785.2 5689.8 5701.8 5771.9 5776.2 5794.8 5531.6 5550.7 5637.8 5649.6 5727.0 6036.6 6137.6 6147.3 6174.3 6176.0 6548.6 6619.4 6642.4 6660.3 6717.1 6711.5 6732.3 6802.0 6817.3 6832.3 6054.3 6223.2 6245.8 6302.8 6318.8 6806.0 6896.5 6970.7 6972.0 6985.9 6506.3 6546.8 6578.5 6587.1 6598.8 6568.9 6591.0 6667.2 6692.7 6694.2 6565.0 6587.7 6674.4 6677.0 6682.0 6552.0 6658.4 6673.0 6756.5 6761.1 5378.8 5427.3 5428.6 5432.7 5435.9 4614.8 4654.5 4660.3 4664.4 4693.4 5796.1 5797.7 5862.1 5862.9 5863.5 6569.5 6672.7 6739.1 6763.5 6763.6 5730.7 5786.6 5803.1 5807.2 5808.6 5729.9 5892.8 5896.5 5901.8 5928.7 6435.9 6447.1 6456.2 6539.5 6546.8 6588.5 6663.7 6718.5 6737.8 6762.0 6529.7 6548.2 6549.7 6552.6 6563.2 6579.3 6585.8 6596.5 6688.3 6688.9 6683.9 6722.4 6796.2 6800.5 6821.0 6269.8 6366.6 6392.2 6476.4 6557.1 6507.7 6525.1 6530.8 6540.3 6546.2 6376.1 6408.1 6466.9 6476.3 6478.8 6477.8 6520.8 6585.4 6593.0 6624.1 6214.5 6307.1 6328.1 6340.2 6417.0 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#1] ext.html Cycles:180 Average:39877.52 Median:3631.67 stddev:57773.99 (1590.8%) stddev-sans-first:57861.56 11:09:54 INFO - PID 3560 | Values: 803.1 838.3 857.4 859.3 1170.3 31768.7 32774.8 44109.3 44759.3 44778.6 44196.3 44654.0 44702.1 44820.8 44837.1 7650.5 7735.6 7749.0 7769.5 7799.3 7658.3 7772.1 7780.0 7780.2 7780.6 7784.9 7792.7 7796.2 7808.8 7812.5 7754.0 7764.9 7779.3 7786.5 7789.5 7609.5 7652.0 7665.8 7673.9 7680.3 40836.8 41291.6 41324.8 41381.2 41449.2 3590.4 3617.8 3620.0 3627.3 3636.1 32842.2 32934.7 32938.5 33014.8 33091.2 5073.4 5079.2 5095.0 5095.2 5100.4 203268.0 203724.0 204133.0 204248.0 204727.0 47948.8 48022.5 48362.3 48369.8 48482.3 49498.8 50126.5 50149.7 50189.7 50225.5 14674.3 14932.7 14948.2 14953.9 14977.3 12115.5 12124.9 12159.9 12168.9 12220.1 12679.9 12930.9 12972.8 13047.1 13143.1 5472.5 5477.8 5499.8 5507.6 5512.0 985.1 992.7 1018.2 1025.9 1029.9 22873.5 22900.9 22968.3 23208.9 23266.2 1119.8 1134.1 1137.1 1142.1 1146.1 12301.3 12304.5 12307.9 12378.8 12436.8 215472.0 216357.0 216778.0 258811.0 260616.0 62963.4 63224.7 63247.0 63474.7 63502.4 1515.0 1554.1 1562.4 1563.2 1580.1 28290.7 28311.6 28315.6 28333.6 29053.1 40792.4 40961.6 41082.6 41235.8 41265.0 225711.0 227305.0 227476.0 227550.0 228707.0 37942.4 38065.2 38344.2 38356.6 39061.6 46716.5 47499.8 47517.0 47913.3 48251.0 33882.2 34360.0 34556.8 34868.5 34903.7 33439.0 33514.3 33522.2 33631.0 34453.5 35953.1 36669.2 36834.0 36938.3 36991.8 32356.3 32676.5 32805.5 33007.0 33436.7 23388.9 23595.2 23676.3 25666.0 25679.4 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#2] jquery.html Cycles:180 Average:36057.62 Median:23892.96 stddev:83839.72 (350.9%) stddev-sans-first:84032.59 11:09:54 INFO - PID 3560 | Values: 578.3 579.5 582.7 586.9 588.2 21545.2 23026.9 23890.0 23895.9 23905.4 25712.7 27863.4 27919.6 27929.3 28087.2 6664.8 6774.1 6805.1 6810.6 6813.1 6094.4 6542.8 6561.7 6565.9 6576.3 6535.9 6552.2 6556.3 6559.2 6572.1 6551.6 6554.3 6556.4 6567.8 6570.0 6073.4 6087.1 6087.4 6095.4 6096.8 29132.1 30066.4 30612.4 31093.4 31144.4 1966.4 1995.6 1997.8 2004.0 2004.3 19939.8 20413.7 20451.3 20489.8 20528.8 2386.3 2401.4 2421.4 2432.6 2442.7 140588.0 143497.3 146069.3 146777.0 147575.0 14707.9 15325.5 15382.5 15820.4 15971.1 24080.9 24283.2 24376.1 24393.5 24432.0 10151.6 10203.2 10225.3 10234.2 10345.1 9300.2 9328.3 9343.5 9366.3 9449.3 7902.0 9398.6 9439.9 9493.5 9515.9 2761.5 2778.0 2787.5 2825.9 2870.1 976.2 991.6 995.8 997.5 1015.1 19492.8 19899.2 19995.0 20012.8 20222.9 1045.2 1053.3 1056.9 1060.4 1065.8 11189.6 11247.6 11355.4 11387.3 11446.9 482993.0 492164.0 492758.0 496743.0 506707.0 123639.0 124435.0 128645.0 129474.4 130131.0 1249.2 1256.4 1293.8 1295.5 1298.4 21059.3 21113.3 21179.4 21290.1 21703.5 58808.7 59363.7 59595.7 60068.4 61079.7 76085.2 76711.0 76777.0 76929.2 77171.2 12549.4 13198.6 13224.3 14569.2 14967.3 23762.6 24935.3 24987.6 25006.0 25049.6 18654.8 19091.5 19114.1 19154.3 19319.0 17347.4 17588.5 17717.6 17731.4 17979.7 19427.2 19684.1 19753.8 19906.5 19965.1 14549.8 14753.9 14826.3 14857.9 14861.3 19113.1 19292.8 19305.6 19376.2 19384.4 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#3] mootools.html Cycles:180 Average:8820.29 Median:2575.46 stddev:6098.58 (236.8%) stddev-sans-first:6090.03 11:09:54 INFO - PID 3560 | Values: 1376.0 1418.6 1431.2 1447.3 1451.1 12165.8 13840.9 14445.3 14478.1 14495.4 12417.8 12582.7 14126.5 14623.6 14670.8 2673.0 2715.9 2716.3 2716.9 2717.7 2571.1 2574.3 2648.3 2650.9 2658.0 2675.7 2712.2 2716.6 2717.9 2718.0 2567.6 2591.9 2594.6 2598.0 2598.7 2570.4 2573.5 2576.6 2589.9 2590.9 13326.0 13593.7 13624.0 13663.7 13711.1 7418.4 7662.0 7698.2 7704.3 7704.6 4893.1 4965.1 4970.6 5130.5 5199.7 1906.3 1929.8 1945.8 1970.3 1977.8 23887.2 23968.0 24000.0 24008.6 24070.4 6056.4 6253.9 6269.2 6383.6 6476.3 16242.1 16258.2 16274.0 16298.1 16314.4 7624.8 7787.1 7797.9 7798.3 7816.6 6998.7 7189.1 7235.7 7254.3 7266.9 5007.8 5132.3 5184.8 5212.2 5232.3 1350.8 1377.1 1446.4 1474.7 1500.4 906.6 911.9 915.9 926.2 928.9 7515.6 7677.3 7730.5 7731.9 7888.2 976.0 976.7 981.6 993.9 1000.2 4029.6 5583.3 5611.2 5650.8 5783.4 18953.0 19382.4 20386.3 20477.9 20516.1 19725.7 19949.8 19999.2 20004.6 20027.5 10439.8 10808.6 10836.9 10843.6 10873.6 8126.9 8444.8 8678.1 8787.6 8879.7 17515.3 17711.5 17746.6 17768.3 17802.3 17704.9 17715.5 17764.5 17859.7 18263.6 10241.9 10501.7 10510.5 10519.6 10533.3 12701.6 12758.6 12927.7 13217.2 13226.1 10903.2 11084.9 11131.8 11255.9 11326.4 10579.1 10724.6 10769.2 10859.7 11105.5 9363.3 9432.3 9484.3 9519.0 9522.4 6760.9 6981.9 7262.1 7490.7 7538.5 7169.0 7211.8 7272.5 7281.1 7320.9 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#4] prototype.html Cycles:180 Average:5615.77 Median:6226.60 stddev:1579.75 (25.4%) stddev-sans-first:1536.88 11:09:54 INFO - PID 3560 | Values: 503.9 504.0 529.0 530.3 540.5 6240.3 6309.5 6342.6 6430.1 6434.5 6059.6 6230.7 6255.9 6268.7 6311.4 4993.2 5003.9 5041.6 5094.9 5107.4 4860.8 4995.8 5011.3 5087.0 5095.7 4955.3 4978.6 4991.9 5054.5 5086.7 4994.3 4997.4 5038.4 5059.2 5067.7 4478.9 4485.8 4521.8 4545.7 4553.5 6147.2 6158.0 6191.6 6202.0 6222.5 5770.2 5785.6 5811.2 5832.2 5854.7 6521.4 6583.5 6610.7 6624.9 6637.0 4935.1 4940.9 4948.3 4950.4 4972.3 6995.8 7027.9 7056.9 7098.4 7129.0 4991.4 5047.9 5071.9 5084.2 5092.5 5070.3 5129.7 5149.1 5180.6 5190.5 5757.5 5811.5 5826.9 5829.0 5852.3 6658.8 6678.2 6711.6 6777.3 6826.2 1685.5 1729.9 1737.2 1737.6 1778.2 1221.8 1226.7 1229.2 1232.8 1244.7 5843.1 5858.9 5877.9 5909.1 5918.7 6642.4 6773.5 6780.3 6791.6 6834.8 5870.2 5879.8 5881.7 5899.9 5906.5 3618.0 3622.5 3632.2 3646.3 3659.8 6616.7 6642.4 6649.2 6658.4 6691.9 7023.0 7027.3 7060.6 7061.7 7067.6 6503.5 6632.3 6652.2 6667.6 6687.3 6785.5 6847.8 6876.4 6887.3 6905.2 6743.3 6832.5 6844.5 6873.0 6893.6 6523.2 6566.5 6571.8 6587.8 6597.2 5570.9 5577.6 5605.8 5608.3 5611.6 6820.9 6914.4 6917.0 6934.9 6954.3 6703.8 6724.3 6730.8 6748.4 6767.7 6656.8 6672.2 6690.9 6697.1 6778.8 6282.5 6352.4 6381.6 6391.6 6479.6 6570.6 6573.0 6609.2 6639.1 6674.9 6416.0 6432.9 6447.2 6454.9 6460.8 11:09:54 INFO - PID 3560 | 11:09:54 INFO - PID 3560 | [#5] yui.html Cycles:180 Average:23103.91 Median:19436.51 stddev:31570.24 (162.4%) stddev-sans-first:31614.84 11:09:54 INFO - PID 3560 | Values: 915.1 927.6 938.9 941.5 946.9 19238.6 19999.0 20023.8 20069.5 20104.0 18451.8 18822.0 20607.6 20662.8 20742.2 1036.1 1049.7 1051.2 1054.5 1055.0 972.2 1050.0 1056.9 1057.4 1060.1 1098.3 1103.8 1106.4 1111.1 1111.5 1104.8 1108.8 1109.0 1110.1 1110.2 808.0 809.8 812.9 813.1 813.8 19763.5 19787.8 19829.4 19898.1 20693.0 19528.5 19960.7 20037.4 20536.9 21645.5 16493.2 16750.3 16976.2 16982.6 17070.5 3614.8 3642.6 3643.2 3643.9 3645.3 128755.4 129728.4 130037.0 131642.3 132840.3 16822.5 16884.4 16995.4 17299.6 17343.7 30940.4 31339.0 31676.0 31729.4 31804.7 8722.2 8781.3 8802.5 8838.2 8853.8 4036.1 4187.1 4198.0 4210.0 4210.0 5019.9 5205.4 5237.9 5361.8 5369.1 1087.1 1133.6 1145.7 1146.7 1147.7 692.9 695.3 707.6 714.2 724.2 12489.6 12489.9 12714.4 12741.6 12946.7 704.2 717.0 717.8 723.2 734.7 5494.1 5950.9 5971.6 5993.1 6077.8 99504.5 100998.0 108847.5 111400.0 114314.0 90735.5 95421.5 96305.0 96654.5 98615.0 79348.6 84707.6 85088.0 87506.7 87813.1 11153.4 11179.5 11322.4 11332.8 11440.4 40937.6 41087.1 41437.8 41508.4 43597.3 51536.0 51811.2 52559.7 52602.5 53651.0 16057.1 16631.3 16895.9 16959.7 17014.7 18443.8 18815.4 18878.2 18884.4 18887.1 16242.8 16469.2 16579.4 16613.8 16619.2 14697.3 14731.1 14815.9 14872.1 14918.9 16720.5 17456.4 18951.8 19062.6 19344.5 12950.5 13138.3 13666.5 13703.3 13906.2 14684.4 15188.8 15192.7 15312.2 15339.2 11:09:54 INFO - PID 3560 | -------- Summary: end -------- 11:09:54 INFO - PID 3560 | 11:09:55 INFO - TEST-INFO | 3560: exit 0 11:09:55 INFO - TEST-OK | dromaeo_css | took 1113278ms 11:09:55 INFO - TEST-START | kraken 11:09:55 INFO - Initialising browser for kraken test... 11:09:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40331/getInfo.html -profile /tmp/tmp_qOPCi/profile 11:09:55 INFO - TEST-INFO | started process 3931 (/builds/slave/test/build/application/firefox/firefox http://localhost:40331/getInfo.html) 11:10:01 INFO - TEST-INFO | 3931: exit 0 11:10:01 INFO - Browser initialized. 11:10:01 INFO - Running cycle 1/1 for kraken test... 11:10:01 INFO - TEST-INFO | started process 4168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qOPCi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:02 INFO - PID 4168 | 11:10:02 INFO - PID 4168 | (/builds/slave/test/build/application/firefox/firefox:4223): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:10:02 INFO - PID 4168 | 11:10:12 INFO - PID 4168 | RSS: Main: 171298816 11:10:12 INFO - PID 4168 | 11:10:15 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40331/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:16 INFO - PID 4168 | RSS: Main: 177725440 11:10:16 INFO - PID 4168 | 11:10:18 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40331/tests/kraken/driver.html?testName=audio-dft) 11:10:19 INFO - PID 4168 | RSS: Main: 177786880 11:10:19 INFO - PID 4168 | 11:10:22 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40331/tests/kraken/driver.html?testName=audio-fft) 11:10:23 INFO - PID 4168 | RSS: Main: 172994560 11:10:23 INFO - PID 4168 | 11:10:25 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40331/tests/kraken/driver.html?testName=audio-oscillator) 11:10:26 INFO - PID 4168 | RSS: Main: 173662208 11:10:26 INFO - PID 4168 | 11:10:28 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:29 INFO - PID 4168 | RSS: Main: 173584384 11:10:29 INFO - PID 4168 | 11:10:32 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40331/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:32 INFO - PID 4168 | RSS: Main: 176312320 11:10:32 INFO - PID 4168 | 11:10:36 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40331/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:36 INFO - PID 4168 | RSS: Main: 175910912 11:10:36 INFO - PID 4168 | 11:10:39 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40331/tests/kraken/driver.html?testName=json-parse-financial) 11:10:40 INFO - PID 4168 | RSS: Main: 176230400 11:10:40 INFO - PID 4168 | 11:10:42 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:42 INFO - PID 4168 | RSS: Main: 176439296 11:10:42 INFO - PID 4168 | 11:10:44 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:45 INFO - PID 4168 | RSS: Main: 173412352 11:10:45 INFO - PID 4168 | 11:10:47 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:48 INFO - PID 4168 | RSS: Main: 173748224 11:10:48 INFO - PID 4168 | 11:10:50 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:51 INFO - PID 4168 | RSS: Main: 174198784 11:10:51 INFO - PID 4168 | 11:10:54 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:55 INFO - PID 4168 | RSS: Main: 174526464 11:10:55 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | Cycle 1(1): loaded http://localhost:40331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40331/tests/kraken/driver.html?testName=ai-astar) 11:10:57 INFO - PID 4168 | RSS: Main: 176037888 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | __start_tp_report 11:10:57 INFO - PID 4168 | _x_x_mozilla_page_load 11:10:57 INFO - PID 4168 | _x_x_mozilla_page_load_details 11:10:57 INFO - PID 4168 | |i|pagename|runs| 11:10:57 INFO - PID 4168 | |0;ai-astar;99;107;102;108;108;115;110;99;113;107 11:10:57 INFO - PID 4168 | |1;audio-beat-detection;142;118;139;186;117;154;148;118;169;120 11:10:57 INFO - PID 4168 | |2;audio-dft;162;167;162;162;163;170;170;175;167;165 11:10:57 INFO - PID 4168 | |3;audio-fft;81;76;75;182;76;79;80;88;100;75 11:10:57 INFO - PID 4168 | |4;audio-oscillator;78;78;134;79;88;78;134;80;79;132 11:10:57 INFO - PID 4168 | |5;imaging-gaussian-blur;114;113;114;113;117;114;114;114;114;114 11:10:57 INFO - PID 4168 | |6;imaging-darkroom;152;149;150;150;150;149;150;153;150;152 11:10:57 INFO - PID 4168 | |7;imaging-desaturate;95;93;94;94;94;94;94;93;94;95 11:10:57 INFO - PID 4168 | |8;json-parse-financial;59;53;53;55;54;53;54;53;61;56 11:10:57 INFO - PID 4168 | |9;json-stringify-tinderbox;55;54;54;55;54;54;54;55;61;55 11:10:57 INFO - PID 4168 | |10;stanford-crypto-aes;85;76;80;77;77;77;78;90;77;77 11:10:57 INFO - PID 4168 | |11;stanford-crypto-ccm;122;129;136;123;137;129;131;135;130;176 11:10:57 INFO - PID 4168 | |12;stanford-crypto-pbkdf2;171;172;178;181;176;181;173;175;175;175 11:10:57 INFO - PID 4168 | |13;stanford-crypto-sha256-iterative;70;72;69;75;67;70;68;69;69;67 11:10:57 INFO - PID 4168 | __end_tp_report 11:10:57 INFO - PID 4168 | __start_cc_report 11:10:57 INFO - PID 4168 | _x_x_mozilla_cycle_collect,955 11:10:57 INFO - PID 4168 | __end_cc_report 11:10:57 INFO - PID 4168 | __startTimestamp1502734257290__endTimestamp 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | ------- Summary: start ------- 11:10:57 INFO - PID 4168 | Number of tests: 14 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#0] ai-astar Cycles:10 Average:106.80 Median:111.50 stddev:5.41 (4.9%) stddev-sans-first:4.95 11:10:57 INFO - PID 4168 | Values: 99.0 107.0 102.0 108.0 108.0 115.0 110.0 99.0 113.0 107.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:145.00 stddev:23.82 (16.4%) stddev-sans-first:25.26 11:10:57 INFO - PID 4168 | Values: 142.0 118.0 139.0 186.0 117.0 154.0 148.0 118.0 169.0 120.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.00 stddev:4.37 (2.6%) stddev-sans-first:4.35 11:10:57 INFO - PID 4168 | Values: 162.0 167.0 162.0 162.0 163.0 170.0 170.0 175.0 167.0 165.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#3] audio-fft Cycles:10 Average:91.20 Median:77.50 stddev:32.83 (42.4%) stddev-sans-first:34.61 11:10:57 INFO - PID 4168 | Values: 81.0 76.0 75.0 182.0 76.0 79.0 80.0 88.0 100.0 75.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:78.50 stddev:25.94 (33.0%) stddev-sans-first:26.68 11:10:57 INFO - PID 4168 | Values: 78.0 78.0 134.0 79.0 88.0 78.0 134.0 80.0 79.0 132.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 11:10:57 INFO - PID 4168 | Values: 114.0 113.0 114.0 113.0 117.0 114.0 114.0 114.0 114.0 114.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:1.35 (0.9%) stddev-sans-first:1.32 11:10:57 INFO - PID 4168 | Values: 152.0 149.0 150.0 150.0 150.0 149.0 150.0 153.0 150.0 152.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 11:10:57 INFO - PID 4168 | Values: 95.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 95.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:2.81 (5.1%) stddev-sans-first:2.60 11:10:57 INFO - PID 4168 | Values: 59.0 53.0 53.0 55.0 54.0 53.0 54.0 53.0 61.0 56.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:2.13 (3.9%) stddev-sans-first:2.26 11:10:57 INFO - PID 4168 | Values: 55.0 54.0 54.0 55.0 54.0 54.0 54.0 55.0 61.0 55.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:77.50 stddev:4.55 (5.9%) stddev-sans-first:4.35 11:10:57 INFO - PID 4168 | Values: 85.0 76.0 80.0 77.0 77.0 77.0 78.0 90.0 77.0 77.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.00 stddev:15.32 (11.5%) stddev-sans-first:15.53 11:10:57 INFO - PID 4168 | Values: 122.0 129.0 136.0 123.0 137.0 129.0 131.0 135.0 130.0 176.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:175.50 stddev:3.43 (2.0%) stddev-sans-first:3.19 11:10:57 INFO - PID 4168 | Values: 171.0 172.0 178.0 181.0 176.0 181.0 173.0 175.0 175.0 175.0 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.41 (3.5%) stddev-sans-first:2.55 11:10:57 INFO - PID 4168 | Values: 70.0 72.0 69.0 75.0 67.0 70.0 68.0 69.0 69.0 67.0 11:10:57 INFO - PID 4168 | -------- Summary: end -------- 11:10:57 INFO - PID 4168 | 11:10:57 INFO - PID 4168 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:10:57 INFO - TEST-INFO | 4168: exit 0 11:10:58 INFO - TEST-OK | kraken | took 62794ms 11:10:58 INFO - SUITE-END | took 1176s 11:10:58 INFO - Completed test suite (00:19:36) 11:10:58 INFO - javascript benchmark 11:10:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8595.441372191817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.1783536280573, 3183.4906414973607, 3207.1180425383022, 3232.4020056289582, 3235.175030367256, 6112.235970503687, 6137.416945390187, 6181.196444462219, 6208.348123447029, 6278.246610406746, 6234.438900498954, 6246.937530624692, 6279.277883043452, 6291.4652254558305, 6365.013422919444, 5553.250311207976, 5655.802046928358, 5750.798722044729, 5757.337906140785, 5769.451902069297, 5600.439956004408, 5617.8033768818095, 5712.171735098408, 5725.770969161229, 5768.36547979724, 5682.829515114532, 5758.078707406816, 5762.625429347079, 5782.681952492611, 5785.190073389729, 5689.772409103631, 5701.828945131652, 5771.913421298684, 5776.191333213354, 5794.797182098607, 5531.612787104904, 5550.72246387679, 5637.802676906289, 5649.604527683064, 5727.0, 6036.63780173191, 6137.631742095488, 6147.2930612979635, 6174.320824709278, 6176.011838105882, 6548.607083575001, 6619.404253617149, 6642.368974947372, 6660.300668429793, 6717.09319241901, 6711.463082953352, 6732.326767323278, 6801.965990170067, 6817.250102488722, 6832.282610325894, 6054.273487181566, 6223.159873417076, 6245.812625621239, 6302.8424289392215, 6318.842028949267, 6806.047153398528, 6896.517243792987, 6970.686319115652, 6971.965140174267, 6985.93014069863, 6506.31683673217, 6546.803595892131, 6578.473722102316, 6587.110740050128, 6598.835029124214, 6568.934310656928, 6591.0, 6667.19993600771, 6692.732290708317, 6694.196696396463, 6565.048068030109, 6587.670616469158, 6674.399304062657, 6677.0, 6681.966590167018, 6552.049952756824, 6658.43403310724, 6672.966635166793, 6756.4932630052945, 6761.121054262914, 5378.838634840961, 5427.29445172133, 5428.619996600279, 5432.728363581805, 5435.864103397446, 4614.769261536977, 4654.464736555272, 4660.324252983299, 4664.416947881515, 4693.436787585511, 5796.072628379439, 5797.739101740347, 5862.091375836752, 5862.882742345215, 5863.472287494146, 6569.474442044625, 6672.733090676318, 6739.090222819955, 6763.526553141233, 6763.560368576027, 5730.7421166047625, 5786.623869448473, 5803.129530570448, 5807.216025836543, 5808.6224395414165, 5729.88540229193, 5892.823215303548, 5896.498797602252, 5901.793437229677, 5928.673922934194, 6435.871282574229, 6447.097406363113, 6456.192975878015, 6539.50953678476, 6546.836329091716, 6588.538802283986, 6663.733450661919, 6718.496112791658, 6737.797866064026, 6761.966190169018, 6529.738810447719, 6548.214214294315, 6549.7380104795275, 6552.57408268461, 6563.1796025496815, 6579.276279609335, 6585.80242592723, 6596.5052621052655, 6688.264290928091, 6688.933110668831, 6683.866322673616, 6722.394984451423, 6796.218434879855, 6800.52396332252, 6820.965895170492, 6269.843253918689, 6366.554341196257, 6392.232932047998, 6476.4495017924, 6557.114789503356, 6507.674616269073, 6525.086487891794, 6530.8040758777315, 6540.345965403612, 6546.24718157418, 6376.107344971801, 6408.070829729756, 6466.870662586816, 6476.287608362982, 6478.773242936474, 6477.773277935438, 6520.804375868732, 6585.440237579859, 6592.967035164794, 6624.138861947916, 6214.5028397728975, 6307.05394190875, 6328.0507923809955, 6340.207474065742, 6417.0], "value": 6100.22029788774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.1205829616572, 838.3125836813812, 857.4212406625526, 859.2610355094614, 1170.262734477279, 31768.68231317689, 32774.83612581937, 44109.33835992463, 44759.32861007079, 44778.552214477924, 44196.337054944204, 44654.0, 44702.10595788082, 44820.775896120555, 44837.103257934825, 7650.464467487292, 7735.574543400111, 7749.0, 7769.533827970312, 7799.298063174313, 7658.349040331578, 7772.145064042951, 7780.02749656293, 7780.221977802231, 7780.649870755801, 7784.883226751604, 7792.727254546092, 7796.1814009529035, 7808.80477988052, 7812.453128281023, 7754.030746156731, 7764.883526747103, 7779.260970207822, 7786.532808031537, 7789.454738168331, 7609.505382150142, 7652.0, 7665.846683066363, 7673.923260767377, 7680.34717049046, 40836.795816021026, 41291.587084129074, 41324.793376032925, 41381.1723765523, 41449.1710165795, 3590.35373632746, 3617.819109044537, 3620.0225938996587, 3627.2564124354444, 3636.090977255686, 32842.17894552655, 32934.67065329364, 32938.50592241118, 33014.83492582546, 33091.172720681934, 5073.39119305682, 5079.212722028092, 5095.0, 5095.159298715707, 5100.438951715309, 203268.0, 203723.99999999852, 204133.0, 204248.0, 204727.0, 47948.7602561985, 48022.5197748018, 48362.27456588154, 48369.75815120902, 48482.27276590854, 49498.75250623796, 50126.49873501218, 50149.74925125351, 50189.74905125524, 50225.49774502281, 14674.339654715563, 14932.70134597302, 14948.177850218342, 14953.925230373778, 14977.326020329112, 12115.454804533818, 12124.878751212551, 12159.878401216052, 12168.878311216775, 12220.083493738006, 12679.873201268054, 12930.870691293156, 12972.80540791889, 13047.086703930823, 13143.14569552976, 5472.534834539029, 5477.75350109246, 5499.752511136929, 5507.586930980113, 5512.0, 985.0986347492108, 992.7016020630651, 1018.1549314069305, 1025.9384436933808, 1029.8815636201782, 22873.543744954964, 22900.885495572416, 22968.310950671508, 23208.883955580113, 23266.185683500997, 1119.8208286674094, 1134.121056181466, 1137.0960086731068, 1142.1205671632797, 1146.060230610891, 12301.32342721159, 12304.507819687113, 12307.93846030782, 12378.81431778524, 12436.81344779829, 215472.0, 216357.0, 216778.0, 258811.0, 260616.0, 62963.37036629575, 63224.683876580326, 63247.0, 63474.682626586575, 63502.36497635057, 1515.0, 1554.1063888264293, 1562.421903895566, 1563.1558958162466, 1580.138824340737, 28290.717092828807, 28311.575326370534, 28315.575266370608, 28333.57499637466, 29053.12840614785, 40792.38811417772, 40961.59038409697, 41082.589174107874, 41235.793821030704, 41265.0, 225711.0, 227305.0, 227476.0, 227550.0, 228707.0, 37942.430863536516, 38065.23869522649, 38344.233115338095, 38356.616433835305, 39061.609383905794, 46716.53283467122, 47499.76250118727, 47517.0, 47913.281300781215, 48251.0, 33882.152946175556, 34360.0, 34556.82721586376, 34868.47697284492, 34903.65096349004, 33439.0, 33514.32971340511, 33522.16194595155, 33631.0, 34453.483197752554, 35953.101172470895, 36669.166541673345, 36834.0, 36938.261234775695, 36991.8150409257, 32356.267718967378, 32676.50985235271, 32805.507917381736, 33007.0, 33436.66563334336, 23388.883055584614, 23595.174168904006, 23676.289711308687, 25666.0, 25679.358016049748], "value": 17723.76163618847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3146970839558, 579.5132089045201, 582.7086456771614, 586.8591538030871, 588.1589327262014, 21545.24591639293, 23026.88486557567, 23890.044398224072, 23895.880520597395, 23905.402364940885, 25712.742872571267, 27863.442731145416, 27919.58120628187, 27929.301767455825, 28087.157385278424, 6664.833379165523, 6774.085498457719, 6805.081314022618, 6810.557313774613, 6813.148356455443, 6094.360092190323, 6542.836429089287, 6561.737530498798, 6565.868682626345, 6576.342365763409, 6535.869282614345, 6552.180977377828, 6556.27880933097, 6559.245686746014, 6572.145621069254, 6551.574147680433, 6554.311797261266, 6556.44270237028, 6567.802965911006, 6570.0, 6073.42302481268, 6087.1173679816175, 6087.421694938974, 6095.420935011211, 6096.786612468542, 29132.126036218946, 30066.398672026437, 30612.387752245053, 31093.37813243745, 31144.37711245785, 1966.429735376739, 1995.600879824041, 1997.800219978005, 2003.9599208015904, 2004.3085135628185, 19939.80060199394, 20413.693794592946, 20451.2842050529, 20489.795102048938, 20528.794712052837, 2386.284114765581, 2401.387646150238, 2421.418859473731, 2432.586460301753, 2442.7068751749903, 140588.0, 143497.2825135878, 146069.26965365213, 146777.0, 147575.0, 14707.852921470861, 15325.46360877364, 15382.538523844303, 15820.367185312458, 15971.121588312755, 24080.87959560191, 24283.150089746774, 24376.146834860694, 24393.512129757306, 24432.0, 10151.593936242467, 10203.183745300357, 10225.335353202167, 10234.232432567587, 10345.068943795095, 9300.162985331353, 9328.300377471716, 9343.486108263975, 9366.29752768545, 9449.338546301831, 7901.960490197513, 9398.624055037859, 9439.858402123973, 9493.477858717699, 9515.90484095164, 2761.4891245119716, 2778.0, 2787.4982503149627, 2825.901093461719, 2870.0815738963333, 976.2336565795816, 991.5637119667467, 995.7759504111517, 997.5062344139698, 1015.1016350529686, 19492.8050719491, 19899.204031838854, 19995.0, 20012.799872001095, 20222.930728330004, 1045.2004216774174, 1053.3363980692116, 1056.8520407143005, 1060.3955745225148, 1065.8188108021654, 11189.608363707232, 11247.550097995989, 11355.37545435009, 11387.259828111146, 11446.94276528612, 482993.0, 492164.0, 492758.0, 496743.0, 506707.0, 123639.0, 124435.0, 128645.0, 129474.35262823626, 130130.99999999811, 1249.237964841446, 1256.4032084759665, 1293.8447386313514, 1295.546558704446, 1298.448159532195, 21059.262925797524, 21113.26103586367, 21179.364619061453, 21290.148394064065, 21703.45741356479, 58808.705956471655, 59363.70318148382, 59595.70202148962, 60068.39931600628, 61079.694601528485, 76085.23914760782, 76711.0, 76777.0, 76929.23070769444, 77171.22828771641, 12549.372531373212, 13198.60404187876, 13224.338783061, 14569.198694071927, 14967.326470308644, 23762.643560346954, 24935.251942441755, 24987.625185621866, 25006.0, 25049.624255635816, 18654.813451865306, 19091.522711932314, 19114.139863706445, 19154.329598463988, 19319.0, 17347.392841250497, 17588.472345829647, 17717.557061073578, 17731.37940172088, 17979.73030404571, 19427.222911083398, 19684.114214860077, 19753.802461975196, 19906.50233744168, 19965.101570429655, 14549.781753273497, 14753.92623036878, 14826.25868706582, 14857.925710371379, 14861.331240094005, 19113.13990870442, 19292.807071929103, 19305.613887721887, 19376.2249510018, 19384.418467445998], "value": 12359.617338027474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.9931200343997, 1418.6027912184593, 1431.1699214455616, 1447.3269929482788, 1451.056813071504, 12165.817512737316, 13840.861591384084, 14445.277736113192, 14478.13131212128, 14495.420183192673, 12417.813732794015, 12582.748345033095, 14126.505572304972, 14623.561293161221, 14670.779938300933, 2672.973270267292, 2715.8642067896526, 2716.3209197700576, 2716.8641567921622, 2717.714639962805, 2571.061562529682, 2574.3306740247485, 2648.311439025848, 2650.9204723858315, 2657.9734202658015, 2675.665541807274, 2712.22701530064, 2716.578930265812, 2717.8505182215067, 2718.0215122555965, 2567.56351420259, 2591.922242332733, 2594.597837335207, 2597.974020259811, 2598.6881574211025, 2570.4088059746364, 2573.4595734895693, 2576.587745960656, 2589.896404143832, 2590.8834102465435, 13326.000549958791, 13593.660158496017, 13624.0, 13663.658408539866, 13711.108777929403, 7418.443616728713, 7662.0, 7698.153203147649, 7704.3451306639, 7704.576248306341, 4893.143699852547, 4965.106280869442, 4970.552650261494, 5130.4613015633195, 5199.688018718851, 1906.3423119023914, 1929.8359639430664, 1945.785963544009, 1970.2808474906699, 1977.7626684797772, 23887.163949261867, 23968.0, 24000.0, 24008.63987040196, 24070.398240043964, 6056.424639659225, 6253.874922501615, 6269.185005949289, 6383.648899310582, 6476.319986401454, 16242.10668413225, 16258.18709064542, 16274.023558586523, 16298.103604301878, 16314.428994985119, 7624.771256862303, 7787.06555213378, 7797.883031754528, 7798.298153166129, 7816.648250828613, 6998.720051197997, 7189.065421495172, 7235.674394652253, 7254.274572542704, 7266.890996635055, 5007.84976450707, 5132.255822905732, 5184.792608295701, 5212.218167274939, 5232.3459567554055, 1350.7973803929292, 1377.0704774277324, 1446.4214314274163, 1474.7198032374029, 1500.3698446652431, 906.582971832951, 911.8768966189613, 915.9175674189355, 926.2358554192817, 928.9442633442015, 7515.586642734593, 7677.309042186118, 7730.458867879194, 7731.884021739678, 7888.171741967011, 976.0434773921596, 976.6728146071146, 981.617169303972, 993.9006099390003, 1000.2448151645607, 4029.6171863672903, 5583.302087239095, 5611.158326251095, 5650.802221922213, 5783.421657834267, 18953.0, 19382.4185274442, 20386.28647997313, 20477.89761051215, 20516.07677654509, 19725.704114438297, 19949.800501994796, 19999.200031998847, 20004.599908001757, 20027.49931251701, 10439.843402348972, 10808.621698240524, 10836.945815270874, 10843.62047328324, 10873.565057397616, 8126.943497345307, 8444.76563084049, 8678.132186781271, 8787.604557794786, 8879.733607991771, 17515.299388024847, 17711.46865594034, 17746.5563360917, 17768.289268429635, 17802.287908483515, 17704.911475443056, 17715.468535943943, 17764.46706598804, 17859.73210401871, 18263.634727305114, 10241.948790256001, 10501.737456563647, 10510.527026283682, 10519.579216831242, 10533.315334503539, 12701.618951431472, 12758.553450629184, 12927.741445171232, 13217.206967581977, 13226.140300880412, 10903.236773425784, 11084.889151108708, 11131.833022504507, 11255.887441125484, 11326.433678315887, 10579.10077643409, 10724.571017159225, 10769.192310576582, 10859.728506787393, 11105.500252488819, 9363.250939924927, 9432.292578056537, 9484.288678349014, 9519.0, 9522.428654280766, 6760.864782704417, 6981.860362792614, 7262.128544574685, 7490.662920168715, 7538.509996850187, 7169.0, 7211.819704507429, 7272.454565907472, 7281.05346304977, 7320.853582928418], "value": 6430.362295279222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.8992201559689, 504.01465135659777, 528.9894202115958, 530.2735252703797, 540.4622400711293, 6240.313565507796, 6309.49524038077, 6342.619442833422, 6430.131932189153, 6434.485241180706, 6059.606125601833, 6230.7196176172065, 6255.937440625592, 6268.705936433535, 6311.431971122598, 4993.176125939216, 5003.874903127415, 5041.621878359119, 5094.949050509485, 5107.38711354638, 4860.829870954517, 4995.775190116454, 5011.348524691785, 5086.97456512717, 5095.719735414551, 4955.256711493269, 4978.601711863061, 4991.900161996758, 5054.519820617035, 5086.745662716868, 4994.325766021613, 4997.375328083989, 5038.39539255288, 5059.215821547666, 5067.695938243717, 4478.910421791578, 4485.798139083749, 4521.819127234907, 4545.659075569345, 4553.476350219734, 6147.231596050494, 6158.0, 6191.628502289877, 6202.0, 6222.471089957359, 5770.19217309577, 5785.566082543826, 5811.157382179603, 5832.154337621064, 5854.677992710399, 6521.413072823469, 6583.473322134218, 6610.669466526654, 6624.86750264992, 6636.966815165942, 4935.111679897617, 4940.925886111711, 4948.331975183341, 4950.4307004694565, 4972.290101894476, 6995.79012629622, 7027.89458158128, 7056.894146587805, 7098.361147496698, 7128.964355178191, 4991.3511243538105, 5047.87380315495, 5071.8985620287385, 5084.237364395371, 5092.516210959953, 5070.340855688811, 5129.692218466904, 5149.073166830007, 5180.611454140954, 5190.532852043334, 5757.539396848242, 5811.476967072899, 5826.883462330815, 5828.968936153176, 5852.268466441695, 6658.800235992928, 6678.198616166092, 6711.563748356341, 6777.288384719632, 6826.214985276657, 1685.5449028762412, 1729.8702597305, 1737.200887591722, 1737.6003519190656, 1778.2442461953617, 1221.8472690913636, 1226.6565361698738, 1229.1887354346088, 1232.7657745028416, 1244.7074937389707, 5843.123531470228, 5858.941410585925, 5877.882442351129, 5909.113632955005, 5918.704064796743, 6642.383543437361, 6773.45812335012, 6780.288069752703, 6791.558548694319, 6834.794956151323, 5870.178175055496, 5879.764809407661, 5881.676507792113, 5899.876044623932, 5906.49794767441, 3617.981910090485, 3622.5109610202812, 3632.182758879231, 3646.2707458508403, 3659.780413175218, 6616.669166541654, 6642.435392991553, 6649.235337936199, 6658.368699668516, 6691.899621505681, 7023.0, 7027.297270272932, 7060.576365418091, 7061.717531298793, 7067.6112813795735, 6503.512236582275, 6632.270450250565, 6652.234992975773, 6667.599944003278, 6687.255137123227, 6785.491088168308, 6847.760328388682, 6876.381125698511, 6887.345702158287, 6905.240423553305, 6743.29195434492, 6832.487563432862, 6844.486663500158, 6873.041183262746, 6893.586384816927, 6523.217213934358, 6566.474682025331, 6571.835704107436, 6587.80236592903, 6597.175353080865, 5570.944290557205, 5577.5537956962535, 5605.775768969359, 5608.298962629671, 5611.597100724819, 6820.897686534607, 6914.377706006484, 6916.965415172892, 6934.895976560457, 6954.269801670752, 6703.832404189934, 6724.327567243432, 6730.764423245163, 6748.358905903931, 6767.695453704497, 6656.83357916056, 6672.199336079701, 6690.866182676416, 6697.129373181455, 6778.830529236809, 6282.528810339151, 6352.428281454691, 6381.617102973836, 6391.648459334781, 6479.611223326616, 6570.6057636540045, 6572.967135164294, 6609.173853268341, 6639.136912201383, 6674.866502670016, 6415.967920160369, 6432.9385651367, 6447.194100737408, 6454.870902582016, 6460.806175814733], "value": 5147.420249851637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.0712027292295, 927.582587835474, 938.9389689670171, 941.4868896451434, 946.8863736351639, 19238.615227695438, 19999.0, 20023.799762002374, 20069.498262543406, 20104.0, 18451.815481845177, 18822.0, 20607.587848243027, 20662.793372066273, 20742.170313187453, 1036.1296510930836, 1049.7323182588468, 1051.2168434516295, 1054.5254635414055, 1054.978900421995, 972.1590823937314, 1049.9632512862051, 1056.8520407143005, 1057.3602970203033, 1060.0777323728366, 1098.2531878322736, 1103.779244151169, 1106.4191299567751, 1111.1222134513764, 1111.5442668505873, 1104.7956128116284, 1108.839218313348, 1108.9667309980714, 1110.0509064749604, 1110.1784679337231, 807.9959600201961, 809.7692157735077, 812.8577498937722, 813.0609146435876, 813.800618848386, 19763.505912352164, 19787.80212197874, 19829.405117846345, 19898.104585293695, 20693.0, 19528.51178720529, 19960.70058949117, 20037.398878033535, 20536.897315513477, 21645.458863528536, 16493.17534123289, 16750.329986800636, 16976.15119244045, 16982.575435614086, 17070.48788536346, 3614.7831130132276, 3642.5811031731423, 3643.2167084076787, 3643.85424583019, 3645.2891686121216, 128755.35622321829, 129728.35135824261, 130037.0, 131642.3417882914, 132840.33579832135, 16822.495325140266, 16884.409045683344, 16995.40516081931, 17299.56751081233, 17343.653126937643, 30940.381192376477, 31339.0, 31676.0, 31729.365412692077, 31804.68195318017, 8722.171393717714, 8781.2535934445, 8802.471851688919, 8838.204561589358, 8853.822923541493, 4036.1120553478186, 4187.120704651997, 4197.97901010493, 4209.957900420956, 4209.957900421018, 5019.874503137451, 5205.375354957354, 5237.895242095136, 5361.8123365682795, 5369.087255166631, 1087.1194332590626, 1133.6145710458484, 1145.6734830573246, 1146.6502716671328, 1147.690123666622, 692.8891377379595, 695.2630211975322, 707.6426404665611, 714.1893950366372, 724.1672077111364, 12489.562865299671, 12489.93755031219, 12714.427850746739, 12741.617751467471, 12946.67633309156, 704.1585305559909, 717.0427479315173, 717.7990162754437, 723.1791916175179, 734.7208060936916, 5494.148406996922, 5950.851228719317, 5971.641701497924, 5993.130996005555, 6077.817665470043, 99504.50247748716, 100998.0, 108847.45576272227, 111400.0, 114313.99901003425, 90735.54632226797, 95421.52289238648, 96305.0, 96654.51672741592, 98615.0, 79348.60325698335, 84707.5764621173, 85088.0, 87506.68739968905, 87813.12186878177, 11153.386563739072, 11179.496922638338, 11322.433878305887, 11332.773344532898, 11440.370779607201, 40937.59062409338, 41087.05757686319, 41437.79281103575, 41508.377374340016, 43597.34603980879, 51536.0, 51811.222831658306, 52559.73720131375, 52602.47397526129, 53651.0, 16057.11685857289, 16631.33474661, 16895.91552042232, 16959.660806783548, 17014.659706806044, 18443.81556184421, 18815.435536933914, 18878.15048322801, 18884.43346699601, 18887.05564721731, 16242.756358654866, 16469.176541172656, 16579.419720309732, 16613.833861661227, 16619.169041547633, 14697.338619761922, 14731.116133032052, 14815.851841481448, 14872.107673539622, 14918.85081149218, 16720.498385048468, 17456.389026384015, 18951.810481895005, 19062.61874762525, 19344.516387090436, 12950.481980720666, 13138.277394742998, 13666.52167174144, 13703.314834258048, 13906.165630062229, 14684.41262349494, 15188.772168417261, 15192.696146077238, 15312.157831319384, 15339.233038347815], "value": 9116.966603975721, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 102.0, 108.0, 108.0, 115.0, 110.0, 99.0, 113.0, 107.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 139.0, 186.0, 117.0, 154.0, 148.0, 118.0, 169.0, 120.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 162.0, 162.0, 163.0, 170.0, 170.0, 175.0, 167.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 75.0, 182.0, 76.0, 79.0, 80.0, 88.0, 100.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 134.0, 79.0, 88.0, 78.0, 134.0, 80.0, 79.0, 132.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 150.0, 150.0, 150.0, 149.0, 150.0, 153.0, 150.0, 152.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 53.0, 55.0, 54.0, 53.0, 54.0, 53.0, 61.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 61.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 80.0, 77.0, 77.0, 77.0, 78.0, 90.0, 77.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 129.0, 136.0, 123.0, 137.0, 129.0, 131.0, 135.0, 130.0, 176.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 178.0, 181.0, 176.0, 181.0, 173.0, 175.0, 175.0, 175.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 75.0, 67.0, 70.0, 68.0, 69.0, 69.0, 67.0], "value": 69.6, "unit": "score"}]}]} 11:10:58 INFO - Return code: 0 11:10:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:58 INFO - # TBPL SUCCESS # 11:10:58 INFO - Running post-action listener: _package_coverage_data 11:10:58 INFO - Running post-action listener: _resource_record_post_action 11:10:58 INFO - [mozharness: 2017-08-14 18:10:58.567178Z] Finished run-tests step (success) 11:10:58 INFO - Running post-run listener: _resource_record_post_run 11:10:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 6225920; Write bytes: 431325184; Read time: 2936; Write time: 262084 11:10:58 INFO - TinderboxPrint: CPU usage
13.1% 11:10:58 INFO - TinderboxPrint: I/O read bytes / time
6,225,920 / 2,936 11:10:58 INFO - TinderboxPrint: I/O write bytes / time
431,325,184 / 262,084 11:10:58 INFO - TinderboxPrint: CPU idle
8,274.2 (86.8%) 11:10:58 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 11:10:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:10:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 184594432; Read time: 0; Write time: 100116 11:10:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:10:58 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4038656; Write bytes: 145018880; Read time: 2608; Write time: 44892 11:10:59 INFO - Running post-run listener: _upload_blobber_files 11:10:59 INFO - Blob upload gear active. 11:10:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:59 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 11:10:59 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'] 11:10:59 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 11:10:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:11:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:00 INFO - (blobuploader) - INFO - Done attempting. 11:11:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:07 INFO - (blobuploader) - INFO - Done attempting. 11:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:08 INFO - (blobuploader) - INFO - Done attempting. 11:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:09 INFO - (blobuploader) - INFO - Done attempting. 11:11:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:09 INFO - Return code: 0 11:11:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbb8509487ec884546936394725f910e8df2b3f2d8b13286902b189531ec817b40d3fd784bcf215c3ff15c69c221ee0109db9a5d83664f7c1e5d97f7d66add4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4475ee49f464baed4e83d8d60e4b30d40088c8c94b2c1214ed25ff41c7635e0f2195578e4ad3fdf3eb0fccf1aa44a2e58a257d9a6cb3098381afad887cda236", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9bd3f9965e9a98e2ebc1eb48ed913d1d31be4d52e5a6ad0d6ee945744f5a1b19178a9616e44ea8ea2e1f1a6634e028289a08598d6ec5f568305920a72196e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703ba71c99fdb8211bb0465d513231969e878a123b1e61bb61401adf2ad5ebcb9fadfbe7f388c0a12473859a064b744a77b3007e5fb183997509b8d2c3be7b5c"} 11:11:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:09 INFO - Contents: 11:11:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbb8509487ec884546936394725f910e8df2b3f2d8b13286902b189531ec817b40d3fd784bcf215c3ff15c69c221ee0109db9a5d83664f7c1e5d97f7d66add4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4475ee49f464baed4e83d8d60e4b30d40088c8c94b2c1214ed25ff41c7635e0f2195578e4ad3fdf3eb0fccf1aa44a2e58a257d9a6cb3098381afad887cda236", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9bd3f9965e9a98e2ebc1eb48ed913d1d31be4d52e5a6ad0d6ee945744f5a1b19178a9616e44ea8ea2e1f1a6634e028289a08598d6ec5f568305920a72196e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703ba71c99fdb8211bb0465d513231969e878a123b1e61bb61401adf2ad5ebcb9fadfbe7f388c0a12473859a064b744a77b3007e5fb183997509b8d2c3be7b5c"} 11:11:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:09 INFO - Copying logs to upload dir... 11:11:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.061464 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-14 11:11:08.972003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:11:08.975103) ========= 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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbb8509487ec884546936394725f910e8df2b3f2d8b13286902b189531ec817b40d3fd784bcf215c3ff15c69c221ee0109db9a5d83664f7c1e5d97f7d66add4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4475ee49f464baed4e83d8d60e4b30d40088c8c94b2c1214ed25ff41c7635e0f2195578e4ad3fdf3eb0fccf1aa44a2e58a257d9a6cb3098381afad887cda236", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9bd3f9965e9a98e2ebc1eb48ed913d1d31be4d52e5a6ad0d6ee945744f5a1b19178a9616e44ea8ea2e1f1a6634e028289a08598d6ec5f568305920a72196e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703ba71c99fdb8211bb0465d513231969e878a123b1e61bb61401adf2ad5ebcb9fadfbe7f388c0a12473859a064b744a77b3007e5fb183997509b8d2c3be7b5c"} build_url:https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbb8509487ec884546936394725f910e8df2b3f2d8b13286902b189531ec817b40d3fd784bcf215c3ff15c69c221ee0109db9a5d83664f7c1e5d97f7d66add4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4475ee49f464baed4e83d8d60e4b30d40088c8c94b2c1214ed25ff41c7635e0f2195578e4ad3fdf3eb0fccf1aa44a2e58a257d9a6cb3098381afad887cda236", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9bd3f9965e9a98e2ebc1eb48ed913d1d31be4d52e5a6ad0d6ee945744f5a1b19178a9616e44ea8ea2e1f1a6634e028289a08598d6ec5f568305920a72196e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703ba71c99fdb8211bb0465d513231969e878a123b1e61bb61401adf2ad5ebcb9fadfbe7f388c0a12473859a064b744a77b3007e5fb183997509b8d2c3be7b5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:11:09.004171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:11:09.004463) ========= 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=20e20d796406ba5117c4a6f1000001ba-1502729438.317378-1698170974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:11:09.085481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:11:09.086787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:11:09.087060) ========= ========= Total master_lag: -0.15 =========