builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1502147522.17 results: success (0) revision: 65507616792c990b1230888612dd7ffc13ed32b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.174795) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.175337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.175712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.188551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.188898) ========= 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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 16:12:02-- 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% 43.6M=0s 2017-08-07 16:12:02 (43.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.326019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.326399) ========= 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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.378132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:02.378706) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 65507616792c990b1230888612dd7ffc13ed32b4 --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 65507616792c990b1230888612dd7ffc13ed32b4 --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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 16:12:02,697 truncating revision to first 12 chars 2017-08-07 16:12:02,697 Setting DEBUG logging. 2017-08-07 16:12:02,697 attempt 1/10 2017-08-07 16:12:02,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/65507616792c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 16:12:03,302 unpacking tar archive at: mozilla-central-65507616792c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:03.344150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:03.344558) ========= script_repo_revision: 65507616792c990b1230888612dd7ffc13ed32b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:03.344979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:03.345263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 16:12:03.355725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-07 16:12:03.356115) ========= /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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:03 INFO - MultiFileLogger online at 20170807 16:12:03 in /builds/slave/test 16:12:03 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 16:12:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:03 INFO - {'append_to_log': False, 16:12:03 INFO - 'base_work_dir': '/builds/slave/test', 16:12:03 INFO - 'blob_upload_branch': 'Firefox', 16:12:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:03 INFO - 'branch': 'Firefox', 16:12:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:03 INFO - 'code_coverage': False, 16:12:03 INFO - 'config_files': ('talos/linux_config.py',), 16:12:03 INFO - 'default_actions': ('clobber', 16:12:03 INFO - 'read-buildbot-config', 16:12:03 INFO - 'download-and-extract', 16:12:03 INFO - 'populate-webroot', 16:12:03 INFO - 'create-virtualenv', 16:12:03 INFO - 'install', 16:12:03 INFO - 'setup-mitmproxy', 16:12:03 INFO - 'run-tests'), 16:12:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:03 INFO - 'disable_ccov_upload': False, 16:12:03 INFO - 'download_minidump_stackwalk': True, 16:12:03 INFO - 'download_symbols': 'ondemand', 16:12:03 INFO - 'enable_stylo': False, 16:12:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:03 INFO - 'gecko_profile': False, 16:12:03 INFO - 'gecko_profile_interval': 0, 16:12:03 INFO - 'installer_path': 'installer.exe', 16:12:03 INFO - 'log_level': 'info', 16:12:03 INFO - 'log_name': 'talos', 16:12:03 INFO - 'log_to_console': True, 16:12:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:03 INFO - 'opt_config_files': (), 16:12:03 INFO - 'pip_index': False, 16:12:03 INFO - 'suite': 'dromaeojs-e10s', 16:12:03 INFO - 'system_bits': '32', 16:12:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:03 INFO - 'title': 'talos-linux64-ix-007', 16:12:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:03 INFO - 'use_talos_json': True, 16:12:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:03 INFO - 'work_dir': 'build'} 16:12:03 INFO - [mozharness: 2017-08-07 23:12:03.780170Z] Running clobber step. 16:12:03 INFO - Running pre-action listener: _resource_record_pre_action 16:12:03 INFO - Running main action method: clobber 16:12:03 INFO - rmtree: /builds/slave/test/build 16:12:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:04 INFO - Running post-action listener: _resource_record_post_action 16:12:04 INFO - [mozharness: 2017-08-07 23:12:04.937174Z] Finished clobber step (success) 16:12:04 INFO - [mozharness: 2017-08-07 23:12:04.937276Z] Running read-buildbot-config step. 16:12:04 INFO - Running pre-action listener: _resource_record_pre_action 16:12:04 INFO - Running main action method: read_buildbot_config 16:12:04 INFO - Using buildbot properties: 16:12:04 INFO - { 16:12:04 INFO - "project": "", 16:12:04 INFO - "product": "firefox", 16:12:04 INFO - "who": "kwierso@gmail.com", 16:12:04 INFO - "installer_path": "public/build/target.tar.bz2", 16:12:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:12:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:12:04 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:12:04 INFO - "stage_platform": "linux64-stylosequential", 16:12:04 INFO - "basedir": "/builds/slave/test", 16:12:04 INFO - "buildnumber": 173, 16:12:04 INFO - "platform": "ubuntu64_hw_styloseq", 16:12:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:12:04 INFO - "slavebuilddir": "test", 16:12:04 INFO - "taskId": "ViGP-I2BT-GT0b0zSK8kVw", 16:12:04 INFO - "branch": "mozilla-central", 16:12:04 INFO - "script_repo_revision": "production", 16:12:04 INFO - "revision": "65507616792c990b1230888612dd7ffc13ed32b4", 16:12:04 INFO - "slavename": "talos-linux64-ix-007", 16:12:04 INFO - "repo_path": "mozilla-central" 16:12:04 INFO - } 16:12:04 INFO - Finding installer, test and symbols from parent task. 16:12:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViGP-I2BT-GT0b0zSK8kVw'}, attempt #1 16:12:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViGP-I2BT-GT0b0zSK8kVw'}, attempt #1 16:12:05 INFO - Task dependencies: YyZs7crNS8KmVZtD6qtlsg 16:12:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg'}, attempt #1 16:12:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:12:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json 16:12:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.crashreporter-symbols.zip 16:12:06 INFO - Running post-action listener: _resource_record_post_action 16:12:06 INFO - [mozharness: 2017-08-07 23:12:06.313906Z] Finished read-buildbot-config step (success) 16:12:06 INFO - [mozharness: 2017-08-07 23:12:06.314128Z] Running download-and-extract step. 16:12:06 INFO - Running pre-action listener: _resource_record_pre_action 16:12:06 INFO - Running main action method: download_and_extract 16:12:06 INFO - mkdir: /builds/slave/test/build/tests 16:12:06 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')]} 16:12:06 INFO - trying https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json 16:12:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:12:06 INFO - Downloaded 989 bytes. 16:12:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:12:06 INFO - Using the following test package requirements: 16:12:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:12:06 INFO - u'common': [u'target.common.tests.zip'], 16:12:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:12:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:12:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:12:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:12:06 INFO - u'mozbase': [u'target.common.tests.zip'], 16:12:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:12:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:12:06 INFO - u'web-platform': [u'target.common.tests.zip', 16:12:06 INFO - u'target.web-platform.tests.tar.gz'], 16:12:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:12:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:12:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip 16:12:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:12:06 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip into memory 16:12:07 INFO - Content-Length response header: 54284476 16:12:07 INFO - Bytes received: 54284476 16:12:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:12:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip 16:12:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:12:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip into memory 16:12:19 INFO - Content-Length response header: 54284476 16:12:19 INFO - Bytes received: 54284476 16:12:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.talos.tests.zip 16:12:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:12:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.talos.tests.zip into memory 16:12:32 INFO - Content-Length response header: 14496008 16:12:32 INFO - Bytes received: 14496008 16:12:32 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')]} 16:12:32 INFO - trying https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:12:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:12:33 INFO - Downloaded 61758064 bytes. 16:12:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:12:33 INFO - mkdir: /builds/slave/test/properties 16:12:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:33 INFO - Contents: 16:12:33 INFO - build_url:https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:12:33 INFO - Running post-action listener: _resource_record_post_action 16:12:33 INFO - Running post-action listener: set_extra_try_arguments 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.972363Z] Finished download-and-extract step (success) 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.972461Z] Running populate-webroot step. 16:12:33 INFO - Running pre-action listener: _resource_record_pre_action 16:12:33 INFO - Running main action method: populate_webroot 16:12:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:12:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:12:33 INFO - 'tests': ['damp', 'tps']}, 16:12:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:12:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:12:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:12:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:33 INFO - 'ts_paint', 16:12:33 INFO - 'tpaint', 16:12:33 INFO - 'sessionrestore', 16:12:33 INFO - 'sessionrestore_many_windows', 16:12:33 INFO - 'sessionrestore_no_auto_restore', 16:12:33 INFO - 'tabpaint']}, 16:12:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:12:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:12:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:33 INFO - 'tsvgr_opacity', 16:12:33 INFO - 'tart', 16:12:33 INFO - 'tscrollx', 16:12:33 INFO - 'tsvg_static']}, 16:12:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:12:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:33 INFO - 'talos_options': ['--mitmproxy', 16:12:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:33 INFO - '--firstNonBlankPaint'], 16:12:33 INFO - 'tests': ['tp6_google', 16:12:33 INFO - 'tp6_youtube', 16:12:33 INFO - 'tp6_amazon', 16:12:33 INFO - 'tp6_facebook']}, 16:12:33 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:33 INFO - 'talos_options': ['--stylo', 16:12:33 INFO - '--mitmproxy', 16:12:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:33 INFO - '--firstNonBlankPaint'], 16:12:33 INFO - 'tests': ['tp6_google', 16:12:33 INFO - 'tp6_youtube', 16:12:33 INFO - 'tp6_amazon', 16:12:33 INFO - 'tp6_facebook']}, 16:12:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:33 INFO - 'talos_options': ['--stylo', 16:12:33 INFO - '--stylo-threads=1', 16:12:33 INFO - '--mitmproxy', 16:12:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:33 INFO - '--firstNonBlankPaint'], 16:12:33 INFO - 'tests': ['tp6_google', 16:12:33 INFO - 'tp6_youtube', 16:12:33 INFO - 'tp6_amazon', 16:12:33 INFO - 'tp6_facebook']}, 16:12:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:12:33 INFO - 'talos_options': ['--xperf_path', 16:12:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:33 INFO - 'tests': ['tp5n']}}} 16:12:33 INFO - Running post-action listener: _resource_record_post_action 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.980874Z] Finished populate-webroot step (success) 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.980964Z] Running create-virtualenv step. 16:12:33 INFO - Running pre-action listener: _resource_record_pre_action 16:12:33 INFO - Running main action method: create_virtualenv 16:12:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:33 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 16:12:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:12:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:34 INFO - Using real prefix '/usr' 16:12:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:36 INFO - Installing pip.................done. 16:12:36 INFO - Return code: 0 16:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:36 INFO - Reading from file tmpfile_stdout 16:12:36 INFO - Output received: 16:12:36 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) 16:12:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:36 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')]} 16:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:36 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')]} 16:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:36 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:36 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 16:12:36 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 16:12:36 INFO - Using env: {'DISPLAY': ':0', 16:12:36 INFO - 'HOME': '/home/cltbld', 16:12:36 INFO - 'LANG': 'en_US.UTF-8', 16:12:36 INFO - 'LANGUAGE': 'en_US:en', 16:12:36 INFO - 'LOGNAME': 'cltbld', 16:12:36 INFO - 'MAIL': '/var/mail/cltbld', 16:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:36 INFO - 'MOZ_NO_REMOTE': '1', 16:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:36 INFO - 'NO_EM_RESTART': '1', 16:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:36 INFO - 'PWD': '/builds/slave/test', 16:12:36 INFO - 'SHELL': '/bin/bash', 16:12:36 INFO - 'SHLVL': '1', 16:12:36 INFO - 'TERM': 'linux', 16:12:36 INFO - 'TMOUT': '86400', 16:12:36 INFO - 'USER': 'cltbld', 16:12:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:36 INFO - '_': '/tools/buildbot/bin/python'} 16:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:36 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 16:12:36 INFO - Cleaning up... 16:12:37 INFO - Return code: 0 16:12:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:37 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')]} 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:37 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')]} 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:37 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:37 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 16:12:37 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 16:12:37 INFO - Using env: {'DISPLAY': ':0', 16:12:37 INFO - 'HOME': '/home/cltbld', 16:12:37 INFO - 'LANG': 'en_US.UTF-8', 16:12:37 INFO - 'LANGUAGE': 'en_US:en', 16:12:37 INFO - 'LOGNAME': 'cltbld', 16:12:37 INFO - 'MAIL': '/var/mail/cltbld', 16:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:37 INFO - 'MOZ_NO_REMOTE': '1', 16:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:37 INFO - 'NO_EM_RESTART': '1', 16:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:37 INFO - 'PWD': '/builds/slave/test', 16:12:37 INFO - 'SHELL': '/bin/bash', 16:12:37 INFO - 'SHLVL': '1', 16:12:37 INFO - 'TERM': 'linux', 16:12:37 INFO - 'TMOUT': '86400', 16:12:37 INFO - 'USER': 'cltbld', 16:12:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:37 INFO - '_': '/tools/buildbot/bin/python'} 16:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:37 INFO - Downloading/unpacking psutil>=3.1.1 16:12:37 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 16:12:37 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 16:12:37 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 16:12:37 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 16:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:38 INFO - Installing collected packages: psutil 16:12:38 INFO - Running setup.py install for psutil 16:12:38 INFO - building 'psutil._psutil_linux' extension 16:12:38 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 16:12:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:12:38 INFO - building 'psutil._psutil_posix' extension 16:12:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:12:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:12:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:38 INFO - Successfully installed psutil 16:12:38 INFO - Cleaning up... 16:12:38 INFO - Return code: 0 16:12:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:38 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')]} 16:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:38 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')]} 16:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:38 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 16:12:38 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 16:12:38 INFO - Using env: {'DISPLAY': ':0', 16:12:38 INFO - 'HOME': '/home/cltbld', 16:12:38 INFO - 'LANG': 'en_US.UTF-8', 16:12:38 INFO - 'LANGUAGE': 'en_US:en', 16:12:38 INFO - 'LOGNAME': 'cltbld', 16:12:38 INFO - 'MAIL': '/var/mail/cltbld', 16:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:38 INFO - 'MOZ_NO_REMOTE': '1', 16:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:38 INFO - 'NO_EM_RESTART': '1', 16:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:38 INFO - 'PWD': '/builds/slave/test', 16:12:38 INFO - 'SHELL': '/bin/bash', 16:12:38 INFO - 'SHLVL': '1', 16:12:38 INFO - 'TERM': 'linux', 16:12:38 INFO - 'TMOUT': '86400', 16:12:38 INFO - 'USER': 'cltbld', 16:12:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:38 INFO - '_': '/tools/buildbot/bin/python'} 16:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:39 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 16:12:39 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 16:12:39 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 16:12:39 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 16:12:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:40 INFO - Installing collected packages: mozsystemmonitor 16:12:40 INFO - Running setup.py install for mozsystemmonitor 16:12:40 INFO - Successfully installed mozsystemmonitor 16:12:40 INFO - Cleaning up... 16:12:40 INFO - Return code: 0 16:12:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:40 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')]} 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:40 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')]} 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:40 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 16:12:40 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 16:12:40 INFO - Using env: {'DISPLAY': ':0', 16:12:40 INFO - 'HOME': '/home/cltbld', 16:12:40 INFO - 'LANG': 'en_US.UTF-8', 16:12:40 INFO - 'LANGUAGE': 'en_US:en', 16:12:40 INFO - 'LOGNAME': 'cltbld', 16:12:40 INFO - 'MAIL': '/var/mail/cltbld', 16:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:40 INFO - 'MOZ_NO_REMOTE': '1', 16:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:40 INFO - 'NO_EM_RESTART': '1', 16:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:40 INFO - 'PWD': '/builds/slave/test', 16:12:40 INFO - 'SHELL': '/bin/bash', 16:12:40 INFO - 'SHLVL': '1', 16:12:40 INFO - 'TERM': 'linux', 16:12:40 INFO - 'TMOUT': '86400', 16:12:40 INFO - 'USER': 'cltbld', 16:12:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:40 INFO - '_': '/tools/buildbot/bin/python'} 16:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:40 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 16:12:40 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 16:12:40 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 16:12:40 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 16:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:41 INFO - warning: no files found matching '*.txt' 16:12:41 INFO - no previously-included directories found matching 'build' 16:12:41 INFO - no previously-included directories found matching 'dist' 16:12:41 INFO - no previously-included directories found matching '.git*' 16:12:41 INFO - Installing collected packages: jsonschema, functools32 16:12:42 INFO - Running setup.py install for functools32 16:12:42 INFO - warning: no files found matching '*.txt' 16:12:42 INFO - no previously-included directories found matching 'build' 16:12:42 INFO - no previously-included directories found matching 'dist' 16:12:42 INFO - no previously-included directories found matching '.git*' 16:12:42 INFO - Successfully installed jsonschema functools32 16:12:42 INFO - Cleaning up... 16:12:42 INFO - Return code: 0 16:12:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:42 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')]} 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:42 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')]} 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:42 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:42 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 16:12:42 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 16:12:42 INFO - Using env: {'DISPLAY': ':0', 16:12:42 INFO - 'HOME': '/home/cltbld', 16:12:42 INFO - 'LANG': 'en_US.UTF-8', 16:12:42 INFO - 'LANGUAGE': 'en_US:en', 16:12:42 INFO - 'LOGNAME': 'cltbld', 16:12:42 INFO - 'MAIL': '/var/mail/cltbld', 16:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:42 INFO - 'MOZ_NO_REMOTE': '1', 16:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:42 INFO - 'NO_EM_RESTART': '1', 16:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:42 INFO - 'PWD': '/builds/slave/test', 16:12:42 INFO - 'SHELL': '/bin/bash', 16:12:42 INFO - 'SHLVL': '1', 16:12:42 INFO - 'TERM': 'linux', 16:12:42 INFO - 'TMOUT': '86400', 16:12:42 INFO - 'USER': 'cltbld', 16:12:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:42 INFO - '_': '/tools/buildbot/bin/python'} 16:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:42 INFO - Cleaning up... 16:12:42 INFO - Return code: 0 16:12:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:42 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')]} 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:42 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')]} 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:42 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:42 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 16:12:42 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 16:12:42 INFO - Using env: {'DISPLAY': ':0', 16:12:42 INFO - 'HOME': '/home/cltbld', 16:12:42 INFO - 'LANG': 'en_US.UTF-8', 16:12:42 INFO - 'LANGUAGE': 'en_US:en', 16:12:42 INFO - 'LOGNAME': 'cltbld', 16:12:42 INFO - 'MAIL': '/var/mail/cltbld', 16:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:42 INFO - 'MOZ_NO_REMOTE': '1', 16:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:42 INFO - 'NO_EM_RESTART': '1', 16:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:42 INFO - 'PWD': '/builds/slave/test', 16:12:42 INFO - 'SHELL': '/bin/bash', 16:12:42 INFO - 'SHLVL': '1', 16:12:42 INFO - 'TERM': 'linux', 16:12:42 INFO - 'TMOUT': '86400', 16:12:42 INFO - 'USER': 'cltbld', 16:12:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:42 INFO - '_': '/tools/buildbot/bin/python'} 16:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:42 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 16:12:42 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 16:12:42 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 16:12:42 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 16:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:44 INFO - Downloading docopt-0.6.1.tar.gz 16:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:44 INFO - Running setup.py install for blobuploader 16:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:44 INFO - Running setup.py install for requests 16:12:44 INFO - Running setup.py install for docopt 16:12:44 INFO - Successfully installed blobuploader requests docopt 16:12:44 INFO - Cleaning up... 16:12:44 INFO - Return code: 0 16:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:44 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:44 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 16:12:44 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 16:12:44 INFO - Using env: {'DISPLAY': ':0', 16:12:44 INFO - 'HOME': '/home/cltbld', 16:12:44 INFO - 'LANG': 'en_US.UTF-8', 16:12:44 INFO - 'LANGUAGE': 'en_US:en', 16:12:44 INFO - 'LOGNAME': 'cltbld', 16:12:44 INFO - 'MAIL': '/var/mail/cltbld', 16:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:44 INFO - 'MOZ_NO_REMOTE': '1', 16:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:44 INFO - 'NO_EM_RESTART': '1', 16:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:44 INFO - 'PWD': '/builds/slave/test', 16:12:44 INFO - 'SHELL': '/bin/bash', 16:12:44 INFO - 'SHLVL': '1', 16:12:44 INFO - 'TERM': 'linux', 16:12:44 INFO - 'TMOUT': '86400', 16:12:44 INFO - 'USER': 'cltbld', 16:12:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:44 INFO - '_': '/tools/buildbot/bin/python'} 16:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:45 INFO - Running setup.py (path:/tmp/pip-NLxGVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:45 INFO - Running setup.py (path:/tmp/pip-ren3ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:45 INFO - Running setup.py (path:/tmp/pip-kEK8c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:45 INFO - Running setup.py (path:/tmp/pip-9D8xdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:45 INFO - Running setup.py (path:/tmp/pip-N2y0gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:45 INFO - Running setup.py (path:/tmp/pip-hlbSAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:45 INFO - Running setup.py (path:/tmp/pip-1UAusV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:45 INFO - Running setup.py (path:/tmp/pip-_7Isqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:45 INFO - Running setup.py (path:/tmp/pip-vrzwvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:45 INFO - Running setup.py (path:/tmp/pip-aNwm6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:45 INFO - Running setup.py (path:/tmp/pip-DP0xWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:45 INFO - Running setup.py (path:/tmp/pip-MHufI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:45 INFO - Running setup.py (path:/tmp/pip-xpjmfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:46 INFO - Running setup.py (path:/tmp/pip-gb_E0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:46 INFO - Running setup.py (path:/tmp/pip-y_5Xpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:46 INFO - Running setup.py (path:/tmp/pip-NyN3iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:46 INFO - Running setup.py (path:/tmp/pip-4_RXqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:46 INFO - Running setup.py install for manifestparser 16:12:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:46 INFO - Running setup.py install for mozcrash 16:12:46 INFO - Running setup.py install for mozdebug 16:12:46 INFO - Running setup.py install for mozdevice 16:12:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:46 INFO - Running setup.py install for mozfile 16:12:46 INFO - Running setup.py install for mozhttpd 16:12:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:46 INFO - Running setup.py install for mozinfo 16:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for mozInstall 16:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for mozleak 16:12:47 INFO - Running setup.py install for mozlog 16:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for moznetwork 16:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for mozprocess 16:12:47 INFO - Running setup.py install for mozprofile 16:12:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for mozrunner 16:12:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:47 INFO - Running setup.py install for mozscreenshot 16:12:47 INFO - Running setup.py install for moztest 16:12:48 INFO - Running setup.py install for mozversion 16:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:48 INFO - Cleaning up... 16:12:48 INFO - Return code: 0 16:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:48 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:48 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 16:12:48 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 16:12:48 INFO - Using env: {'DISPLAY': ':0', 16:12:48 INFO - 'HOME': '/home/cltbld', 16:12:48 INFO - 'LANG': 'en_US.UTF-8', 16:12:48 INFO - 'LANGUAGE': 'en_US:en', 16:12:48 INFO - 'LOGNAME': 'cltbld', 16:12:48 INFO - 'MAIL': '/var/mail/cltbld', 16:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:48 INFO - 'MOZ_NO_REMOTE': '1', 16:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:48 INFO - 'NO_EM_RESTART': '1', 16:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:48 INFO - 'PWD': '/builds/slave/test', 16:12:48 INFO - 'SHELL': '/bin/bash', 16:12:48 INFO - 'SHLVL': '1', 16:12:48 INFO - 'TERM': 'linux', 16:12:48 INFO - 'TMOUT': '86400', 16:12:48 INFO - 'USER': 'cltbld', 16:12:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:48 INFO - '_': '/tools/buildbot/bin/python'} 16:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:48 INFO - Running setup.py (path:/tmp/pip-AnFJK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:48 INFO - Running setup.py (path:/tmp/pip-2DwD5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:48 INFO - Running setup.py (path:/tmp/pip-nrEWQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:48 INFO - Running setup.py (path:/tmp/pip-XC3rhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:48 INFO - Running setup.py (path:/tmp/pip-AHm3Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:48 INFO - Running setup.py (path:/tmp/pip-WSfFg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:48 INFO - Running setup.py (path:/tmp/pip-ZM9IAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:48 INFO - Running setup.py (path:/tmp/pip-uYtos6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:48 INFO - Running setup.py (path:/tmp/pip-LYglPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:48 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)) 16:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:49 INFO - Running setup.py (path:/tmp/pip-1YQNzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:49 INFO - Running setup.py (path:/tmp/pip-V1_EXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:49 INFO - Running setup.py (path:/tmp/pip-QXNO3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:49 INFO - Running setup.py (path:/tmp/pip-ab_9iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:49 INFO - Running setup.py (path:/tmp/pip-Br1456-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:49 INFO - Running setup.py (path:/tmp/pip-pG3rVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:49 INFO - Running setup.py (path:/tmp/pip-IZdGOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:49 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)) 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:49 INFO - Running setup.py (path:/tmp/pip-Egyh5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:49 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)) 16:12:49 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)) 16:12:49 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)) 16:12:49 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)) 16:12:49 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)) 16:12:49 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)) 16:12:49 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)) 16:12:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:50 INFO - Downloading blessings-1.6.tar.gz 16:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:50 INFO - Installing collected packages: blessings 16:12:50 INFO - Running setup.py install for blessings 16:12:50 INFO - Successfully installed blessings 16:12:50 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:51 INFO - Reading from file tmpfile_stdout 16:12:51 INFO - Current package versions: 16:12:51 INFO - argparse == 1.2.1 16:12:51 INFO - blessings == 1.6 16:12:51 INFO - blobuploader == 1.2.4 16:12:51 INFO - docopt == 0.6.1 16:12:51 INFO - functools32 == 3.2.3-2 16:12:51 INFO - jsonschema == 2.5.1 16:12:51 INFO - manifestparser == 1.1 16:12:51 INFO - mozInstall == 1.13 16:12:51 INFO - mozcrash == 1.0 16:12:51 INFO - mozdebug == 0.1 16:12:51 INFO - mozdevice == 0.51 16:12:51 INFO - mozfile == 1.2 16:12:51 INFO - mozhttpd == 0.7 16:12:51 INFO - mozinfo == 0.10 16:12:51 INFO - mozleak == 0.1 16:12:51 INFO - mozlog == 3.5 16:12:51 INFO - moznetwork == 0.27 16:12:51 INFO - mozprocess == 0.25 16:12:51 INFO - mozprofile == 0.28 16:12:51 INFO - mozrunner == 6.13 16:12:51 INFO - mozscreenshot == 0.1 16:12:51 INFO - mozsystemmonitor == 0.3 16:12:51 INFO - moztest == 0.8 16:12:51 INFO - mozversion == 1.4 16:12:51 INFO - psutil == 3.1.1 16:12:51 INFO - requests == 1.2.3 16:12:51 INFO - wsgiref == 0.1.2 16:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:51 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:51 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 16:12:51 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 16:12:51 INFO - Using env: {'DISPLAY': ':0', 16:12:51 INFO - 'HOME': '/home/cltbld', 16:12:51 INFO - 'LANG': 'en_US.UTF-8', 16:12:51 INFO - 'LANGUAGE': 'en_US:en', 16:12:51 INFO - 'LOGNAME': 'cltbld', 16:12:51 INFO - 'MAIL': '/var/mail/cltbld', 16:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:51 INFO - 'MOZ_NO_REMOTE': '1', 16:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:51 INFO - 'NO_EM_RESTART': '1', 16:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:51 INFO - 'PWD': '/builds/slave/test', 16:12:51 INFO - 'SHELL': '/bin/bash', 16:12:51 INFO - 'SHLVL': '1', 16:12:51 INFO - 'TERM': 'linux', 16:12:51 INFO - 'TMOUT': '86400', 16:12:51 INFO - 'USER': 'cltbld', 16:12:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:51 INFO - '_': '/tools/buildbot/bin/python'} 16:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 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)) 16:12:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:12:52 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)) 16:12:52 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)) 16:12:52 INFO - Installing collected packages: simplejson 16:12:52 INFO - Running setup.py install for simplejson 16:12:52 INFO - building 'simplejson._speedups' extension 16:12:52 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 16:12:53 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 16:12:53 INFO - Successfully installed simplejson 16:12:53 INFO - Cleaning up... 16:12:53 INFO - Return code: 0 16:12:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:53 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')]} 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:53 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')]} 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:53 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 0x11681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1334a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, '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': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', '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 16:12:53 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 16:12:53 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 16:12:53 INFO - Using env: {'DISPLAY': ':0', 16:12:53 INFO - 'HOME': '/home/cltbld', 16:12:53 INFO - 'LANG': 'en_US.UTF-8', 16:12:53 INFO - 'LANGUAGE': 'en_US:en', 16:12:53 INFO - 'LOGNAME': 'cltbld', 16:12:53 INFO - 'MAIL': '/var/mail/cltbld', 16:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:53 INFO - 'MOZ_NO_REMOTE': '1', 16:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:53 INFO - 'NO_EM_RESTART': '1', 16:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:53 INFO - 'PWD': '/builds/slave/test', 16:12:53 INFO - 'SHELL': '/bin/bash', 16:12:53 INFO - 'SHLVL': '1', 16:12:53 INFO - 'TERM': 'linux', 16:12:53 INFO - 'TMOUT': '86400', 16:12:53 INFO - 'USER': 'cltbld', 16:12:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:53 INFO - '_': '/tools/buildbot/bin/python'} 16:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:53 INFO - Cleaning up... 16:12:53 INFO - Return code: 0 16:12:53 INFO - Running post-action listener: _resource_record_post_action 16:12:53 INFO - Running post-action listener: _start_resource_monitoring 16:12:53 INFO - Starting resource monitoring. 16:12:53 INFO - [mozharness: 2017-08-07 23:12:53.855634Z] Finished create-virtualenv step (success) 16:12:53 INFO - [mozharness: 2017-08-07 23:12:53.856102Z] Running install step. 16:12:53 INFO - Running pre-action listener: _resource_record_pre_action 16:12:53 INFO - Running main action method: install 16:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:54 INFO - Reading from file tmpfile_stdout 16:12:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:54 INFO - Reading from file tmpfile_stdout 16:12:54 INFO - Output received: 16:12:54 INFO - Usage: mozinstall [options] installer 16:12:54 INFO - Options: 16:12:54 INFO - -h, --help show this help message and exit 16:12:54 INFO - -d DEST, --destination=DEST 16:12:54 INFO - Directory to install application into. [default: 16:12:54 INFO - "/builds/slave/test"] 16:12:54 INFO - --app=APP Application being installed. [default: firefox] 16:12:54 INFO - mkdir: /builds/slave/test/build/application 16:12:54 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'] 16:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:13:12 INFO - Reading from file tmpfile_stdout 16:13:12 INFO - Output received: 16:13:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:12 INFO - Running post-action listener: _resource_record_post_action 16:13:12 INFO - [mozharness: 2017-08-07 23:13:12.174607Z] Finished install step (success) 16:13:12 INFO - [mozharness: 2017-08-07 23:13:12.174974Z] Running setup-mitmproxy step. 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running main action method: setup_mitmproxy 16:13:12 INFO - Skipping: mitmproxy is not required 16:13:12 INFO - Running post-action listener: _resource_record_post_action 16:13:12 INFO - [mozharness: 2017-08-07 23:13:12.176125Z] Finished setup-mitmproxy step (success) 16:13:12 INFO - [mozharness: 2017-08-07 23:13:12.176345Z] Running run-tests step. 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running pre-action listener: _set_gcov_prefix 16:13:12 INFO - Running main action method: run_tests 16:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:12 INFO - Python 2.7.3 16:13:12 INFO - Return code: 0 16:13:12 INFO - grabbing minidump binary from tooltool 16:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d4eb0>, '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 0x14d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d6240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:13:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:13:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:13:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:12 INFO - Return code: 0 16:13:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:12 INFO - ENV: RUST_BACKTRACE is now 1 16:13:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:12 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/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:13:12 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/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 16:13:12 INFO - Using env: {'DISPLAY': ':0', 16:13:12 INFO - 'HOME': '/home/cltbld', 16:13:12 INFO - 'LANG': 'en_US.UTF-8', 16:13:12 INFO - 'LANGUAGE': 'en_US:en', 16:13:12 INFO - 'LOGNAME': 'cltbld', 16:13:12 INFO - 'MAIL': '/var/mail/cltbld', 16:13:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:12 INFO - 'MOZ_NO_REMOTE': '1', 16:13:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:12 INFO - 'NO_EM_RESTART': '1', 16:13:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:12 INFO - 'PWD': '/builds/slave/test', 16:13:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:12 INFO - 'RUST_BACKTRACE': '1', 16:13:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:13:12 INFO - 'SHELL': '/bin/bash', 16:13:12 INFO - 'SHLVL': '1', 16:13:12 INFO - 'STYLO_FORCE_ENABLED': '1', 16:13:12 INFO - 'TERM': 'linux', 16:13:12 INFO - 'TMOUT': '86400', 16:13:12 INFO - 'USER': 'cltbld', 16:13:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502147521.885121-769476555', 16:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:12 INFO - '_': '/tools/buildbot/bin/python'} 16:13:12 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/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:13:12 INFO - mozversion application_buildid: 20170807222356 16:13:12 INFO - mozversion application_changeset: 65507616792c990b1230888612dd7ffc13ed32b4 16:13:12 INFO - mozversion application_display_name: Nightly 16:13:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:12 INFO - mozversion application_name: Firefox 16:13:12 INFO - mozversion application_remotingname: firefox 16:13:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:13:12 INFO - mozversion application_vendor: Mozilla 16:13:12 INFO - mozversion application_version: 57.0a1 16:13:12 INFO - mozversion platform_buildid: 20170807222356 16:13:12 INFO - mozversion platform_changeset: 65507616792c990b1230888612dd7ffc13ed32b4 16:13:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:13:12 INFO - mozversion platform_version: 57.0a1 16:13:12 INFO - using testdate: 1502147592 16:13:12 INFO - actual date: 1502147592 16:13:12 INFO - starting webserver on 'localhost:37821' 16:13:12 INFO - SUITE-START | Running 2 tests 16:13:12 INFO - TEST-START | dromaeo_css 16:13:12 INFO - Initialising browser for dromaeo_css test... 16:13:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37821/getInfo.html -profile /tmp/tmphzJGp7/profile 16:13:12 INFO - TEST-INFO | started process 8782 (/builds/slave/test/build/application/firefox/firefox http://localhost:37821/getInfo.html) 16:13:17 INFO - TEST-INFO | 8782: exit 0 16:13:17 INFO - Browser initialized. 16:13:17 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:17 INFO - TEST-INFO | started process 9007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphzJGp7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:19 INFO - PID 9007 | 16:13:19 INFO - PID 9007 | (/builds/slave/test/build/application/firefox/firefox:9061): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:13:19 INFO - PID 9007 | 16:13:29 INFO - PID 9007 | RSS: Main: 173821952 16:13:29 INFO - PID 9007 | 16:16:28 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37821/tests/dromaeo/cssquery-ext.html) 16:16:30 INFO - PID 9007 | RSS: Main: 176017408 16:16:30 INFO - PID 9007 | 16:19:32 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-ext.html (next: http://localhost:37821/tests/dromaeo/cssquery-jquery.html) 16:19:32 INFO - PID 9007 | RSS: Main: 173109248 16:19:32 INFO - PID 9007 | 16:22:34 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37821/tests/dromaeo/cssquery-mootools.html) 16:22:35 INFO - PID 9007 | RSS: Main: 175529984 16:22:35 INFO - PID 9007 | 16:25:37 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37821/tests/dromaeo/cssquery-prototype.html) 16:25:37 INFO - PID 9007 | RSS: Main: 171368448 16:25:37 INFO - PID 9007 | 16:28:41 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37821/tests/dromaeo/cssquery-yui.html) 16:28:41 INFO - PID 9007 | RSS: Main: 177143808 16:28:41 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-yui.html (next: http://localhost:37821/tests/dromaeo/cssquery-dojo.html) 16:31:43 INFO - PID 9007 | RSS: Main: 177483776 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | __start_tp_report 16:31:43 INFO - PID 9007 | _x_x_mozilla_page_load 16:31:43 INFO - PID 9007 | _x_x_mozilla_page_load_details 16:31:43 INFO - PID 9007 | |i|pagename|runs| 16:31:43 INFO - PID 9007 | |0;dojo.html;3155.605549306337;3157.4474466968277;3177.682231776821;3188.3463889902564;3238.2875767331193;6180.0420934755075;6300.621962682242;6330.177076979998;6338.397852204039;6377.13908622337;6173;6242.750289988407;6259.530535209866;6275.152854364671;6289.433950944414;5693.857653558653;5749.993751093573;5776.711164441782;5776.884462310752;5778.508826749731;5799.159121927318;5799.478046975772;5804.129380592903;5805.912911306334;5807.332156801979;5765.481106700396;5766.625169363999;5789.131630255453;5801.622894511865;5809.099589563624;5699.74351154199;5774.797882074107;5776.537876969833;5789.478946894778;5795.391483894173;5609.214709940612;5655.688937108457;5695.943040569583;5762.884742305172;5766.365699773021;6006.669633170174;6102.96948515259;6104.20645316106;6134.447899689005;6144.293406258293;6040.038202268021;6687.765928192539;6697.665116744143;6729.05793188954;6807.659617019179;6803.523753337268;6816.079829223041;6816.625085620289;6890.965545172292;6912.170539535288;6266.530010249204;6272.435480806749;6337.809865703944;6339.587926784837;6357.268914074894;6964.164300283897;6965.686544105527;6992.650367481606;6999.09011828459;6999.335063168991;6588.044733513614;6633.7346506140175;6668.433183179387;6676.632785196861;6681.866362672719;6670;6684.732610695615;6759.729610815512;6767.35710107539;6786.660666966632;6582.17722784652;6630.602163870183;6681.966590167018;6690.765823196165;6789.456843452512;6660.833479162963;6707.731690732414;6712.060311556386;6725.9663701681175;6738.797836064926;5355.973220133875;5356.464353564613;5408.107662235766;5422.91865622016;5451.318585176853;4709.67032307742;4710;4737.502562230985;4739.644526660514;4758.214894542361;5869.6771677558145;5875.148103524965;5944.4352786485215;5946.494547963385;5957.880842383128;6666.633335166613;6800.897986530206;6814.863702725917;6882.965585172042;6891.448684105259;5821.330546987151;5830.2420685310635;5841.328247251536;5842.532597392198;5846.883062338729;5871.500922421642;5883.646981181143;5900.0264956281735;5903.468687818031;5907.409259074144;6487;6504.05691174777;6511.8697626047215;6520.771772987922;6520.902186467207;6683.2648408675;6719.899201511884;6729.528932974645;6815.318468153145;6821.079154314104;6508.511861610493;6519.7392104315295;6526.412622863965;6623.4038936495945;6626.734930602915;6480.189976252968;6628.038934354588;6628.105205797156;6736.225334086446;6741.258461569126;6790.151231096113;6852.0749698792015;6853.657317134223;6870.896936546056;6872.10662613857;6536.705848236746;6561.671916404065;6596.175478065242;6601.867962640817;6649.135612370555;6486.54594178403;6530.771423000362;6551.344865513411;6566.0479230512265;6632.83417914556;6400.445802195222;6430.5177111715875;6507.869842603216;6536.117624120683;6545.443637290884;6422.967885160544;6579.80260592183;6586.209654841449;6610.8016759497295;6646.268910419946;6367.713452894538;6378.6810659467765;6453.548251622341;6463.612183269019;6468.126802881739 16:31:43 INFO - PID 9007 | |1;ext.html;757.594686842539;774.3611520495592;795.9721409750658;819.5779173725529;827.0819390476572;43056.138877222475;43817.561824381744;43937.34093988593;44105.558944410586;44184.11631767363;40295.39556906649;40479;40666.18667626646;40766.388504172464;40970.59029409713;6903.482238832095;7008.19405768338;7058.7882363528915;7059.89410158848;7061.046758687563;7671;7885.093214280345;7893.842123157562;7896.763097107068;7912.367010639164;7896.170902055288;7919.287264146225;7922.366210703159;7931.682732690714;7977.202279772035;7739.303462688357;7954.363650907942;7982.840343193104;7984.441089123706;7987.321077708372;7776.222377762178;7863.724769633035;7866.7639970800965;7867.370610351215;7869.724559640443;38907.416388754194;39274.60725392738;39327.410088848694;39352.409713854315;39366.803165984275;3617.5478065241846;3634.691051260646;3638.745287829853;3647.1429214134655;3660.1764602964386;30990.535141972887;31368;31427.84286078578;31463.685363146305;31497.05508834716;4985.401751789772;5127.871803204913;5174.534291913746;5235.110031294689;5285.418603953562;180885;181130;183027.08486457614;183196;183642;48800;48881.511184888404;49014.264786027525;49074;49178.75410622996;51276.23085653718;51330.74334628303;51382.74308628433;51613;51730.74134629303;16832.579185520215;16918.915405422893;16923.830761692225;16987;16990.49028529146;13934.930325348309;13962.092463990011;13967.301634918213;13970.790438143436;13976.790348144787;14481;14664.780028299583;14751.852481475047;14818.184999825113;14916.254187290591;5690.943090569124;5717.113847353667;5802.274715660543;5929.584929054925;5979.820605381846;1013.4932533733133;1029.5367084811714;1040.380973320873;1042.3276986343765;1052.1004541117388;22998.425039373815;23617.645735313985;23906.880465597562;29528.557071643943;30339.393212136074;1113.4599719136213;1115.8437818705388;1119.2165484160957;1124.7244425115898;1137.971550711239;12666.620001399788;16139.273732682057;16600.754943379296;16634.75047874283;16841.9894806312;236656;238849;238974;239192;239453;56015.439845601024;59006.11490827641;59161;60613.696931515944;60702;1492.8880333974996;1506.6082818467278;1515.2348064227494;1521.1709618258076;1525.7024880148265;27456.725432745417;27837.16488505348;28121.859390702917;28135.859320703265;28189.43621127525;39087.6091239084;39563.40654890236;39606.80196599114;39637.60362396455;39706.60293397029;201772;202271;202965;203179;203557;36046.639533605376;36164.45753313755;36321.81839090788;36351;36680.266394671424;42690.78654606832;45321.54678453173;45353.77323113364;45484;45583.54416455793;32359.676403235666;32767.508487373187;32898;33238.66761332453;33460.33079338351;30872.84563577168;31722.841385792923;32254.19364515906;32406.67593324131;33005.33989320248;35604.64395356013;35842.64157358497;35864.28271434609;35960.82019589885;36163.81918090498;31657.683423165472;31790;31822;32016.679833202303;32339.676603233667;23134.884325578936;23584.505319494052;23889.761102388755;24280.63579046351;24350.26949191527 16:31:43 INFO - PID 9007 | |2;jquery.html;571.5085026876885;582.5514353947464;584.6024703201824;589.9587028907976;601.1103566721252;22154.88922555387;22571.661425078597;23032.999999999978;23063.192788252414;23152.76847231527;26240;26615.467690646175;26822.329441763966;27041.594376084326;27042.864785676094;6497.122888410063;6695;6697.5981441113445;6698.665066746667;6714.899276510856;6240.750369985218;6254.46837018854;6345.270293916189;6354.523410744189;6576.243731970837;6463.095166676669;6485.4811615070685;6487.93512064878;6511.869762604745;6517.250516190651;6472.773452929125;6483;6505.479561635081;6508.02379643055;6508.64202468864;6057.575969682124;6080;6080.179175811253;6085.847853803691;6098.512119030467;30154.547681784792;30370.84814575935;30678;31004.069877903697;31172.220694482592;1934.9903250483799;1980.6236815005102;1982.8017198280202;1983.6925276582153;1992.14337834731;19955.50111247216;20557;20569.69145462819;20588;20644.38066857997;2409.8674572898485;2454.9754502454925;2508.6613307203475;2521.4957008598353;2526.166365099531;142911;143513.99999999895;145408;146656.2667186668;146866;13906.860931390758;14718.558443246506;15101.47144849925;15311.540653780405;15443.382264709511;24090.879545602158;24125;24135.75864241335;24158.39604009914;24167.15414960503;10493.422861742678;10718.571257149782;10758.73103172427;10763.408012559385;10884.564617415374;9836;9903.653372131941;9943.552540135712;9945.502724863727;10079.143272821892;8972.596233169523;9069.555917600328;9264.490453025013;9267.490288034223;9511.619535218513;2663.4732929172046;2730.2218867622632;2769.9584506232422;2772.695003549608;2816.4648716743754;955.4267439536222;984.4437892590663;984.9458279794537;994.532569692258;998.3111652959435;19640.410787676392;20305.49236269105;20435.657771488764;20605.587888242153;20673.689894651292;1046.8115739166872;1048.2557384257111;1073.2326386633595;1074.1728868771158;1079.1312993040679;11175.888241117647;11348.829767553494;11530.654080377602;11611.013063889495;13311;523831;531664;545491;550151;555474;120734;120877;123456.38271808763;123848;124449;1271.675722690708;1297.5912587534897;1303.5307289375817;1308.3458270864567;1311.3639884655934;21485.6777148346;21491.89254053782;21623.567528649026;21726.565468690853;21756.673649894947;58416.707916460145;59359.1096133567;60938.390616093275;61266.38733612607;61477;69571;69966;70438.64780676064;70482;70993;14928.552143435714;15179.316930738365;15389.538313850602;15454.690906182039;15579.76630350523;23950.640740389255;24139;24253;24565;24585.631215531423;18657.440276791716;19055.618887622448;19127.713084304025;19204.903975480032;19227.51931201731;15208.847911520743;15820.68358632798;16113.758293625371;17430.73853892218;17443.476695699148;19071;19263.133159008157;19313.324033658755;19659.70510442316;19671.80328196757;15042.473513426978;15072.171030592985;15123.470678526199;15159.166245856142;15219.391224350902;18548.25806967706;18660.906695466434;18728.53178670544;18929.33747318837;18961.43115706531 16:31:43 INFO - PID 9007 | |3;mootools.html;1339.6316013096398;1348.811166436699;1379.2827729580617;1389.076264284251;1395.8045873577698;13875.930620346897;14282.500112496065;14544.272786360692;14586.270686465661;14600.78098828517;14714.63213419665;14957.10257384555;14959.252037398113;14964;14982.175980321077;2714.6199532065525;2768.9169324920285;2769;2769.0585201031645;2770.34896799253;2541.9745802542016;2639.5248855206055;2714.5249581323287;2720.197541725186;2720.659917510311;2726.795490338223;2768.6123942648046;2789.986050069757;2798.258461507702;2807.887684492618;2694.986525067372;2712.32191952011;2728.181545536351;2732.9590056149173;2734.5624700048097;2587.2884956636885;2614.647022651937;2667.079857449177;2681.1286331942197;2682.342826007621;14150.504732334319;14173.078749881328;14231.146131232159;14242.786358204532;14274.571762847027;7658.502197357154;7967;7967.163447838009;7971.043474783005;8000;4873.756312184377;5121.257417674454;5231.529162375405;5254.343207099113;5265.973670131663;1808.7196484544916;1860.4697661166638;1871.0925201277369;1920.1743250402321;1932.690769476891;23432.76567234323;23559.29322120322;23791.643125353134;23857.64213536781;23925.880370598035;7080.256573059857;7150.570965742072;7301.525400848928;7426.665800039012;7427.702891884264;16087.276072576762;16108.677826443405;16122;16133.757993630104;16247.51257462278;7395.112586489656;7546.773596792105;7548.962255188689;7556.65995030225;7561.357284630758;6160.537959653044;6872.278410766898;6981.371676549135;7109;7365.594892280868;4790.4969978152485;4906.58294045003;5075.746212689424;5190.11767999441;5221.477852214824;1380.5444203412849;1422.1680317014454;1440.7694768836936;1455.978160327596;1469.2873956131268;856.4604299291407;874.7900503879023;888.3293113699245;896.9416987895765;899.8515244984635;7777.222277772177;8173.632186551619;8254.380921430917;8297.58512074394;8308;955.1451450951498;961.403929563661;985.5860538573817;996.4668902137322;1007.2948935745007;4502.684812063189;4665;4873;4939.802407903716;4947.752612369367;18770.436886893414;18790.81209187918;19102.808971910104;19408.4177474676;20155.899220503805;18676.43970680882;19044.143013564422;19226.134823932956;19229;19460.90269548643;10421;10490.737731556772;10711.83932241017;10720.678379648623;10913.399763012952;7999.400044996532;8058.113607503053;8094;8125.79685507867;8195.590220489072;16404.097774622034;16551.172441377643;17046.062466564457;17069.06120163403;17157.91421042887;16903.239354228845;17281.567960800578;17357.39249126325;17736.55658608545;17959.191836367132;11171.162162837982;11732.12009099304;11836.349000805038;11852.466639001093;11855.407229638311;12037.879621204027;12422.813657794959;13210.867891320964;13312.467501300227;13695.246761428218;11130.610428634958;11191.216614836883;11269.66191014271;11409.144314176636;11434.08527317796;10346.172306215636;10447.791044179226;10541.841872371768;10594.841077383691;10607.522661480407;9149.130832570896;9163.358564900393;9244;9255.35212535143;9311.906880931105;6997.265287144776;7005.859882802417;7081.185663648746;7111.3999350145805;7207.243239459781;7194.172670143001;7375.262473752582;7401.851962960818;7445.9627701861145;7487.625618719151 16:31:43 INFO - PID 9007 | |4;prototype.html;506.30636028640765;511.75435790820393;530.3317819547369;534.0573440343705;535.8606762241818;6233.812985610428;6285.245770507534;6320.841978950522;6336.366363363667;6340.556161068727;6100.450959413652;6169.4755945744555;6226.84432889178;6262.937370626292;6272.717727702253;5190.610704197182;5207.140821764414;5215.895682086375;5222.477752224766;5231.764570594313;4827.179379505475;4897.3878265216845;5113.565346945514;5157.30376399185;5162.780004598021;4902.828401005965;4939.25911113334;4965.379327584052;4970.453250142481;4991.155041626274;4893.608511319121;4940.677881395738;4943.184374578191;4960.851174464772;4968.850934471935;4225.767582782945;4303.268444364434;4360.738355698668;4367.934480982788;4490.932636010462;5931.347551769302;5987.43119403656;6020.922781640327;6052;6080.361562035967;5597.524210442118;5602.859928501779;5621.297337832771;5643.68959707216;5646.858828529279;6594.340565943416;6601.745668323003;6602.801915942529;6619.900701489481;6648.135742353512;4754.215554433515;4784.617230621542;4790.305405716152;4798.304245884327;4848.418189817209;6661.533692641517;6738.865222695518;6780.32196780318;6821.441959265325;6926.688299026556;4927.965127323302;5004.774785134678;5006.098902197639;5027.522385373383;5040.36995375578;5081.695098294114;5088.160453525127;5116.872078198;5137.357830271216;5147.6654017488745;5713.971430142906;5724.8282551523525;5740.799072032459;5762.827115186551;5773.6824474654295;6653.434458071119;6688.197416310074;6691.330866913269;6692.3976842083475;6703.597784132968;1783.2510345654855;1799.73004049391;1804.0979510244877;1807.5752198233404;1809.3848091648902;1179.9056075513938;1233.210745123122;1244.9066320026034;1245.3337464456654;1255.083788834138;5824.271966004249;5833.445822646841;5838.386969368155;5840.3575606683235;5851.32709738377;6816.318368163244;6819.829504262433;6829.760958366533;6832.521723479309;6867.965660171667;5864.501517370986;5865.120231965239;5872.324682661463;5886.293644762571;5896.292444906553;3612.548431446069;3619.7104231661406;3632.5822530408814;3646.08847788053;3654.3056819204267;6518.706658200393;6522.15212022434;6555.836573930686;6573.441257493071;6626.668666566652;6680.565763225375;6867.862642747117;6914.757983470555;6943.66021236727;6966.721331146799;6024.759009639565;6458.741650334028;6501.0898474213645;6571.342865713582;6573.375529324707;6679.632620205935;6739.764108256383;6768.796936091925;6783.4573234142135;6792.21889482696;6583.407493325623;6638.76764313266;6650.467962562887;6674.799756007327;6684.732610695518;6525.107718761506;6533.607983521004;6558.8360290993105;6575.769848055486;6613.404793568602;5039.168537191323;5042.319286896369;5052.216906379517;5059.3169922061525;5076.36545431821;6494.870102598016;6622.470202383702;6645.438321994424;6739.629320387229;6832.521723479507;6385.3295403983775;6405.231372235362;6507.446867016357;6524.412802847766;6546.8363290918105;6432.2602900667025;6482.776534526719;6506.551527690332;6509.544331896911;6547.607143571401;6299.275583307978;6302;6386.265579458422;6441.291457939717;6501.479881609365;6571.769988050395;6599.53803233769;6610.438112760469;6645.867082658223;6664.733410663519;6314.905276420765;6375.968120159369;6376.585521941059;6438.163038804925;6505.837354066186 16:31:43 INFO - PID 9007 | |5;yui.html;913.187263335631;915.3180880244219;923.6166990698861;929.3866048408051;942.4486675294952;18805.4358369249;19718;19785.802141978576;19794.406167814952;20341;21643.350699479;22641.09435622573;22717.54564908701;22815;22898.198563050297;964.4261664309741;980.7842274699555;981.7741919358516;982.8181786369545;988.7182153086371;965.1795973422605;1035.3425574760006;1046.1735229168946;1049.8057859296016;1054.562356622001;1111.9888801112006;1118.0775859915561;1118.211660779153;1118.2563595209176;1119.4906317625503;1089.0579648603941;1097.1880808201872;1098.5166526728253;1099.2634934593802;1099.6755956992627;804.5494523067101;806.105223202245;806.2743530822248;806.3428305930706;806.5563939833069;19606;20629.174833006662;20737.27419540309;20808;21106.155753769985;22021.779782202135;22147.446313842123;22615.095396184133;22625.88687056554;22795;16721.331146754113;17109.914450427794;17245.31018759248;17356.392526261647;17372.47882563525;3578.534790477221;3584.8207589620415;3605.8197090145386;3606.242689035306;3607.2965771674535;132050;133565;135017;137655.31172344173;138710.30644846812;16973.151342433077;17530.912345438446;18009.18958646864;18047.278108875762;18055.909720451313;30317.848410757804;31978.20054498656;31998.360032799214;32091.679083209336;32147.196320091716;7793.80515487106;8209.671613135408;8623.223909848144;8927.285817134614;9205.03347148553;4279;4314.352847072964;4363.912721745611;4379.255526560492;4385.912281754411;5048.16705243638;5157.484251574812;5169.896602067937;5190.24741412493;5191.870203244949;1057.1701214546545;1071.1698433713777;1079.9676009719722;1088.450332582041;1090.7055095124272;656.2354856592017;673.6934694713893;682.8258794007496;687.4294335701356;696.4532841719328;11385.316880987002;11985.820212696817;12290.569830055905;12598.622041338775;12627.747445051047;670.7216505150308;674.5986138247735;680.8706345794383;681.4480270980522;692.9757458488929;5299.2845965794895;5609.382967873531;5791.160281759121;6111.938880611226;6408.519361047846;110126;110286;113321.4333928325;115870;119919.4024179276;98022;99474;100848;102239.48880255551;103886.48056759819;83153.58423207967;84053.99999999878;84508.57745711232;87648.56175719081;87926.12073879308;12578.748425031265;12616.74766504683;12793.6031984008;12965.935170324088;13048.739025219633;37879.81060094682;37977.62022379741;38186.80906595449;38318.23363532769;38826.6117338823;46330.76834615805;46609.533904661876;47572.28641570448;47855.76072119617;48701.75649121732;18469.353572624892;18504;18538.721919170952;18558.628827423647;18668.533286667942;17633.647327053644;17788.288468461116;17827.554311142325;17862.821371786114;18147.909260453613;18859.151338190088;19067.713984290524;19142.23431062742;19208.231670733574;19427.222911083398;18491.35280265238;18819;18829.717554236973;18878.52803679919;19021.144048518127;18241.361552345603;18290.72563911569;18311.17599708043;18406.907965460086;18471.90764046225;11185.272957257752;11412.885871141183;11622.476988535705;11672.941635291769;11696.88303116992;13085.542006029744;13104.868951310365;13156.407961641558;13235.801462978256;13292 16:31:43 INFO - PID 9007 | __end_tp_report 16:31:43 INFO - PID 9007 | __start_cc_report 16:31:43 INFO - PID 9007 | _x_x_mozilla_cycle_collect,373 16:31:43 INFO - PID 9007 | __end_cc_report 16:31:43 INFO - PID 9007 | __startTimestamp1502148703858__endTimestamp 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | ------- Summary: start ------- 16:31:43 INFO - PID 9007 | Number of tests: 6 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#0] dojo.html Cycles:165 Average:6202.37 Median:6463.61 stddev:732.13 (11.3%) stddev-sans-first:694.26 16:31:43 INFO - PID 9007 | Values: 3155.6 3157.4 3177.7 3188.3 3238.3 6180.0 6300.6 6330.2 6338.4 6377.1 6173.0 6242.8 6259.5 6275.2 6289.4 5693.9 5750.0 5776.7 5776.9 5778.5 5799.2 5799.5 5804.1 5805.9 5807.3 5765.5 5766.6 5789.1 5801.6 5809.1 5699.7 5774.8 5776.5 5789.5 5795.4 5609.2 5655.7 5695.9 5762.9 5766.4 6006.7 6103.0 6104.2 6134.4 6144.3 6040.0 6687.8 6697.7 6729.1 6807.7 6803.5 6816.1 6816.6 6891.0 6912.2 6266.5 6272.4 6337.8 6339.6 6357.3 6964.2 6965.7 6992.7 6999.1 6999.3 6588.0 6633.7 6668.4 6676.6 6681.9 6670.0 6684.7 6759.7 6767.4 6786.7 6582.2 6630.6 6682.0 6690.8 6789.5 6660.8 6707.7 6712.1 6726.0 6738.8 5356.0 5356.5 5408.1 5422.9 5451.3 4709.7 4710.0 4737.5 4739.6 4758.2 5869.7 5875.1 5944.4 5946.5 5957.9 6666.6 6800.9 6814.9 6883.0 6891.4 5821.3 5830.2 5841.3 5842.5 5846.9 5871.5 5883.6 5900.0 5903.5 5907.4 6487.0 6504.1 6511.9 6520.8 6520.9 6683.3 6719.9 6729.5 6815.3 6821.1 6508.5 6519.7 6526.4 6623.4 6626.7 6480.2 6628.0 6628.1 6736.2 6741.3 6790.2 6852.1 6853.7 6870.9 6872.1 6536.7 6561.7 6596.2 6601.9 6649.1 6486.5 6530.8 6551.3 6566.0 6632.8 6400.4 6430.5 6507.9 6536.1 6545.4 6423.0 6579.8 6586.2 6610.8 6646.3 6367.7 6378.7 6453.5 6463.6 6468.1 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#1] ext.html Cycles:180 Average:38578.46 Median:36164.14 stddev:54171.72 (149.8%) stddev-sans-first:54249.25 16:31:43 INFO - PID 9007 | Values: 757.6 774.4 796.0 819.6 827.1 43056.1 43817.6 43937.3 44105.6 44184.1 40295.4 40479.0 40666.2 40766.4 40970.6 6903.5 7008.2 7058.8 7059.9 7061.0 7671.0 7885.1 7893.8 7896.8 7912.4 7896.2 7919.3 7922.4 7931.7 7977.2 7739.3 7954.4 7982.8 7984.4 7987.3 7776.2 7863.7 7866.8 7867.4 7869.7 38907.4 39274.6 39327.4 39352.4 39366.8 3617.5 3634.7 3638.7 3647.1 3660.2 30990.5 31368.0 31427.8 31463.7 31497.1 4985.4 5127.9 5174.5 5235.1 5285.4 180885.0 181130.0 183027.1 183196.0 183642.0 48800.0 48881.5 49014.3 49074.0 49178.8 51276.2 51330.7 51382.7 51613.0 51730.7 16832.6 16918.9 16923.8 16987.0 16990.5 13934.9 13962.1 13967.3 13970.8 13976.8 14481.0 14664.8 14751.9 14818.2 14916.3 5690.9 5717.1 5802.3 5929.6 5979.8 1013.5 1029.5 1040.4 1042.3 1052.1 22998.4 23617.6 23906.9 29528.6 30339.4 1113.5 1115.8 1119.2 1124.7 1138.0 12666.6 16139.3 16600.8 16634.8 16842.0 236656.0 238849.0 238974.0 239192.0 239453.0 56015.4 59006.1 59161.0 60613.7 60702.0 1492.9 1506.6 1515.2 1521.2 1525.7 27456.7 27837.2 28121.9 28135.9 28189.4 39087.6 39563.4 39606.8 39637.6 39706.6 201772.0 202271.0 202965.0 203179.0 203557.0 36046.6 36164.5 36321.8 36351.0 36680.3 42690.8 45321.5 45353.8 45484.0 45583.5 32359.7 32767.5 32898.0 33238.7 33460.3 30872.8 31722.8 32254.2 32406.7 33005.3 35604.6 35842.6 35864.3 35960.8 36163.8 31657.7 31790.0 31822.0 32016.7 32339.7 23134.9 23584.5 23889.8 24280.6 24350.3 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#2] jquery.html Cycles:180 Average:37071.30 Median:23551.70 stddev:90888.49 (385.9%) stddev-sans-first:91102.14 16:31:43 INFO - PID 9007 | Values: 571.5 582.6 584.6 590.0 601.1 22154.9 22571.7 23033.0 23063.2 23152.8 26240.0 26615.5 26822.3 27041.6 27042.9 6497.1 6695.0 6697.6 6698.7 6714.9 6240.8 6254.5 6345.3 6354.5 6576.2 6463.1 6485.5 6487.9 6511.9 6517.3 6472.8 6483.0 6505.5 6508.0 6508.6 6057.6 6080.0 6080.2 6085.8 6098.5 30154.5 30370.8 30678.0 31004.1 31172.2 1935.0 1980.6 1982.8 1983.7 1992.1 19955.5 20557.0 20569.7 20588.0 20644.4 2409.9 2455.0 2508.7 2521.5 2526.2 142911.0 143514.0 145408.0 146656.3 146866.0 13906.9 14718.6 15101.5 15311.5 15443.4 24090.9 24125.0 24135.8 24158.4 24167.2 10493.4 10718.6 10758.7 10763.4 10884.6 9836.0 9903.7 9943.6 9945.5 10079.1 8972.6 9069.6 9264.5 9267.5 9511.6 2663.5 2730.2 2770.0 2772.7 2816.5 955.4 984.4 984.9 994.5 998.3 19640.4 20305.5 20435.7 20605.6 20673.7 1046.8 1048.3 1073.2 1074.2 1079.1 11175.9 11348.8 11530.7 11611.0 13311.0 523831.0 531664.0 545491.0 550151.0 555474.0 120734.0 120877.0 123456.4 123848.0 124449.0 1271.7 1297.6 1303.5 1308.3 1311.4 21485.7 21491.9 21623.6 21726.6 21756.7 58416.7 59359.1 60938.4 61266.4 61477.0 69571.0 69966.0 70438.6 70482.0 70993.0 14928.6 15179.3 15389.5 15454.7 15579.8 23950.6 24139.0 24253.0 24565.0 24585.6 18657.4 19055.6 19127.7 19204.9 19227.5 15208.8 15820.7 16113.8 17430.7 17443.5 19071.0 19263.1 19313.3 19659.7 19671.8 15042.5 15072.2 15123.5 15159.2 15219.4 18548.3 18660.9 18728.5 18929.3 18961.4 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#3] mootools.html Cycles:180 Average:8826.16 Median:2674.10 stddev:6010.41 (224.8%) stddev-sans-first:6000.94 16:31:43 INFO - PID 9007 | Values: 1339.6 1348.8 1379.3 1389.1 1395.8 13875.9 14282.5 14544.3 14586.3 14600.8 14714.6 14957.1 14959.3 14964.0 14982.2 2714.6 2768.9 2769.0 2769.1 2770.3 2542.0 2639.5 2714.5 2720.2 2720.7 2726.8 2768.6 2790.0 2798.3 2807.9 2695.0 2712.3 2728.2 2733.0 2734.6 2587.3 2614.6 2667.1 2681.1 2682.3 14150.5 14173.1 14231.1 14242.8 14274.6 7658.5 7967.0 7967.2 7971.0 8000.0 4873.8 5121.3 5231.5 5254.3 5266.0 1808.7 1860.5 1871.1 1920.2 1932.7 23432.8 23559.3 23791.6 23857.6 23925.9 7080.3 7150.6 7301.5 7426.7 7427.7 16087.3 16108.7 16122.0 16133.8 16247.5 7395.1 7546.8 7549.0 7556.7 7561.4 6160.5 6872.3 6981.4 7109.0 7365.6 4790.5 4906.6 5075.7 5190.1 5221.5 1380.5 1422.2 1440.8 1456.0 1469.3 856.5 874.8 888.3 896.9 899.9 7777.2 8173.6 8254.4 8297.6 8308.0 955.1 961.4 985.6 996.5 1007.3 4502.7 4665.0 4873.0 4939.8 4947.8 18770.4 18790.8 19102.8 19408.4 20155.9 18676.4 19044.1 19226.1 19229.0 19460.9 10421.0 10490.7 10711.8 10720.7 10913.4 7999.4 8058.1 8094.0 8125.8 8195.6 16404.1 16551.2 17046.1 17069.1 17157.9 16903.2 17281.6 17357.4 17736.6 17959.2 11171.2 11732.1 11836.3 11852.5 11855.4 12037.9 12422.8 13210.9 13312.5 13695.2 11130.6 11191.2 11269.7 11409.1 11434.1 10346.2 10447.8 10541.8 10594.8 10607.5 9149.1 9163.4 9244.0 9255.4 9311.9 6997.3 7005.9 7081.2 7111.4 7207.2 7194.2 7375.3 7401.9 7446.0 7487.6 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#4] prototype.html Cycles:180 Average:5528.63 Median:6090.41 stddev:1544.84 (25.4%) stddev-sans-first:1502.48 16:31:43 INFO - PID 9007 | Values: 506.3 511.8 530.3 534.1 535.9 6233.8 6285.2 6320.8 6336.4 6340.6 6100.5 6169.5 6226.8 6262.9 6272.7 5190.6 5207.1 5215.9 5222.5 5231.8 4827.2 4897.4 5113.6 5157.3 5162.8 4902.8 4939.3 4965.4 4970.5 4991.2 4893.6 4940.7 4943.2 4960.9 4968.9 4225.8 4303.3 4360.7 4367.9 4490.9 5931.3 5987.4 6020.9 6052.0 6080.4 5597.5 5602.9 5621.3 5643.7 5646.9 6594.3 6601.7 6602.8 6619.9 6648.1 4754.2 4784.6 4790.3 4798.3 4848.4 6661.5 6738.9 6780.3 6821.4 6926.7 4928.0 5004.8 5006.1 5027.5 5040.4 5081.7 5088.2 5116.9 5137.4 5147.7 5714.0 5724.8 5740.8 5762.8 5773.7 6653.4 6688.2 6691.3 6692.4 6703.6 1783.3 1799.7 1804.1 1807.6 1809.4 1179.9 1233.2 1244.9 1245.3 1255.1 5824.3 5833.4 5838.4 5840.4 5851.3 6816.3 6819.8 6829.8 6832.5 6868.0 5864.5 5865.1 5872.3 5886.3 5896.3 3612.5 3619.7 3632.6 3646.1 3654.3 6518.7 6522.2 6555.8 6573.4 6626.7 6680.6 6867.9 6914.8 6943.7 6966.7 6024.8 6458.7 6501.1 6571.3 6573.4 6679.6 6739.8 6768.8 6783.5 6792.2 6583.4 6638.8 6650.5 6674.8 6684.7 6525.1 6533.6 6558.8 6575.8 6613.4 5039.2 5042.3 5052.2 5059.3 5076.4 6494.9 6622.5 6645.4 6739.6 6832.5 6385.3 6405.2 6507.4 6524.4 6546.8 6432.3 6482.8 6506.6 6509.5 6547.6 6299.3 6302.0 6386.3 6441.3 6501.5 6571.8 6599.5 6610.4 6645.9 6664.7 6314.9 6376.0 6376.6 6438.2 6505.8 16:31:43 INFO - PID 9007 | 16:31:43 INFO - PID 9007 | [#5] yui.html Cycles:180 Average:23649.83 Median:19790.10 stddev:32727.09 (165.4%) stddev-sans-first:32774.36 16:31:43 INFO - PID 9007 | Values: 913.2 915.3 923.6 929.4 942.4 18805.4 19718.0 19785.8 19794.4 20341.0 21643.4 22641.1 22717.5 22815.0 22898.2 964.4 980.8 981.8 982.8 988.7 965.2 1035.3 1046.2 1049.8 1054.6 1112.0 1118.1 1118.2 1118.3 1119.5 1089.1 1097.2 1098.5 1099.3 1099.7 804.5 806.1 806.3 806.3 806.6 19606.0 20629.2 20737.3 20808.0 21106.2 22021.8 22147.4 22615.1 22625.9 22795.0 16721.3 17109.9 17245.3 17356.4 17372.5 3578.5 3584.8 3605.8 3606.2 3607.3 132050.0 133565.0 135017.0 137655.3 138710.3 16973.2 17530.9 18009.2 18047.3 18055.9 30317.8 31978.2 31998.4 32091.7 32147.2 7793.8 8209.7 8623.2 8927.3 9205.0 4279.0 4314.4 4363.9 4379.3 4385.9 5048.2 5157.5 5169.9 5190.2 5191.9 1057.2 1071.2 1080.0 1088.5 1090.7 656.2 673.7 682.8 687.4 696.5 11385.3 11985.8 12290.6 12598.6 12627.7 670.7 674.6 680.9 681.4 693.0 5299.3 5609.4 5791.2 6111.9 6408.5 110126.0 110286.0 113321.4 115870.0 119919.4 98022.0 99474.0 100848.0 102239.5 103886.5 83153.6 84054.0 84508.6 87648.6 87926.1 12578.7 12616.7 12793.6 12965.9 13048.7 37879.8 37977.6 38186.8 38318.2 38826.6 46330.8 46609.5 47572.3 47855.8 48701.8 18469.4 18504.0 18538.7 18558.6 18668.5 17633.6 17788.3 17827.6 17862.8 18147.9 18859.2 19067.7 19142.2 19208.2 19427.2 18491.4 18819.0 18829.7 18878.5 19021.1 18241.4 18290.7 18311.2 18406.9 18471.9 11185.3 11412.9 11622.5 11672.9 11696.9 13085.5 13104.9 13156.4 13235.8 13292.0 16:31:43 INFO - PID 9007 | -------- Summary: end -------- 16:31:43 INFO - PID 9007 | 16:31:44 INFO - TEST-INFO | 9007: exit 0 16:31:44 INFO - TEST-OK | dromaeo_css | took 1111965ms 16:31:44 INFO - TEST-START | kraken 16:31:44 INFO - Initialising browser for kraken test... 16:31:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37821/getInfo.html -profile /tmp/tmp9EGgPy/profile 16:31:44 INFO - TEST-INFO | started process 9387 (/builds/slave/test/build/application/firefox/firefox http://localhost:37821/getInfo.html) 16:31:50 INFO - TEST-INFO | 9387: exit 0 16:31:50 INFO - Browser initialized. 16:31:50 INFO - Running cycle 1/1 for kraken test... 16:31:50 INFO - TEST-INFO | started process 9614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9EGgPy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:51 INFO - PID 9614 | 16:31:51 INFO - PID 9614 | (/builds/slave/test/build/application/firefox/firefox:9668): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:31:51 INFO - PID 9614 | 16:32:01 INFO - PID 9614 | RSS: Main: 174166016 16:32:01 INFO - PID 9614 | 16:32:04 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:05 INFO - PID 9614 | RSS: Main: 178479104 16:32:05 INFO - PID 9614 | 16:32:07 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-dft) 16:32:08 INFO - PID 9614 | RSS: Main: 178749440 16:32:08 INFO - PID 9614 | 16:32:11 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-fft) 16:32:12 INFO - PID 9614 | RSS: Main: 173457408 16:32:12 INFO - PID 9614 | 16:32:14 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-oscillator) 16:32:15 INFO - PID 9614 | RSS: Main: 174280704 16:32:15 INFO - PID 9614 | 16:32:17 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:18 INFO - PID 9614 | RSS: Main: 174346240 16:32:18 INFO - PID 9614 | 16:32:21 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:21 INFO - PID 9614 | RSS: Main: 176955392 16:32:21 INFO - PID 9614 | 16:32:25 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:26 INFO - PID 9614 | RSS: Main: 176238592 16:32:26 INFO - PID 9614 | 16:32:28 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37821/tests/kraken/driver.html?testName=json-parse-financial) 16:32:29 INFO - PID 9614 | RSS: Main: 177209344 16:32:29 INFO - PID 9614 | 16:32:31 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:31 INFO - PID 9614 | RSS: Main: 177487872 16:32:31 INFO - PID 9614 | 16:32:33 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:34 INFO - PID 9614 | RSS: Main: 175005696 16:32:34 INFO - PID 9614 | 16:32:36 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:37 INFO - PID 9614 | RSS: Main: 174891008 16:32:37 INFO - PID 9614 | 16:32:40 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:40 INFO - PID 9614 | RSS: Main: 175087616 16:32:40 INFO - PID 9614 | 16:32:44 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:44 INFO - PID 9614 | RSS: Main: 175165440 16:32:44 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37821/tests/kraken/driver.html?testName=ai-astar) 16:32:46 INFO - PID 9614 | RSS: Main: 176791552 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | __start_tp_report 16:32:46 INFO - PID 9614 | _x_x_mozilla_page_load 16:32:46 INFO - PID 9614 | _x_x_mozilla_page_load_details 16:32:46 INFO - PID 9614 | |i|pagename|runs| 16:32:46 INFO - PID 9614 | |0;ai-astar;100;109;100;113;111;115;109;104;108;108 16:32:46 INFO - PID 9614 | |1;audio-beat-detection;156;121;165;169;125;153;147;119;167;122 16:32:46 INFO - PID 9614 | |2;audio-dft;170;166;162;167;165;175;172;162;161;164 16:32:46 INFO - PID 9614 | |3;audio-fft;76;75;75;176;76;78;74;81;168;77 16:32:46 INFO - PID 9614 | |4;audio-oscillator;79;84;131;81;82;79;129;79;79;130 16:32:46 INFO - PID 9614 | |5;imaging-gaussian-blur;114;114;114;114;114;115;118;114;116;115 16:32:46 INFO - PID 9614 | |6;imaging-darkroom;150;151;152;153;152;150;151;153;154;150 16:32:46 INFO - PID 9614 | |7;imaging-desaturate;96;94;96;93;94;95;94;94;94;94 16:32:46 INFO - PID 9614 | |8;json-parse-financial;60;52;52;56;53;61;53;53;52;53 16:32:46 INFO - PID 9614 | |9;json-stringify-tinderbox;55;55;61;57;55;62;55;59;56;57 16:32:46 INFO - PID 9614 | |10;stanford-crypto-aes;77;88;78;90;87;89;86;90;89;90 16:32:46 INFO - PID 9614 | |11;stanford-crypto-ccm;128;130;133;142;133;140;134;126;123;172 16:32:46 INFO - PID 9614 | |12;stanford-crypto-pbkdf2;180;191;194;178;188;184;186;176;188;174 16:32:46 INFO - PID 9614 | |13;stanford-crypto-sha256-iterative;69;64;66;66;69;66;68;66;67;67 16:32:46 INFO - PID 9614 | __end_tp_report 16:32:46 INFO - PID 9614 | __start_cc_report 16:32:46 INFO - PID 9614 | _x_x_mozilla_cycle_collect,950 16:32:46 INFO - PID 9614 | __end_cc_report 16:32:46 INFO - PID 9614 | __startTimestamp1502148766722__endTimestamp 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | ------- Summary: start ------- 16:32:46 INFO - PID 9614 | Number of tests: 14 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:5.03 (4.6%) stddev-sans-first:4.50 16:32:46 INFO - PID 9614 | Values: 100.0 109.0 100.0 113.0 111.0 115.0 109.0 104.0 108.0 108.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:154.50 stddev:20.62 (13.3%) stddev-sans-first:21.44 16:32:46 INFO - PID 9614 | Values: 156.0 121.0 165.0 169.0 125.0 153.0 147.0 119.0 167.0 122.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:4.65 (2.8%) stddev-sans-first:4.74 16:32:46 INFO - PID 9614 | Values: 170.0 166.0 162.0 167.0 165.0 175.0 172.0 162.0 161.0 164.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:40.36 (53.1%) stddev-sans-first:42.18 16:32:46 INFO - PID 9614 | Values: 76.0 75.0 75.0 176.0 76.0 78.0 74.0 81.0 168.0 77.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.00 stddev:24.00 (30.4%) stddev-sans-first:24.73 16:32:46 INFO - PID 9614 | Values: 79.0 84.0 131.0 81.0 82.0 79.0 129.0 79.0 79.0 130.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.32 (1.1%) stddev-sans-first:1.36 16:32:46 INFO - PID 9614 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 118.0 114.0 116.0 115.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 16:32:46 INFO - PID 9614 | Values: 150.0 151.0 152.0 153.0 152.0 150.0 151.0 153.0 154.0 150.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:0.83 16:32:46 INFO - PID 9614 | Values: 96.0 94.0 96.0 93.0 94.0 95.0 94.0 94.0 94.0 94.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:53.00 stddev:3.37 (6.4%) stddev-sans-first:2.93 16:32:46 INFO - PID 9614 | Values: 60.0 52.0 52.0 56.0 53.0 61.0 53.0 53.0 52.0 53.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:2.62 (4.6%) stddev-sans-first:2.65 16:32:46 INFO - PID 9614 | Values: 55.0 55.0 61.0 57.0 55.0 62.0 55.0 59.0 56.0 57.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:89.00 stddev:4.88 (5.5%) stddev-sans-first:3.81 16:32:46 INFO - PID 9614 | Values: 77.0 88.0 78.0 90.0 87.0 89.0 86.0 90.0 89.0 90.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:133.50 stddev:13.90 (10.4%) stddev-sans-first:14.43 16:32:46 INFO - PID 9614 | Values: 128.0 130.0 133.0 142.0 133.0 140.0 134.0 126.0 123.0 172.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:187.00 stddev:6.67 (3.6%) stddev-sans-first:6.93 16:32:46 INFO - PID 9614 | Values: 180.0 191.0 194.0 178.0 188.0 184.0 186.0 176.0 188.0 174.0 16:32:46 INFO - PID 9614 | 16:32:46 INFO - PID 9614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.42 16:32:46 INFO - PID 9614 | Values: 69.0 64.0 66.0 66.0 69.0 66.0 68.0 66.0 67.0 67.0 16:32:46 INFO - PID 9614 | -------- Summary: end -------- 16:32:46 INFO - PID 9614 | 16:32:47 INFO - PID 9614 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:32:47 INFO - TEST-INFO | 9614: exit 0 16:32:47 INFO - TEST-OK | kraken | took 62904ms 16:32:47 INFO - SUITE-END | took 1174s 16:32:47 INFO - Completed test suite (00:19:35) 16:32:47 INFO - javascript benchmark 16:32:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8601.839655583224, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.605549306337, 3157.4474466968277, 3177.682231776821, 3188.3463889902564, 3238.2875767331193, 6180.0420934755075, 6300.621962682242, 6330.177076979998, 6338.397852204039, 6377.13908622337, 6173.0, 6242.750289988407, 6259.530535209866, 6275.152854364671, 6289.433950944414, 5693.857653558653, 5749.993751093573, 5776.711164441782, 5776.884462310752, 5778.508826749731, 5799.159121927318, 5799.478046975772, 5804.129380592903, 5805.912911306334, 5807.332156801979, 5765.481106700396, 5766.625169363999, 5789.131630255453, 5801.622894511865, 5809.099589563624, 5699.74351154199, 5774.797882074107, 5776.537876969833, 5789.478946894778, 5795.391483894173, 5609.214709940612, 5655.688937108457, 5695.943040569583, 5762.884742305172, 5766.365699773021, 6006.669633170174, 6102.96948515259, 6104.20645316106, 6134.447899689005, 6144.293406258293, 6040.038202268021, 6687.765928192539, 6697.665116744143, 6729.05793188954, 6807.659617019179, 6803.523753337268, 6816.079829223041, 6816.625085620289, 6890.965545172292, 6912.170539535288, 6266.530010249204, 6272.435480806749, 6337.809865703944, 6339.587926784837, 6357.268914074894, 6964.164300283897, 6965.686544105527, 6992.650367481606, 6999.09011828459, 6999.335063168991, 6588.044733513614, 6633.7346506140175, 6668.433183179387, 6676.632785196861, 6681.866362672719, 6670.0, 6684.732610695615, 6759.729610815512, 6767.35710107539, 6786.660666966632, 6582.17722784652, 6630.602163870183, 6681.966590167018, 6690.765823196165, 6789.456843452512, 6660.833479162963, 6707.731690732414, 6712.060311556386, 6725.9663701681175, 6738.797836064926, 5355.973220133875, 5356.464353564613, 5408.107662235766, 5422.91865622016, 5451.318585176853, 4709.67032307742, 4710.0, 4737.502562230985, 4739.644526660514, 4758.214894542361, 5869.6771677558145, 5875.148103524965, 5944.4352786485215, 5946.494547963385, 5957.880842383128, 6666.633335166613, 6800.897986530206, 6814.863702725917, 6882.965585172042, 6891.448684105259, 5821.330546987151, 5830.2420685310635, 5841.328247251536, 5842.532597392198, 5846.883062338729, 5871.500922421642, 5883.646981181143, 5900.0264956281735, 5903.468687818031, 5907.409259074144, 6487.0, 6504.05691174777, 6511.8697626047215, 6520.771772987922, 6520.902186467207, 6683.2648408675, 6719.899201511884, 6729.528932974645, 6815.318468153145, 6821.079154314104, 6508.511861610493, 6519.7392104315295, 6526.412622863965, 6623.4038936495945, 6626.734930602915, 6480.189976252968, 6628.038934354588, 6628.105205797156, 6736.225334086446, 6741.258461569126, 6790.151231096113, 6852.0749698792015, 6853.657317134223, 6870.896936546056, 6872.10662613857, 6536.705848236746, 6561.671916404065, 6596.175478065242, 6601.867962640817, 6649.135612370555, 6486.54594178403, 6530.771423000362, 6551.344865513411, 6566.0479230512265, 6632.83417914556, 6400.445802195222, 6430.5177111715875, 6507.869842603216, 6536.117624120683, 6545.443637290884, 6422.967885160544, 6579.80260592183, 6586.209654841449, 6610.8016759497295, 6646.268910419946, 6367.713452894538, 6378.6810659467765, 6453.548251622341, 6463.612183269019, 6468.126802881739], "value": 6147.667118014541, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.594686842539, 774.3611520495592, 795.9721409750658, 819.5779173725529, 827.0819390476572, 43056.138877222475, 43817.561824381744, 43937.34093988593, 44105.558944410586, 44184.11631767363, 40295.39556906649, 40479.0, 40666.18667626646, 40766.388504172464, 40970.59029409713, 6903.482238832095, 7008.19405768338, 7058.7882363528915, 7059.89410158848, 7061.046758687563, 7671.0, 7885.093214280345, 7893.842123157562, 7896.763097107068, 7912.367010639164, 7896.170902055288, 7919.287264146225, 7922.366210703159, 7931.682732690714, 7977.202279772035, 7739.303462688357, 7954.363650907942, 7982.840343193104, 7984.441089123706, 7987.321077708372, 7776.222377762178, 7863.724769633035, 7866.7639970800965, 7867.370610351215, 7869.724559640443, 38907.416388754194, 39274.60725392738, 39327.410088848694, 39352.409713854315, 39366.803165984275, 3617.5478065241846, 3634.691051260646, 3638.745287829853, 3647.1429214134655, 3660.1764602964386, 30990.535141972887, 31368.0, 31427.84286078578, 31463.685363146305, 31497.05508834716, 4985.401751789772, 5127.871803204913, 5174.534291913746, 5235.110031294689, 5285.418603953562, 180885.0, 181130.0, 183027.08486457614, 183196.0, 183642.0, 48800.0, 48881.511184888404, 49014.264786027525, 49074.0, 49178.75410622996, 51276.23085653718, 51330.74334628303, 51382.74308628433, 51613.0, 51730.74134629303, 16832.579185520215, 16918.915405422893, 16923.830761692225, 16987.0, 16990.49028529146, 13934.930325348309, 13962.092463990011, 13967.301634918213, 13970.790438143436, 13976.790348144787, 14481.0, 14664.780028299583, 14751.852481475047, 14818.184999825113, 14916.254187290591, 5690.943090569124, 5717.113847353667, 5802.274715660543, 5929.584929054925, 5979.820605381846, 1013.4932533733133, 1029.5367084811714, 1040.380973320873, 1042.3276986343765, 1052.1004541117388, 22998.425039373815, 23617.645735313985, 23906.880465597562, 29528.557071643943, 30339.393212136074, 1113.4599719136213, 1115.8437818705388, 1119.2165484160957, 1124.7244425115898, 1137.971550711239, 12666.620001399788, 16139.273732682057, 16600.754943379296, 16634.75047874283, 16841.9894806312, 236656.0, 238849.0, 238974.0, 239192.0, 239453.0, 56015.439845601024, 59006.11490827641, 59161.0, 60613.696931515944, 60702.0, 1492.8880333974996, 1506.6082818467278, 1515.2348064227494, 1521.1709618258076, 1525.7024880148265, 27456.725432745417, 27837.16488505348, 28121.859390702917, 28135.859320703265, 28189.43621127525, 39087.6091239084, 39563.40654890236, 39606.80196599114, 39637.60362396455, 39706.60293397029, 201772.0, 202271.0, 202965.0, 203179.0, 203557.0, 36046.639533605376, 36164.45753313755, 36321.81839090788, 36351.0, 36680.266394671424, 42690.78654606832, 45321.54678453173, 45353.77323113364, 45484.0, 45583.54416455793, 32359.676403235666, 32767.508487373187, 32898.0, 33238.66761332453, 33460.33079338351, 30872.84563577168, 31722.841385792923, 32254.19364515906, 32406.67593324131, 33005.33989320248, 35604.64395356013, 35842.64157358497, 35864.28271434609, 35960.82019589885, 36163.81918090498, 31657.683423165472, 31790.0, 31822.0, 32016.679833202303, 32339.676603233667, 23134.884325578936, 23584.505319494052, 23889.761102388755, 24280.63579046351, 24350.26949191527], "value": 17727.65112503679, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5085026876885, 582.5514353947464, 584.6024703201824, 589.9587028907976, 601.1103566721252, 22154.88922555387, 22571.661425078597, 23032.999999999978, 23063.192788252414, 23152.76847231527, 26240.0, 26615.467690646175, 26822.329441763966, 27041.594376084326, 27042.864785676094, 6497.122888410063, 6695.0, 6697.5981441113445, 6698.665066746667, 6714.899276510856, 6240.750369985218, 6254.46837018854, 6345.270293916189, 6354.523410744189, 6576.243731970837, 6463.095166676669, 6485.4811615070685, 6487.93512064878, 6511.869762604745, 6517.250516190651, 6472.773452929125, 6483.0, 6505.479561635081, 6508.02379643055, 6508.64202468864, 6057.575969682124, 6080.0, 6080.179175811253, 6085.847853803691, 6098.512119030467, 30154.547681784792, 30370.84814575935, 30678.0, 31004.069877903697, 31172.220694482592, 1934.9903250483799, 1980.6236815005102, 1982.8017198280202, 1983.6925276582153, 1992.14337834731, 19955.50111247216, 20557.0, 20569.69145462819, 20588.0, 20644.38066857997, 2409.8674572898485, 2454.9754502454925, 2508.6613307203475, 2521.4957008598353, 2526.166365099531, 142911.0, 143513.99999999895, 145408.0, 146656.2667186668, 146866.0, 13906.860931390758, 14718.558443246506, 15101.47144849925, 15311.540653780405, 15443.382264709511, 24090.879545602158, 24125.0, 24135.75864241335, 24158.39604009914, 24167.15414960503, 10493.422861742678, 10718.571257149782, 10758.73103172427, 10763.408012559385, 10884.564617415374, 9836.0, 9903.653372131941, 9943.552540135712, 9945.502724863727, 10079.143272821892, 8972.596233169523, 9069.555917600328, 9264.490453025013, 9267.490288034223, 9511.619535218513, 2663.4732929172046, 2730.2218867622632, 2769.9584506232422, 2772.695003549608, 2816.4648716743754, 955.4267439536222, 984.4437892590663, 984.9458279794537, 994.532569692258, 998.3111652959435, 19640.410787676392, 20305.49236269105, 20435.657771488764, 20605.587888242153, 20673.689894651292, 1046.8115739166872, 1048.2557384257111, 1073.2326386633595, 1074.1728868771158, 1079.1312993040679, 11175.888241117647, 11348.829767553494, 11530.654080377602, 11611.013063889495, 13311.0, 523831.0, 531664.0, 545491.0, 550151.0, 555474.0, 120734.0, 120877.0, 123456.38271808763, 123848.0, 124449.0, 1271.675722690708, 1297.5912587534897, 1303.5307289375817, 1308.3458270864567, 1311.3639884655934, 21485.6777148346, 21491.89254053782, 21623.567528649026, 21726.565468690853, 21756.673649894947, 58416.707916460145, 59359.1096133567, 60938.390616093275, 61266.38733612607, 61477.0, 69571.0, 69966.0, 70438.64780676064, 70482.0, 70993.0, 14928.552143435714, 15179.316930738365, 15389.538313850602, 15454.690906182039, 15579.76630350523, 23950.640740389255, 24139.0, 24253.0, 24565.0, 24585.631215531423, 18657.440276791716, 19055.618887622448, 19127.713084304025, 19204.903975480032, 19227.51931201731, 15208.847911520743, 15820.68358632798, 16113.758293625371, 17430.73853892218, 17443.476695699148, 19071.0, 19263.133159008157, 19313.324033658755, 19659.70510442316, 19671.80328196757, 15042.473513426978, 15072.171030592985, 15123.470678526199, 15159.166245856142, 15219.391224350902, 18548.25806967706, 18660.906695466434, 18728.53178670544, 18929.33747318837, 18961.43115706531], "value": 12375.144215300914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6316013096398, 1348.811166436699, 1379.2827729580617, 1389.076264284251, 1395.8045873577698, 13875.930620346897, 14282.500112496065, 14544.272786360692, 14586.270686465661, 14600.78098828517, 14714.63213419665, 14957.10257384555, 14959.252037398113, 14964.0, 14982.175980321077, 2714.6199532065525, 2768.9169324920285, 2769.0, 2769.0585201031645, 2770.34896799253, 2541.9745802542016, 2639.5248855206055, 2714.5249581323287, 2720.197541725186, 2720.659917510311, 2726.795490338223, 2768.6123942648046, 2789.986050069757, 2798.258461507702, 2807.887684492618, 2694.986525067372, 2712.32191952011, 2728.181545536351, 2732.9590056149173, 2734.5624700048097, 2587.2884956636885, 2614.647022651937, 2667.079857449177, 2681.1286331942197, 2682.342826007621, 14150.504732334319, 14173.078749881328, 14231.146131232159, 14242.786358204532, 14274.571762847027, 7658.502197357154, 7967.0, 7967.163447838009, 7971.043474783005, 8000.0, 4873.756312184377, 5121.257417674454, 5231.529162375405, 5254.343207099113, 5265.973670131663, 1808.7196484544916, 1860.4697661166638, 1871.0925201277369, 1920.1743250402321, 1932.690769476891, 23432.76567234323, 23559.29322120322, 23791.643125353134, 23857.64213536781, 23925.880370598035, 7080.256573059857, 7150.570965742072, 7301.525400848928, 7426.665800039012, 7427.702891884264, 16087.276072576762, 16108.677826443405, 16122.0, 16133.757993630104, 16247.51257462278, 7395.112586489656, 7546.773596792105, 7548.962255188689, 7556.65995030225, 7561.357284630758, 6160.537959653044, 6872.278410766898, 6981.371676549135, 7109.0, 7365.594892280868, 4790.4969978152485, 4906.58294045003, 5075.746212689424, 5190.11767999441, 5221.477852214824, 1380.5444203412849, 1422.1680317014454, 1440.7694768836936, 1455.978160327596, 1469.2873956131268, 856.4604299291407, 874.7900503879023, 888.3293113699245, 896.9416987895765, 899.8515244984635, 7777.222277772177, 8173.632186551619, 8254.380921430917, 8297.58512074394, 8308.0, 955.1451450951498, 961.403929563661, 985.5860538573817, 996.4668902137322, 1007.2948935745007, 4502.684812063189, 4665.0, 4873.0, 4939.802407903716, 4947.752612369367, 18770.436886893414, 18790.81209187918, 19102.808971910104, 19408.4177474676, 20155.899220503805, 18676.43970680882, 19044.143013564422, 19226.134823932956, 19229.0, 19460.90269548643, 10421.0, 10490.737731556772, 10711.83932241017, 10720.678379648623, 10913.399763012952, 7999.400044996532, 8058.113607503053, 8094.0, 8125.79685507867, 8195.590220489072, 16404.097774622034, 16551.172441377643, 17046.062466564457, 17069.06120163403, 17157.91421042887, 16903.239354228845, 17281.567960800578, 17357.39249126325, 17736.55658608545, 17959.191836367132, 11171.162162837982, 11732.12009099304, 11836.349000805038, 11852.466639001093, 11855.407229638311, 12037.879621204027, 12422.813657794959, 13210.867891320964, 13312.467501300227, 13695.246761428218, 11130.610428634958, 11191.216614836883, 11269.66191014271, 11409.144314176636, 11434.08527317796, 10346.172306215636, 10447.791044179226, 10541.841872371768, 10594.841077383691, 10607.522661480407, 9149.130832570896, 9163.358564900393, 9244.0, 9255.35212535143, 9311.906880931105, 6997.265287144776, 7005.859882802417, 7081.185663648746, 7111.3999350145805, 7207.243239459781, 7194.172670143001, 7375.262473752582, 7401.851962960818, 7445.9627701861145, 7487.625618719151], "value": 6443.681442644451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.30636028640765, 511.75435790820393, 530.3317819547369, 534.0573440343705, 535.8606762241818, 6233.812985610428, 6285.245770507534, 6320.841978950522, 6336.366363363667, 6340.556161068727, 6100.450959413652, 6169.4755945744555, 6226.84432889178, 6262.937370626292, 6272.717727702253, 5190.610704197182, 5207.140821764414, 5215.895682086375, 5222.477752224766, 5231.764570594313, 4827.179379505475, 4897.3878265216845, 5113.565346945514, 5157.30376399185, 5162.780004598021, 4902.828401005965, 4939.25911113334, 4965.379327584052, 4970.453250142481, 4991.155041626274, 4893.608511319121, 4940.677881395738, 4943.184374578191, 4960.851174464772, 4968.850934471935, 4225.767582782945, 4303.268444364434, 4360.738355698668, 4367.934480982788, 4490.932636010462, 5931.347551769302, 5987.43119403656, 6020.922781640327, 6052.0, 6080.361562035967, 5597.524210442118, 5602.859928501779, 5621.297337832771, 5643.68959707216, 5646.858828529279, 6594.340565943416, 6601.745668323003, 6602.801915942529, 6619.900701489481, 6648.135742353512, 4754.215554433515, 4784.617230621542, 4790.305405716152, 4798.304245884327, 4848.418189817209, 6661.533692641517, 6738.865222695518, 6780.32196780318, 6821.441959265325, 6926.688299026556, 4927.965127323302, 5004.774785134678, 5006.098902197639, 5027.522385373383, 5040.36995375578, 5081.695098294114, 5088.160453525127, 5116.872078198, 5137.357830271216, 5147.6654017488745, 5713.971430142906, 5724.8282551523525, 5740.799072032459, 5762.827115186551, 5773.6824474654295, 6653.434458071119, 6688.197416310074, 6691.330866913269, 6692.3976842083475, 6703.597784132968, 1783.2510345654855, 1799.73004049391, 1804.0979510244877, 1807.5752198233404, 1809.3848091648902, 1179.9056075513938, 1233.210745123122, 1244.9066320026034, 1245.3337464456654, 1255.083788834138, 5824.271966004249, 5833.445822646841, 5838.386969368155, 5840.3575606683235, 5851.32709738377, 6816.318368163244, 6819.829504262433, 6829.760958366533, 6832.521723479309, 6867.965660171667, 5864.501517370986, 5865.120231965239, 5872.324682661463, 5886.293644762571, 5896.292444906553, 3612.548431446069, 3619.7104231661406, 3632.5822530408814, 3646.08847788053, 3654.3056819204267, 6518.706658200393, 6522.15212022434, 6555.836573930686, 6573.441257493071, 6626.668666566652, 6680.565763225375, 6867.862642747117, 6914.757983470555, 6943.66021236727, 6966.721331146799, 6024.759009639565, 6458.741650334028, 6501.0898474213645, 6571.342865713582, 6573.375529324707, 6679.632620205935, 6739.764108256383, 6768.796936091925, 6783.4573234142135, 6792.21889482696, 6583.407493325623, 6638.76764313266, 6650.467962562887, 6674.799756007327, 6684.732610695518, 6525.107718761506, 6533.607983521004, 6558.8360290993105, 6575.769848055486, 6613.404793568602, 5039.168537191323, 5042.319286896369, 5052.216906379517, 5059.3169922061525, 5076.36545431821, 6494.870102598016, 6622.470202383702, 6645.438321994424, 6739.629320387229, 6832.521723479507, 6385.3295403983775, 6405.231372235362, 6507.446867016357, 6524.412802847766, 6546.8363290918105, 6432.2602900667025, 6482.776534526719, 6506.551527690332, 6509.544331896911, 6547.607143571401, 6299.275583307978, 6302.0, 6386.265579458422, 6441.291457939717, 6501.479881609365, 6571.769988050395, 6599.53803233769, 6610.438112760469, 6645.867082658223, 6664.733410663519, 6314.905276420765, 6375.968120159369, 6376.585521941059, 6438.163038804925, 6505.837354066186], "value": 5077.550505241342, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.187263335631, 915.3180880244219, 923.6166990698861, 929.3866048408051, 942.4486675294952, 18805.4358369249, 19718.0, 19785.802141978576, 19794.406167814952, 20341.0, 21643.350699479, 22641.09435622573, 22717.54564908701, 22815.0, 22898.198563050297, 964.4261664309741, 980.7842274699555, 981.7741919358516, 982.8181786369545, 988.7182153086371, 965.1795973422605, 1035.3425574760006, 1046.1735229168946, 1049.8057859296016, 1054.562356622001, 1111.9888801112006, 1118.0775859915561, 1118.211660779153, 1118.2563595209176, 1119.4906317625503, 1089.0579648603941, 1097.1880808201872, 1098.5166526728253, 1099.2634934593802, 1099.6755956992627, 804.5494523067101, 806.105223202245, 806.2743530822248, 806.3428305930706, 806.5563939833069, 19606.0, 20629.174833006662, 20737.27419540309, 20808.0, 21106.155753769985, 22021.779782202135, 22147.446313842123, 22615.095396184133, 22625.88687056554, 22795.0, 16721.331146754113, 17109.914450427794, 17245.31018759248, 17356.392526261647, 17372.47882563525, 3578.534790477221, 3584.8207589620415, 3605.8197090145386, 3606.242689035306, 3607.2965771674535, 132050.0, 133565.0, 135017.0, 137655.31172344173, 138710.30644846812, 16973.151342433077, 17530.912345438446, 18009.18958646864, 18047.278108875762, 18055.909720451313, 30317.848410757804, 31978.20054498656, 31998.360032799214, 32091.679083209336, 32147.196320091716, 7793.80515487106, 8209.671613135408, 8623.223909848144, 8927.285817134614, 9205.03347148553, 4279.0, 4314.352847072964, 4363.912721745611, 4379.255526560492, 4385.912281754411, 5048.16705243638, 5157.484251574812, 5169.896602067937, 5190.24741412493, 5191.870203244949, 1057.1701214546545, 1071.1698433713777, 1079.9676009719722, 1088.450332582041, 1090.7055095124272, 656.2354856592017, 673.6934694713893, 682.8258794007496, 687.4294335701356, 696.4532841719328, 11385.316880987002, 11985.820212696817, 12290.569830055905, 12598.622041338775, 12627.747445051047, 670.7216505150308, 674.5986138247735, 680.8706345794383, 681.4480270980522, 692.9757458488929, 5299.2845965794895, 5609.382967873531, 5791.160281759121, 6111.938880611226, 6408.519361047846, 110126.0, 110286.0, 113321.4333928325, 115870.0, 119919.4024179276, 98022.0, 99474.0, 100848.0, 102239.48880255551, 103886.48056759819, 83153.58423207967, 84053.99999999878, 84508.57745711232, 87648.56175719081, 87926.12073879308, 12578.748425031265, 12616.74766504683, 12793.6031984008, 12965.935170324088, 13048.739025219633, 37879.81060094682, 37977.62022379741, 38186.80906595449, 38318.23363532769, 38826.6117338823, 46330.76834615805, 46609.533904661876, 47572.28641570448, 47855.76072119617, 48701.75649121732, 18469.353572624892, 18504.0, 18538.721919170952, 18558.628827423647, 18668.533286667942, 17633.647327053644, 17788.288468461116, 17827.554311142325, 17862.821371786114, 18147.909260453613, 18859.151338190088, 19067.713984290524, 19142.23431062742, 19208.231670733574, 19427.222911083398, 18491.35280265238, 18819.0, 18829.717554236973, 18878.52803679919, 19021.144048518127, 18241.361552345603, 18290.72563911569, 18311.17599708043, 18406.907965460086, 18471.90764046225, 11185.272957257752, 11412.885871141183, 11622.476988535705, 11672.941635291769, 11696.88303116992, 13085.542006029744, 13104.868951310365, 13156.407961641558, 13235.801462978256, 13292.0], "value": 9179.528907232729, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 100.0, 113.0, 111.0, 115.0, 109.0, 104.0, 108.0, 108.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 165.0, 169.0, 125.0, 153.0, 147.0, 119.0, 167.0, 122.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 162.0, 167.0, 165.0, 175.0, 172.0, 162.0, 161.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 176.0, 76.0, 78.0, 74.0, 81.0, 168.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 131.0, 81.0, 82.0, 79.0, 129.0, 79.0, 79.0, 130.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 118.0, 114.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 153.0, 152.0, 150.0, 151.0, 153.0, 154.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 52.0, 52.0, 56.0, 53.0, 61.0, 53.0, 53.0, 52.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 61.0, 57.0, 55.0, 62.0, 55.0, 59.0, 56.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 88.0, 78.0, 90.0, 87.0, 89.0, 86.0, 90.0, 89.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 133.0, 142.0, 133.0, 140.0, 134.0, 126.0, 123.0, 172.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 191.0, 194.0, 178.0, 188.0, 184.0, 186.0, 176.0, 188.0, 174.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 66.0, 66.0, 69.0, 66.0, 68.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}]}]} 16:32:47 INFO - Return code: 0 16:32:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:48 INFO - # TBPL SUCCESS # 16:32:48 INFO - Running post-action listener: _package_coverage_data 16:32:48 INFO - Running post-action listener: _resource_record_post_action 16:32:48 INFO - [mozharness: 2017-08-07 23:32:48.017650Z] Finished run-tests step (success) 16:32:48 INFO - Running post-run listener: _resource_record_post_run 16:32:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439709696; Read time: 8; Write time: 345352 16:32:48 INFO - TinderboxPrint: CPU usage
13.2% 16:32:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:32:48 INFO - TinderboxPrint: I/O write bytes / time
439,709,696 / 345,352 16:32:48 INFO - TinderboxPrint: CPU idle
8,263.4 (86.8%) 16:32:48 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 16:32:48 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115851264; Read time: 0; Write time: 96604 16:32:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:32:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 323858432; Read time: 0; Write time: 248748 16:32:48 INFO - Running post-run listener: _upload_blobber_files 16:32:48 INFO - Blob upload gear active. 16:32:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:51 INFO - (blobuploader) - INFO - Done attempting. 16:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:58 INFO - (blobuploader) - INFO - Done attempting. 16:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:00 INFO - (blobuploader) - INFO - Done attempting. 16:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:01 INFO - (blobuploader) - INFO - Done attempting. 16:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:01 INFO - Return code: 0 16:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f05360a1c6e993248d740ce50c19d6c16b47ee396549aaa0eb8a3ae286d9ecf3a17b75181508dc20b17a91246c856228ef14ff80560c2c5d9b45fa60c2b9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f58e9ceeb9da67e2571ba0d37920e7f0b45e9af7e8e01df0f0c16212046dba514dbff9edff7e0c432ad7a25fc33fcc90d122ba1afdb660c02483d0c7aed0009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdb1ebbc29af435359aabd7d326f46bcd0306710575d8df1783bf9c7099a575073a0c9e1ec9ea85b08ddcede214cac158ee0ddd2b69d2162a96ea55f6ba9d37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630f59ceff3a4368f6bb4e869c7c09b4ae6fcde550d033efb3f6686f944a5627b17e04a34292485fefc97ea38af42b72fc97494fdcc62507cd8d511e10232944"} 16:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:01 INFO - Contents: 16:33:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f05360a1c6e993248d740ce50c19d6c16b47ee396549aaa0eb8a3ae286d9ecf3a17b75181508dc20b17a91246c856228ef14ff80560c2c5d9b45fa60c2b9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f58e9ceeb9da67e2571ba0d37920e7f0b45e9af7e8e01df0f0c16212046dba514dbff9edff7e0c432ad7a25fc33fcc90d122ba1afdb660c02483d0c7aed0009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdb1ebbc29af435359aabd7d326f46bcd0306710575d8df1783bf9c7099a575073a0c9e1ec9ea85b08ddcede214cac158ee0ddd2b69d2162a96ea55f6ba9d37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630f59ceff3a4368f6bb4e869c7c09b4ae6fcde550d033efb3f6686f944a5627b17e04a34292485fefc97ea38af42b72fc97494fdcc62507cd8d511e10232944"} 16:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:01 INFO - Copying logs to upload dir... 16:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.091037 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-07 16:33:01.457941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 16:33:01.461759) ========= 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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f05360a1c6e993248d740ce50c19d6c16b47ee396549aaa0eb8a3ae286d9ecf3a17b75181508dc20b17a91246c856228ef14ff80560c2c5d9b45fa60c2b9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f58e9ceeb9da67e2571ba0d37920e7f0b45e9af7e8e01df0f0c16212046dba514dbff9edff7e0c432ad7a25fc33fcc90d122ba1afdb660c02483d0c7aed0009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdb1ebbc29af435359aabd7d326f46bcd0306710575d8df1783bf9c7099a575073a0c9e1ec9ea85b08ddcede214cac158ee0ddd2b69d2162a96ea55f6ba9d37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630f59ceff3a4368f6bb4e869c7c09b4ae6fcde550d033efb3f6686f944a5627b17e04a34292485fefc97ea38af42b72fc97494fdcc62507cd8d511e10232944"} build_url:https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f05360a1c6e993248d740ce50c19d6c16b47ee396549aaa0eb8a3ae286d9ecf3a17b75181508dc20b17a91246c856228ef14ff80560c2c5d9b45fa60c2b9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f58e9ceeb9da67e2571ba0d37920e7f0b45e9af7e8e01df0f0c16212046dba514dbff9edff7e0c432ad7a25fc33fcc90d122ba1afdb660c02483d0c7aed0009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdb1ebbc29af435359aabd7d326f46bcd0306710575d8df1783bf9c7099a575073a0c9e1ec9ea85b08ddcede214cac158ee0ddd2b69d2162a96ea55f6ba9d37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630f59ceff3a4368f6bb4e869c7c09b4ae6fcde550d033efb3f6686f944a5627b17e04a34292485fefc97ea38af42b72fc97494fdcc62507cd8d511e10232944"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 16:33:01.486774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:33:01.487204) ========= 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=923d835db2ba3686ebe126b700000192-1502147521.885121-769476555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004360 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:33:01.569283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 16:33:01.569613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 16:33:01.569904) ========= ========= Total master_lag: 0.16 =========