builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1502147481.92 results: success (0) revision: 65507616792c990b1230888612dd7ffc13ed32b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:21.918470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:21.918920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:21.919215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:21.935104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:21.935372) ========= 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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 16:11:22-- 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% 42.6M=0s 2017-08-07 16:11:22 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:22.070051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:22.070372) ========= 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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019751 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:22.122944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 16:11:22.123302) ========= 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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 16:11:22,755 truncating revision to first 12 chars 2017-08-07 16:11:22,755 Setting DEBUG logging. 2017-08-07 16:11:22,755 attempt 1/10 2017-08-07 16:11:22,755 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:11:24,196 unpacking tar archive at: mozilla-central-65507616792c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 16:11:23.913269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:23.913633) ========= script_repo_revision: 65507616792c990b1230888612dd7ffc13ed32b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:23.914038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:23.914309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 16:11:23.924435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-08-07 16:11:23.924800) ========= /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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:24 INFO - MultiFileLogger online at 20170807 16:11:24 in /builds/slave/test 16:11:24 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:11:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:24 INFO - {'append_to_log': False, 16:11:24 INFO - 'base_work_dir': '/builds/slave/test', 16:11:24 INFO - 'blob_upload_branch': 'Firefox', 16:11:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:24 INFO - 'branch': 'Firefox', 16:11:24 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:24 INFO - 'code_coverage': False, 16:11:24 INFO - 'config_files': ('talos/linux_config.py',), 16:11:24 INFO - 'default_actions': ('clobber', 16:11:24 INFO - 'read-buildbot-config', 16:11:24 INFO - 'download-and-extract', 16:11:24 INFO - 'populate-webroot', 16:11:24 INFO - 'create-virtualenv', 16:11:24 INFO - 'install', 16:11:24 INFO - 'setup-mitmproxy', 16:11:24 INFO - 'run-tests'), 16:11:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:24 INFO - 'disable_ccov_upload': False, 16:11:24 INFO - 'download_minidump_stackwalk': True, 16:11:24 INFO - 'download_symbols': 'ondemand', 16:11:24 INFO - 'enable_stylo': False, 16:11:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:24 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:24 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:24 INFO - 'gecko_profile': False, 16:11:24 INFO - 'gecko_profile_interval': 0, 16:11:24 INFO - 'installer_path': 'installer.exe', 16:11:24 INFO - 'log_level': 'info', 16:11:24 INFO - 'log_name': 'talos', 16:11:24 INFO - 'log_to_console': True, 16:11:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:24 INFO - 'opt_config_files': (), 16:11:24 INFO - 'pip_index': False, 16:11:24 INFO - 'suite': 'dromaeojs-e10s', 16:11:24 INFO - 'system_bits': '32', 16:11:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:24 INFO - 'title': 'talos-linux64-ix-052', 16:11:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:24 INFO - 'use_talos_json': True, 16:11:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:24 INFO - 'work_dir': 'build'} 16:11:24 INFO - [mozharness: 2017-08-07 23:11:24.664908Z] Running clobber step. 16:11:24 INFO - Running pre-action listener: _resource_record_pre_action 16:11:24 INFO - Running main action method: clobber 16:11:24 INFO - rmtree: /builds/slave/test/build 16:11:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:25 INFO - Running post-action listener: _resource_record_post_action 16:11:25 INFO - [mozharness: 2017-08-07 23:11:25.709236Z] Finished clobber step (success) 16:11:25 INFO - [mozharness: 2017-08-07 23:11:25.709338Z] Running read-buildbot-config step. 16:11:25 INFO - Running pre-action listener: _resource_record_pre_action 16:11:25 INFO - Running main action method: read_buildbot_config 16:11:25 INFO - Using buildbot properties: 16:11:25 INFO - { 16:11:25 INFO - "project": "", 16:11:25 INFO - "product": "firefox", 16:11:25 INFO - "who": "kwierso@gmail.com", 16:11:25 INFO - "installer_path": "public/build/target.tar.bz2", 16:11:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:11:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:11:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:11:25 INFO - "stage_platform": "linux64-stylo", 16:11:25 INFO - "basedir": "/builds/slave/test", 16:11:25 INFO - "buildnumber": 18, 16:11:25 INFO - "platform": "ubuntu64_hw_stylo", 16:11:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:11:25 INFO - "slavebuilddir": "test", 16:11:25 INFO - "taskId": "RDyo_5hOSXq6DfDxRuKGQw", 16:11:25 INFO - "branch": "mozilla-central", 16:11:25 INFO - "script_repo_revision": "production", 16:11:25 INFO - "revision": "65507616792c990b1230888612dd7ffc13ed32b4", 16:11:25 INFO - "slavename": "talos-linux64-ix-052", 16:11:25 INFO - "repo_path": "mozilla-central" 16:11:25 INFO - } 16:11:25 INFO - Finding installer, test and symbols from parent task. 16:11:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDyo_5hOSXq6DfDxRuKGQw'}, attempt #1 16:11:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDyo_5hOSXq6DfDxRuKGQw'}, attempt #1 16:11:26 INFO - Task dependencies: YyZs7crNS8KmVZtD6qtlsg 16:11:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg'}, attempt #1 16:11:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:11:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json 16:11:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.crashreporter-symbols.zip 16:11:27 INFO - Running post-action listener: _resource_record_post_action 16:11:27 INFO - [mozharness: 2017-08-07 23:11:27.116034Z] Finished read-buildbot-config step (success) 16:11:27 INFO - [mozharness: 2017-08-07 23:11:27.116258Z] Running download-and-extract step. 16:11:27 INFO - Running pre-action listener: _resource_record_pre_action 16:11:27 INFO - Running main action method: download_and_extract 16:11:27 INFO - mkdir: /builds/slave/test/build/tests 16:11:27 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:11:27 INFO - trying https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.test_packages.json 16:11:27 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:11:27 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:11:27 INFO - Downloaded 989 bytes. 16:11:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:11:27 INFO - Using the following test package requirements: 16:11:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:11:27 INFO - u'common': [u'target.common.tests.zip'], 16:11:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:11:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:11:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:11:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:11:27 INFO - u'mozbase': [u'target.common.tests.zip'], 16:11:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:11:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:11:27 INFO - u'web-platform': [u'target.common.tests.zip', 16:11:27 INFO - u'target.web-platform.tests.tar.gz'], 16:11:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:11:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:11:27 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:11:27 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:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip into memory 16:11:28 INFO - Content-Length response header: 54284476 16:11:28 INFO - Bytes received: 54284476 16:11:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:11:39 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:11:39 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:11:39 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.common.tests.zip into memory 16:11:40 INFO - Content-Length response header: 54284476 16:11:40 INFO - Bytes received: 54284476 16:11:52 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:11:52 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:11:52 INFO - Fetch https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.talos.tests.zip into memory 16:11:53 INFO - Content-Length response header: 14496008 16:11:53 INFO - Bytes received: 14496008 16:11: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:11:53 INFO - trying https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:11:53 INFO - Downloading https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:11:53 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:11:54 INFO - Downloaded 61758064 bytes. 16:11:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:11:54 INFO - mkdir: /builds/slave/test/properties 16:11:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:54 INFO - Contents: 16:11:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 16:11:54 INFO - Running post-action listener: _resource_record_post_action 16:11:54 INFO - Running post-action listener: set_extra_try_arguments 16:11:54 INFO - [mozharness: 2017-08-07 23:11:54.734099Z] Finished download-and-extract step (success) 16:11:54 INFO - [mozharness: 2017-08-07 23:11:54.734197Z] Running populate-webroot step. 16:11:54 INFO - Running pre-action listener: _resource_record_pre_action 16:11:54 INFO - Running main action method: populate_webroot 16:11:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:11:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:11:54 INFO - 'tests': ['damp', 'tps']}, 16:11:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:11:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:11:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:11:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:54 INFO - 'ts_paint', 16:11:54 INFO - 'tpaint', 16:11:54 INFO - 'sessionrestore', 16:11:54 INFO - 'sessionrestore_many_windows', 16:11:54 INFO - 'sessionrestore_no_auto_restore', 16:11:54 INFO - 'tabpaint']}, 16:11:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:11:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:11:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:54 INFO - 'tsvgr_opacity', 16:11:54 INFO - 'tart', 16:11:54 INFO - 'tscrollx', 16:11:54 INFO - 'tsvg_static']}, 16:11:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:11:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:54 INFO - 'talos_options': ['--mitmproxy', 16:11:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:54 INFO - '--firstNonBlankPaint'], 16:11:54 INFO - 'tests': ['tp6_google', 16:11:54 INFO - 'tp6_youtube', 16:11:54 INFO - 'tp6_amazon', 16:11:54 INFO - 'tp6_facebook']}, 16:11:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:54 INFO - 'talos_options': ['--stylo', 16:11:54 INFO - '--mitmproxy', 16:11:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:54 INFO - '--firstNonBlankPaint'], 16:11:54 INFO - 'tests': ['tp6_google', 16:11:54 INFO - 'tp6_youtube', 16:11:54 INFO - 'tp6_amazon', 16:11:54 INFO - 'tp6_facebook']}, 16:11:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:11:54 INFO - 'talos_options': ['--stylo', 16:11:54 INFO - '--stylo-threads=1', 16:11:54 INFO - '--mitmproxy', 16:11:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:11:54 INFO - '--firstNonBlankPaint'], 16:11:54 INFO - 'tests': ['tp6_google', 16:11:54 INFO - 'tp6_youtube', 16:11:54 INFO - 'tp6_amazon', 16:11:54 INFO - 'tp6_facebook']}, 16:11:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:11:54 INFO - 'talos_options': ['--xperf_path', 16:11:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:54 INFO - 'tests': ['tp5n']}}} 16:11:54 INFO - Running post-action listener: _resource_record_post_action 16:11:54 INFO - [mozharness: 2017-08-07 23:11:54.742655Z] Finished populate-webroot step (success) 16:11:54 INFO - [mozharness: 2017-08-07 23:11:54.742746Z] Running create-virtualenv step. 16:11:54 INFO - Running pre-action listener: _resource_record_pre_action 16:11:54 INFO - Running main action method: create_virtualenv 16:11:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:54 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:11:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:11:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:54 INFO - Using real prefix '/usr' 16:11:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:57 INFO - Installing pip.................done. 16:11:57 INFO - Return code: 0 16:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:11:57 INFO - Reading from file tmpfile_stdout 16:11:57 INFO - Output received: 16:11:57 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:11:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:11:57 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:11:57 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:11:57 INFO - Using env: {'DISPLAY': ':0', 16:11:57 INFO - 'HOME': '/home/cltbld', 16:11:57 INFO - 'LANG': 'en_US.UTF-8', 16:11:57 INFO - 'LANGUAGE': 'en_US:en', 16:11:57 INFO - 'LOGNAME': 'cltbld', 16:11:57 INFO - 'MAIL': '/var/mail/cltbld', 16:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:57 INFO - 'MOZ_NO_REMOTE': '1', 16:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:57 INFO - 'NO_EM_RESTART': '1', 16:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:57 INFO - 'PWD': '/builds/slave/test', 16:11:57 INFO - 'SHELL': '/bin/bash', 16:11:57 INFO - 'SHLVL': '1', 16:11:57 INFO - 'TERM': 'linux', 16:11:57 INFO - 'TMOUT': '86400', 16:11:57 INFO - 'USER': 'cltbld', 16:11:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:57 INFO - '_': '/tools/buildbot/bin/python'} 16:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:57 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:11:57 INFO - Cleaning up... 16:11:57 INFO - Return code: 0 16:11:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:11:57 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:11:57 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:11:57 INFO - Using env: {'DISPLAY': ':0', 16:11:57 INFO - 'HOME': '/home/cltbld', 16:11:57 INFO - 'LANG': 'en_US.UTF-8', 16:11:57 INFO - 'LANGUAGE': 'en_US:en', 16:11:57 INFO - 'LOGNAME': 'cltbld', 16:11:57 INFO - 'MAIL': '/var/mail/cltbld', 16:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:57 INFO - 'MOZ_NO_REMOTE': '1', 16:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:57 INFO - 'NO_EM_RESTART': '1', 16:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:57 INFO - 'PWD': '/builds/slave/test', 16:11:57 INFO - 'SHELL': '/bin/bash', 16:11:57 INFO - 'SHLVL': '1', 16:11:57 INFO - 'TERM': 'linux', 16:11:57 INFO - 'TMOUT': '86400', 16:11:57 INFO - 'USER': 'cltbld', 16:11:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:57 INFO - '_': '/tools/buildbot/bin/python'} 16:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:57 INFO - Downloading/unpacking psutil>=3.1.1 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:59 INFO - Installing collected packages: psutil 16:11:59 INFO - Running setup.py install for psutil 16:11:59 INFO - building 'psutil._psutil_linux' extension 16:11:59 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:11:59 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:11:59 INFO - building 'psutil._psutil_posix' extension 16:11:59 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:11:59 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:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:59 INFO - Successfully installed psutil 16:11:59 INFO - Cleaning up... 16:11:59 INFO - Return code: 0 16:11:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:11:59 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:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:59 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:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:59 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:11:59 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:11:59 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:11:59 INFO - Using env: {'DISPLAY': ':0', 16:11:59 INFO - 'HOME': '/home/cltbld', 16:11:59 INFO - 'LANG': 'en_US.UTF-8', 16:11:59 INFO - 'LANGUAGE': 'en_US:en', 16:11:59 INFO - 'LOGNAME': 'cltbld', 16:11:59 INFO - 'MAIL': '/var/mail/cltbld', 16:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:59 INFO - 'MOZ_NO_REMOTE': '1', 16:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:59 INFO - 'NO_EM_RESTART': '1', 16:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:59 INFO - 'PWD': '/builds/slave/test', 16:11:59 INFO - 'SHELL': '/bin/bash', 16:11:59 INFO - 'SHLVL': '1', 16:11:59 INFO - 'TERM': 'linux', 16:11:59 INFO - 'TMOUT': '86400', 16:11:59 INFO - 'USER': 'cltbld', 16:11:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:59 INFO - '_': '/tools/buildbot/bin/python'} 16:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:59 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:11:59 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:11:59 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:11:59 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:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:01 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:01 INFO - Installing collected packages: mozsystemmonitor 16:12:01 INFO - Running setup.py install for mozsystemmonitor 16:12:01 INFO - Successfully installed mozsystemmonitor 16:12:01 INFO - Cleaning up... 16:12:01 INFO - Return code: 0 16:12:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:01 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 16:12:01 INFO - 'HOME': '/home/cltbld', 16:12:01 INFO - 'LANG': 'en_US.UTF-8', 16:12:01 INFO - 'LANGUAGE': 'en_US:en', 16:12:01 INFO - 'LOGNAME': 'cltbld', 16:12:01 INFO - 'MAIL': '/var/mail/cltbld', 16:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:01 INFO - 'MOZ_NO_REMOTE': '1', 16:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:01 INFO - 'NO_EM_RESTART': '1', 16:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:01 INFO - 'PWD': '/builds/slave/test', 16:12:01 INFO - 'SHELL': '/bin/bash', 16:12:01 INFO - 'SHLVL': '1', 16:12:01 INFO - 'TERM': 'linux', 16:12:01 INFO - 'TMOUT': '86400', 16:12:01 INFO - 'USER': 'cltbld', 16:12:01 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:01 INFO - '_': '/tools/buildbot/bin/python'} 16:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:01 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:01 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:01 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:01 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:01 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:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:02 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:02 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:02 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:02 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:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:02 INFO - warning: no files found matching '*.txt' 16:12:02 INFO - no previously-included directories found matching 'build' 16:12:02 INFO - no previously-included directories found matching 'dist' 16:12:02 INFO - no previously-included directories found matching '.git*' 16:12:02 INFO - Installing collected packages: jsonschema, functools32 16:12:02 INFO - Running setup.py install for functools32 16:12:03 INFO - warning: no files found matching '*.txt' 16:12:03 INFO - no previously-included directories found matching 'build' 16:12:03 INFO - no previously-included directories found matching 'dist' 16:12:03 INFO - no previously-included directories found matching '.git*' 16:12:03 INFO - Successfully installed jsonschema functools32 16:12:03 INFO - Cleaning up... 16:12:03 INFO - Return code: 0 16:12:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:03 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 16:12:03 INFO - 'HOME': '/home/cltbld', 16:12:03 INFO - 'LANG': 'en_US.UTF-8', 16:12:03 INFO - 'LANGUAGE': 'en_US:en', 16:12:03 INFO - 'LOGNAME': 'cltbld', 16:12:03 INFO - 'MAIL': '/var/mail/cltbld', 16:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:03 INFO - 'MOZ_NO_REMOTE': '1', 16:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:03 INFO - 'NO_EM_RESTART': '1', 16:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:03 INFO - 'PWD': '/builds/slave/test', 16:12:03 INFO - 'SHELL': '/bin/bash', 16:12:03 INFO - 'SHLVL': '1', 16:12:03 INFO - 'TERM': 'linux', 16:12:03 INFO - 'TMOUT': '86400', 16:12:03 INFO - 'USER': 'cltbld', 16:12:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:03 INFO - '_': '/tools/buildbot/bin/python'} 16:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:03 INFO - Cleaning up... 16:12:03 INFO - Return code: 0 16:12:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:03 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 16:12:03 INFO - 'HOME': '/home/cltbld', 16:12:03 INFO - 'LANG': 'en_US.UTF-8', 16:12:03 INFO - 'LANGUAGE': 'en_US:en', 16:12:03 INFO - 'LOGNAME': 'cltbld', 16:12:03 INFO - 'MAIL': '/var/mail/cltbld', 16:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:03 INFO - 'MOZ_NO_REMOTE': '1', 16:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:03 INFO - 'NO_EM_RESTART': '1', 16:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:03 INFO - 'PWD': '/builds/slave/test', 16:12:03 INFO - 'SHELL': '/bin/bash', 16:12:03 INFO - 'SHLVL': '1', 16:12:03 INFO - 'TERM': 'linux', 16:12:03 INFO - 'TMOUT': '86400', 16:12:03 INFO - 'USER': 'cltbld', 16:12:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:03 INFO - '_': '/tools/buildbot/bin/python'} 16:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:03 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:03 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:03 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:03 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:04 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:04 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:04 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:04 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:04 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:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:05 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:05 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:05 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:05 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:05 INFO - Downloading docopt-0.6.1.tar.gz 16:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:05 INFO - Running setup.py install for blobuploader 16:12:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:05 INFO - Running setup.py install for requests 16:12:05 INFO - Running setup.py install for docopt 16:12:06 INFO - Successfully installed blobuploader requests docopt 16:12:06 INFO - Cleaning up... 16:12:06 INFO - Return code: 0 16:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:06 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:06 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:06 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:06 INFO - Using env: {'DISPLAY': ':0', 16:12:06 INFO - 'HOME': '/home/cltbld', 16:12:06 INFO - 'LANG': 'en_US.UTF-8', 16:12:06 INFO - 'LANGUAGE': 'en_US:en', 16:12:06 INFO - 'LOGNAME': 'cltbld', 16:12:06 INFO - 'MAIL': '/var/mail/cltbld', 16:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:06 INFO - 'MOZ_NO_REMOTE': '1', 16:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:06 INFO - 'NO_EM_RESTART': '1', 16:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:06 INFO - 'PWD': '/builds/slave/test', 16:12:06 INFO - 'SHELL': '/bin/bash', 16:12:06 INFO - 'SHLVL': '1', 16:12:06 INFO - 'TERM': 'linux', 16:12:06 INFO - 'TMOUT': '86400', 16:12:06 INFO - 'USER': 'cltbld', 16:12:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:06 INFO - '_': '/tools/buildbot/bin/python'} 16:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:06 INFO - Running setup.py (path:/tmp/pip-z9rTHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:06 INFO - Running setup.py (path:/tmp/pip-xNcjEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:06 INFO - Running setup.py (path:/tmp/pip-cPDiq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:06 INFO - Running setup.py (path:/tmp/pip-EOvanr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:06 INFO - Running setup.py (path:/tmp/pip-f5o5GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:06 INFO - Running setup.py (path:/tmp/pip-HdyUJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:06 INFO - Running setup.py (path:/tmp/pip-PVTrMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:06 INFO - Running setup.py (path:/tmp/pip-6bTnZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:06 INFO - Running setup.py (path:/tmp/pip-mBoHVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:06 INFO - Running setup.py (path:/tmp/pip-c6UxGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:07 INFO - Running setup.py (path:/tmp/pip-i1u3bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:07 INFO - Running setup.py (path:/tmp/pip-0l4aGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:07 INFO - Running setup.py (path:/tmp/pip-ZOlqmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:07 INFO - Running setup.py (path:/tmp/pip-41dtD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:07 INFO - Running setup.py (path:/tmp/pip-GiiwX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:07 INFO - Running setup.py (path:/tmp/pip-Gjcaee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:07 INFO - Running setup.py (path:/tmp/pip-V6v_l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:07 INFO - Running setup.py install for manifestparser 16:12:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozcrash 16:12:07 INFO - Running setup.py install for mozdebug 16:12:07 INFO - Running setup.py install for mozdevice 16:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozfile 16:12:08 INFO - Running setup.py install for mozhttpd 16:12:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozinfo 16:12:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozInstall 16:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozleak 16:12:08 INFO - Running setup.py install for mozlog 16:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for moznetwork 16:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozprocess 16:12:08 INFO - Running setup.py install for mozprofile 16:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozrunner 16:12:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Running setup.py install for mozscreenshot 16:12:09 INFO - Running setup.py install for moztest 16:12:09 INFO - Running setup.py install for mozversion 16:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:09 INFO - Cleaning up... 16:12:09 INFO - Return code: 0 16:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:09 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 16:12:09 INFO - 'HOME': '/home/cltbld', 16:12:09 INFO - 'LANG': 'en_US.UTF-8', 16:12:09 INFO - 'LANGUAGE': 'en_US:en', 16:12:09 INFO - 'LOGNAME': 'cltbld', 16:12:09 INFO - 'MAIL': '/var/mail/cltbld', 16:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:09 INFO - 'MOZ_NO_REMOTE': '1', 16:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:09 INFO - 'NO_EM_RESTART': '1', 16:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:09 INFO - 'PWD': '/builds/slave/test', 16:12:09 INFO - 'SHELL': '/bin/bash', 16:12:09 INFO - 'SHLVL': '1', 16:12:09 INFO - 'TERM': 'linux', 16:12:09 INFO - 'TMOUT': '86400', 16:12:09 INFO - 'USER': 'cltbld', 16:12:09 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:09 INFO - '_': '/tools/buildbot/bin/python'} 16:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:09 INFO - Running setup.py (path:/tmp/pip-6RelCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:09 INFO - Running setup.py (path:/tmp/pip-njzO_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:09 INFO - Running setup.py (path:/tmp/pip-5MlkHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:09 INFO - Running setup.py (path:/tmp/pip-EshJy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:09 INFO - Running setup.py (path:/tmp/pip-bxNm7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:09 INFO - Running setup.py (path:/tmp/pip-tcnXm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:09 INFO - Running setup.py (path:/tmp/pip-p78fMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:10 INFO - Running setup.py (path:/tmp/pip-vV46bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:10 INFO - Running setup.py (path:/tmp/pip-qXLWBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:10 INFO - Running setup.py (path:/tmp/pip-Rq28BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:10 INFO - Running setup.py (path:/tmp/pip-uHDLkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:10 INFO - Running setup.py (path:/tmp/pip-YXWjt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:10 INFO - Running setup.py (path:/tmp/pip-F1wgBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:10 INFO - Running setup.py (path:/tmp/pip-Mx8XaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:10 INFO - Running setup.py (path:/tmp/pip-jjzGqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:10 INFO - Running setup.py (path:/tmp/pip-zmH8XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:10 INFO - Running setup.py (path:/tmp/pip-cDE98J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:10 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:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:10 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:10 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:10 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:10 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:11 INFO - Downloading blessings-1.6.tar.gz 16:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:11 INFO - Installing collected packages: blessings 16:12:11 INFO - Running setup.py install for blessings 16:12:12 INFO - Successfully installed blessings 16:12:12 INFO - Cleaning up... 16:12:12 INFO - Return code: 0 16:12:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:12 INFO - Reading from file tmpfile_stdout 16:12:12 INFO - Current package versions: 16:12:12 INFO - argparse == 1.2.1 16:12:12 INFO - blessings == 1.6 16:12:12 INFO - blobuploader == 1.2.4 16:12:12 INFO - docopt == 0.6.1 16:12:12 INFO - functools32 == 3.2.3-2 16:12:12 INFO - jsonschema == 2.5.1 16:12:12 INFO - manifestparser == 1.1 16:12:12 INFO - mozInstall == 1.13 16:12:12 INFO - mozcrash == 1.0 16:12:12 INFO - mozdebug == 0.1 16:12:12 INFO - mozdevice == 0.51 16:12:12 INFO - mozfile == 1.2 16:12:12 INFO - mozhttpd == 0.7 16:12:12 INFO - mozinfo == 0.10 16:12:12 INFO - mozleak == 0.1 16:12:12 INFO - mozlog == 3.5 16:12:12 INFO - moznetwork == 0.27 16:12:12 INFO - mozprocess == 0.25 16:12:12 INFO - mozprofile == 0.28 16:12:12 INFO - mozrunner == 6.13 16:12:12 INFO - mozscreenshot == 0.1 16:12:12 INFO - mozsystemmonitor == 0.3 16:12:12 INFO - moztest == 0.8 16:12:12 INFO - mozversion == 1.4 16:12:12 INFO - psutil == 3.1.1 16:12:12 INFO - requests == 1.2.3 16:12:12 INFO - wsgiref == 0.1.2 16:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:12 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 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 16:12:12 INFO - 'HOME': '/home/cltbld', 16:12:12 INFO - 'LANG': 'en_US.UTF-8', 16:12:12 INFO - 'LANGUAGE': 'en_US:en', 16:12:12 INFO - 'LOGNAME': 'cltbld', 16:12:12 INFO - 'MAIL': '/var/mail/cltbld', 16:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:12 INFO - 'MOZ_NO_REMOTE': '1', 16:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:12 INFO - 'NO_EM_RESTART': '1', 16:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:12 INFO - 'PWD': '/builds/slave/test', 16:12:12 INFO - 'SHELL': '/bin/bash', 16:12:12 INFO - 'SHLVL': '1', 16:12:12 INFO - 'TERM': 'linux', 16:12:12 INFO - 'TMOUT': '86400', 16:12:12 INFO - 'USER': 'cltbld', 16:12:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:12 INFO - '_': '/tools/buildbot/bin/python'} 16:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:12 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:12 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:12 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:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:12:13 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:13 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:13 INFO - Installing collected packages: simplejson 16:12:13 INFO - Running setup.py install for simplejson 16:12:13 INFO - building 'simplejson._speedups' extension 16:12:13 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:14 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:14 INFO - Successfully installed simplejson 16:12:14 INFO - Cleaning up... 16:12:14 INFO - Return code: 0 16:12:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, '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': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', '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:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:12:14 INFO - Using env: {'DISPLAY': ':0', 16:12:14 INFO - 'HOME': '/home/cltbld', 16:12:14 INFO - 'LANG': 'en_US.UTF-8', 16:12:14 INFO - 'LANGUAGE': 'en_US:en', 16:12:14 INFO - 'LOGNAME': 'cltbld', 16:12:14 INFO - 'MAIL': '/var/mail/cltbld', 16:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:14 INFO - 'MOZ_NO_REMOTE': '1', 16:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:14 INFO - 'NO_EM_RESTART': '1', 16:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:14 INFO - 'PWD': '/builds/slave/test', 16:12:14 INFO - 'SHELL': '/bin/bash', 16:12:14 INFO - 'SHLVL': '1', 16:12:14 INFO - 'TERM': 'linux', 16:12:14 INFO - 'TMOUT': '86400', 16:12:14 INFO - 'USER': 'cltbld', 16:12:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:14 INFO - '_': '/tools/buildbot/bin/python'} 16:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:15 INFO - Cleaning up... 16:12:15 INFO - Return code: 0 16:12:15 INFO - Running post-action listener: _resource_record_post_action 16:12:15 INFO - Running post-action listener: _start_resource_monitoring 16:12:15 INFO - Starting resource monitoring. 16:12:15 INFO - [mozharness: 2017-08-07 23:12:15.052646Z] Finished create-virtualenv step (success) 16:12:15 INFO - [mozharness: 2017-08-07 23:12:15.053122Z] Running install step. 16:12:15 INFO - Running pre-action listener: _resource_record_pre_action 16:12:15 INFO - Running main action method: install 16:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:15 INFO - Reading from file tmpfile_stdout 16:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:15 INFO - Reading from file tmpfile_stdout 16:12:15 INFO - Output received: 16:12:15 INFO - Usage: mozinstall [options] installer 16:12:15 INFO - Options: 16:12:15 INFO - -h, --help show this help message and exit 16:12:15 INFO - -d DEST, --destination=DEST 16:12:15 INFO - Directory to install application into. [default: 16:12:15 INFO - "/builds/slave/test"] 16:12:15 INFO - --app=APP Application being installed. [default: firefox] 16:12:15 INFO - mkdir: /builds/slave/test/build/application 16:12:15 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:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:12:33 INFO - Reading from file tmpfile_stdout 16:12:33 INFO - Output received: 16:12:33 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:33 INFO - Running post-action listener: _resource_record_post_action 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.333069Z] Finished install step (success) 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.333359Z] Running setup-mitmproxy step. 16:12:33 INFO - Running pre-action listener: _resource_record_pre_action 16:12:33 INFO - Running main action method: setup_mitmproxy 16:12:33 INFO - Skipping: mitmproxy is not required 16:12:33 INFO - Running post-action listener: _resource_record_post_action 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.334510Z] Finished setup-mitmproxy step (success) 16:12:33 INFO - [mozharness: 2017-08-07 23:12:33.334734Z] Running run-tests step. 16:12:33 INFO - Running pre-action listener: _resource_record_pre_action 16:12:33 INFO - Running pre-action listener: _set_gcov_prefix 16:12:33 INFO - Running main action method: run_tests 16:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:33 INFO - Python 2.7.3 16:12:33 INFO - Return code: 0 16:12:33 INFO - grabbing minidump binary from tooltool 16:12:33 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:33 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 0x19adeb0>, '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 0x19aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:33 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:12:33 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:12:33 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:12:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:33 INFO - Return code: 0 16:12:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:33 INFO - ENV: RUST_BACKTRACE is now 1 16:12:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:33 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-052', '--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:12:33 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-052 --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:12:33 INFO - Using env: {'DISPLAY': ':0', 16:12:33 INFO - 'HOME': '/home/cltbld', 16:12:33 INFO - 'LANG': 'en_US.UTF-8', 16:12:33 INFO - 'LANGUAGE': 'en_US:en', 16:12:33 INFO - 'LOGNAME': 'cltbld', 16:12:33 INFO - 'MAIL': '/var/mail/cltbld', 16:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:33 INFO - 'MOZ_NO_REMOTE': '1', 16:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:33 INFO - 'NO_EM_RESTART': '1', 16:12:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:33 INFO - 'PWD': '/builds/slave/test', 16:12:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:33 INFO - 'RUST_BACKTRACE': '1', 16:12:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:12:33 INFO - 'SHELL': '/bin/bash', 16:12:33 INFO - 'SHLVL': '1', 16:12:33 INFO - 'STYLO_FORCE_ENABLED': '1', 16:12:33 INFO - 'TERM': 'linux', 16:12:33 INFO - 'TMOUT': '86400', 16:12:33 INFO - 'USER': 'cltbld', 16:12:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002', 16:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:33 INFO - '_': '/tools/buildbot/bin/python'} 16:12:33 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-052', '--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:12:33 INFO - mozversion application_buildid: 20170807222356 16:12:33 INFO - mozversion application_changeset: 65507616792c990b1230888612dd7ffc13ed32b4 16:12:33 INFO - mozversion application_display_name: Nightly 16:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:33 INFO - mozversion application_name: Firefox 16:12:33 INFO - mozversion application_remotingname: firefox 16:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:33 INFO - mozversion application_vendor: Mozilla 16:12:33 INFO - mozversion application_version: 57.0a1 16:12:33 INFO - mozversion platform_buildid: 20170807222356 16:12:33 INFO - mozversion platform_changeset: 65507616792c990b1230888612dd7ffc13ed32b4 16:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:33 INFO - mozversion platform_version: 57.0a1 16:12:33 INFO - using testdate: 1502147553 16:12:33 INFO - actual date: 1502147553 16:12:33 INFO - starting webserver on 'localhost:33471' 16:12:33 INFO - SUITE-START | Running 2 tests 16:12:33 INFO - TEST-START | dromaeo_css 16:12:33 INFO - Initialising browser for dromaeo_css test... 16:12:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33471/getInfo.html -profile /tmp/tmprLQUrH/profile 16:12:33 INFO - TEST-INFO | started process 13594 (/builds/slave/test/build/application/firefox/firefox http://localhost:33471/getInfo.html) 16:12:39 INFO - TEST-INFO | 13594: exit 0 16:12:39 INFO - Browser initialized. 16:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:39 INFO - TEST-INFO | started process 13817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprLQUrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:40 INFO - PID 13817 | 16:12:40 INFO - PID 13817 | (/builds/slave/test/build/application/firefox/firefox:13871): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:12:40 INFO - PID 13817 | 16:12:50 INFO - PID 13817 | RSS: Main: 173916160 16:12:50 INFO - PID 13817 | 16:15:50 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33471/tests/dromaeo/cssquery-ext.html) 16:15:51 INFO - PID 13817 | RSS: Main: 175403008 16:15:51 INFO - PID 13817 | 16:18:53 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-ext.html (next: http://localhost:33471/tests/dromaeo/cssquery-jquery.html) 16:18:54 INFO - PID 13817 | RSS: Main: 171225088 16:18:54 INFO - PID 13817 | 16:21:56 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33471/tests/dromaeo/cssquery-mootools.html) 16:21:56 INFO - PID 13817 | RSS: Main: 174845952 16:21:56 INFO - PID 13817 | 16:24:58 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33471/tests/dromaeo/cssquery-prototype.html) 16:24:59 INFO - PID 13817 | RSS: Main: 173142016 16:24:59 INFO - PID 13817 | 16:28:02 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33471/tests/dromaeo/cssquery-yui.html) 16:28:03 INFO - PID 13817 | RSS: Main: 176316416 16:28:03 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | Cycle 1(1): loaded http://localhost:33471/tests/dromaeo/cssquery-yui.html (next: http://localhost:33471/tests/dromaeo/cssquery-dojo.html) 16:31:05 INFO - PID 13817 | RSS: Main: 177385472 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | __start_tp_report 16:31:05 INFO - PID 13817 | _x_x_mozilla_page_load 16:31:05 INFO - PID 13817 | _x_x_mozilla_page_load_details 16:31:05 INFO - PID 13817 | |i|pagename|runs| 16:31:05 INFO - PID 13817 | |0;dojo.html;3071.9539206911886;3186.984065079674;3198.2963747975446;3201.7598680098968;3247.6102867655886;6178.629282243069;6322.367763223681;6326.588771729846;6384.872302553952;6395.616263024222;6194.628322300665;6297;6311.747530098791;6327.525435592326;6360.077788720633;5750.108733146369;5758.251427314464;5778.191053252548;5793.884122317551;5803.6517808931385;5799.072148456248;5823.184754134425;5832.562557808182;5882.647041177543;5893.55798315126;5795.072788353864;5821.912671309934;5823.883522329572;5838.386969368219;5886.705664716768;5753.309602847664;5794.942050579524;5813.970930145365;5864.560157988168;5892.234009578749;5556.611037227396;5715.685637289947;5716.3426205986425;5717.228174196472;5756.338021127582;6149.41580549847;6203.8138855834395;6322.9051564226575;6326.335734747877;6332.208473940757;6634.601923884582;6709.597424154566;6737.461003119788;6742.797716068526;6834.179898412222;6789.864202715968;6832.965835170792;6842.315768423167;6854.657267136673;6861.5539989901;6320.557560970734;6332.145160403379;6333.841653958688;6337.2395312562785;6342.682865856688;6954.026436298922;6976.895346569806;6979.267176946449;6979.685914133876;6980.581165130108;6592.17597800275;6614.7023383947835;6643.136392269071;6664.033715111282;6672.065910772496;6739.224989126215;6772.018057381652;6773.221079575814;6775.695093720795;6794.524383293221;6753.594784312859;6781.152355955505;6805.795826125224;6857.142857142857;6875.862482750317;6775.728970841111;6793.150856142982;6802.3537763912345;6883.380495755406;6904.723811047602;5371.086915224421;5375.919361209585;5446.91829622556;5465.836024919259;5520.944790552124;4727.24364101749;4732.645051621073;4742.644301677388;4781.904361912742;4787.928181077286;5808;5870.589058765845;5886.293644762656;5898.469137777534;5902.734376953047;6829.590224586541;6843.965780171166;6849.828754281183;6849.897251541231;6867.862642747217;5749.281339832521;5853.560982926298;5860.882782344414;5879.588428809942;5894.970525147347;5969.373215812364;6020.909686354708;6027.547933904974;6034.094885767082;6039.8792024159275;6527.314631963671;6532.118164047888;6613.636250006296;6630.336966303331;6635.170603674541;6696.129503164558;6742.292059333699;6796.558223715443;6843.213030501556;6875.4155896749335;6472.708728107341;6490.967545162244;6523.380278873499;6523.510736694861;6532.869342613026;6585.6377899216;6621.370969757865;6624.701888414937;6627.436667883284;6685.364890335411;6865.141857267841;6888.896666550106;6946.583205007716;6964.477664175106;6971.8257043572285;6484.351564843478;6589.934100658932;6610;6632.2372927114;6738.427233685192;6584.8353791155605;6591.571547849375;6606.9008964866525;6607.669616519251;6610.504212184202;6447.129637498878;6450.000249961264;6511.576747511396;6511.609303441809;6518.413342799171;6421.422072013541;6502.772402965874;6603.306652801387;6654.800355989328;6655.367740064686;6441.677916104082;6472.255690595642;6498.772542960974;6526.151600291932;6550.967245163743 16:31:05 INFO - PID 13817 | |1;ext.html;852.3947996922185;876.0801158783275;1146.9655910322692;1177.2465622001926;1180.7402371478272;40487;41120.79439602798;41139.58860411395;41194.38208426876;41200.99999999996;40494.59505404945;40749.79625101878;40806.18387632246;40810;40912.386314205236;7524.473286869935;7625.123110842269;7661.770146895602;7663.540187588763;7682.116556595979;7511.248875112499;7551.735689250877;7610.086789585258;7610.277023682741;7610.657520411595;7509.211532789061;7544.924550754477;7615.314621684048;7643.732469363574;7672.539647621133;7591.013168288115;7621.7713468595475;7631.35133513652;7634.885476717854;7642;7524.699012039512;7585.544867307979;7610.6194690265265;7611.771646850603;7621.58081305528;36998;37108;37295;37392.25215495675;37450.43824342637;3560.1633616100194;3574;3581.176329444216;3586.910327241814;3588.22853086585;29450.70549294501;29526.55710164349;29577.852110739525;29625.40749185004;29703.25741856471;4831.033793241366;4950.777215025297;5001.44984051754;5059.62052846038;5127.154019586764;188553;188682;191159.04420477946;191289;192298;42285;42609.147817043486;47355.763221183675;47533;48359.5164048355;50696.23955640668;50985.7450712744;51038.234426483636;51049.234261486105;51097.744511277204;16528.338866445207;16636.916815415847;16656.583585410463;16657.66684666324;16669;13736.725265494633;13750.449982000808;13755.587332380044;13757.518486852912;13811.309434528233;14048.086874353134;14180.290985450893;14181.858181418054;14284.642883927778;14436.855631443761;5732.633331837627;5798.449147330997;5799.739011744482;5956.880862382728;5993.880122397615;1009.3187098708343;1016.8627235323285;1022.5091955861079;1025.3284098915221;1043.1081425381342;22974.425639358815;23838.165664202017;23858.16496422617;29326.706732932398;30026.84986575097;1101.6144349477618;1104.7900898829196;1109.5312928733504;1111.3332000799455;1119.9104071674246;12375.75248495025;12517.49930002808;12534.23874409046;12633.305168215653;12746.044046696536;229790;234510;234946;235576;235629;50371;50521.74739126281;50865;50975;50994.49005509972;1452.3827373366278;1476.6751314710962;1480.4448331875547;1490.8509149085005;1502.233860731035;22849.885750571142;22937;23033.424164395354;23169.536609268056;23285.53428931446;36668.63331366652;36676;36757;36880.26239475249;37016.62983370132;211565;211854;211909;213303;214397;29416.55875161917;29907.70092299049;29940;32504.83747581247;33287.16782080467;39764;41307.96730081772;41466.792666036476;41671.58328416798;41936;30863.537046943864;31154.22114447157;31401.52897706582;32063.839680801448;32300.83849580737;30747.38505229838;30794.846025769726;31039.379212415173;31109.68890311068;31351;33736.49395259024;33769.66230337665;33858.49212261867;33890.3221935555;34074.63701451914;32979.505307420884;33406.164845879044;33810.3237935235;33844.15389615181;33884.66115338815;23943;25571.36071598225;25578.98893759928;25664.486710266065;25794.226173214833 16:31:05 INFO - PID 13817 | |2;jquery.html;568.673013017515;572.5505478199611;575.8848230353929;577.4571902411735;595.2351228671157;22717.31848044557;22758.772412275874;23670.05319787211;23682.88158559207;23738.406539836513;25982.740172598267;26598.202053938414;26666.866665666694;26669.333266668342;26810.195694129157;6357.300696923347;6481.611103333791;6503.934960650404;6521.250056243522;6521.282658907517;6463.159789227418;6544.0511125886715;6675.365840245169;6999.895001574981;7081.858362832741;7033.964830175842;7090.042844216016;7095.113110861143;7095.503314767969;7102.254263302357;7030.7539236127;7048.68280927357;7062.788116356517;7073;7090.184628767706;6886.173659160882;6929.133858267716;6937.098177236978;6945.548539344977;6954.269801670853;31202.375952481052;31838.363232735446;32582.6741732582;32876.50685239724;33034.83482582572;1964.6463636545416;2002;2004.6191223667602;2007.177057406471;2013.0035632362074;19844.90077549603;20357.185712571478;20403;20434.795652043587;20452.77283363003;2458.1519375815315;2505.649209110726;2541.263033720237;2621.764041236298;2634.183403145031;145123;148236.99999999892;148248.2587587066;148538;148895;19371.903140484206;22260.554788904454;22364.55270894573;22665.2067177648;23071.653925191134;44617.55382446134;44764;44861;44888.775556122666;44991.32513012308;12313;12406.689832754253;12448.066395020409;12489.375531223403;12516.624501264976;9060.864087038699;10405.115565177044;10470.319429237228;10481.161507079416;10799.190060745475;10284;11645.708857278467;11777.646670599896;11878.643640690792;11953.521859125538;4534.818607255739;4614.738777998824;4667.95332046682;4706.670533062653;4833.685810422311;970.5875003123645;977.628501169551;992.5979978108877;993.4238141877694;1005.3666190300064;20433.69349459759;20444.897775511326;20613.381598552067;20642.380728578166;21001.789982099985;1030.299396410448;1032.396048311746;1034.2656713733184;1039.1738567838586;1040.7970445763156;11122.944385278022;11166.385848778395;11197.776044479066;11282.661520154408;11330.94334528322;490071;492537;493538;501613;504550;116205;116871.41564292125;117982.41008794901;119640;121089.39455302844;1198.0475521959888;1203.7111093337535;1215.6960759810047;1216.2398500936915;1222.0406980520427;17839.46481605554;17875.73186402179;17956.640867182843;18392.908035459735;20965.26621568238;58210;59192;59611;60009.39990600213;60805.39194607997;70458.64770676114;70778;71101.64449177722;71606;72459.63770181115;14950.401983920521;15434.84565154379;15547.689046219239;15576.299066541806;15586.76619850726;23599.174028908907;24351.75648243495;24813.503729924938;25376.87311563504;25449.236522904343;19253.80746192576;19506.90246548815;19603;19628.60742785165;19659;15939.681206376039;17095.7435638468;17208.913955430144;17390.82609173892;17902.731459027866;17221.74167387465;18156.364527241483;18188;18297.81702182961;20047;15048.774268385763;15064.623384415478;15100.773488397463;15337.923310383376;15348.846511534743;17156.57108572246;17536.210870511113;18463.353782617545;19124.139413726138;19132 16:31:05 INFO - PID 13817 | |3;mootools.html;1359.9660008499786;1371.0813754784294;1376;1394.0938390046474;1418.2766788937643;13717.519886803964;14215.786763198561;14364.784528232072;14407.207603581799;14410;14509.564713058626;14895.329710163041;14904.552863414116;14910.627234319147;14930.477433289838;2658.9734102658917;2728.2224565998695;2728.6998430172666;2728.9590656140076;2731.3308239481257;2613.9346516337055;2667.679878414593;2683.5303821831103;2707.4585082983385;2786.7770578353784;2718.4563087382503;2756.517609418354;2757.8345299282005;2763.281546797827;2764.14311563416;2642.2733748219202;2657.1895571850578;2668.933276668089;2670.4258584404347;2674.9567668609257;2610.530104581175;2650.721674224198;2659.6542449481635;2660.3349162709324;2682.383051898055;13980.510682126076;14042.85957140436;14069.507567235098;14081;14099.436022559084;7649.6940122395035;7940.404469664741;7948.364130869517;7955.323797477221;7962.681492740284;5154.201098829687;5246;5262.236975638511;5368.677879327252;5378.139497680391;1856.2574970011967;1874.578219900525;1887.5941672540332;1916.444231172958;1949.362535470212;22968.42578935523;23638.29085127449;23650.172243971552;23692;23712.525749484914;7095.787126386217;7114.928850711427;7173.713051477883;7192.065031545865;7263.745768898063;18741.25034998612;18765.81234187668;18782.436526904214;18789;18789.060546972596;7799.5320280783335;8086.676532938734;8096.02847658273;8123.4313598047565;8127.146649601825;7057.505974581833;7214.134303883568;7265;7280.96359518199;7282;5119.308893299357;5393.811216607478;5440.700761458158;5452.618316717871;5485.780568777204;1573.8190108137483;1614.53178578211;1640.8769342299374;1726.326732574297;1770.9822901771074;875.1554749666602;895.4850960697624;898.9146031127033;903.3811838890381;905.6603773584906;7740.690372385042;7898.960505197552;7911.485753426009;8007.759767206993;8107.959460202661;971.1745016735719;983.8229118758549;1012.291396022787;1012.6127205728052;1028.9742756430999;5093.083245015859;5111.667741596784;5377.274068000848;5441.945580544223;5466.753996070186;18926.62146757057;18990.335338263096;19563.804361956198;19637.410877673694;19650.21399144047;19255.711164332548;19340.903295483433;19397.127129279215;19452.902735486514;19540.804591954184;10544.103751181083;10633.73415664599;10859.619913302997;10859.945700271606;10937.234393592531;8330.583800754008;8498.235158835734;8522.957385213282;8824.3381746368;8855.690050848189;16863.662726745642;17152.74270885913;17278;17298.567535811704;17613.471595852145;16918.57703557421;17218.397356092475;17245.65508689844;17256.827431725524;17842.107894604957;12611.621651350475;12697.682557936125;12770;12773.425195866022;12775.552855650008;12202.694932626755;12226.266424014588;12389.62831115068;12394.132410731163;12436.875631243573;10500.947495262475;10615.787684246427;10624.309419887682;10802.405867677038;10907.400092994962;10141.49292535385;10217.438040907822;10387.584496620353;10520.316179448311;10589.046985771318;8743.081976392386;8879.778005549913;8912.465252084636;8913.509756963429;8920.24177944856;7171.462140339391;7185.065941427581;7199.6760145794615;7217.133943926762;7254.129504459499;7147.928520714934;7235.421166306788;7308.269173082649;7343.669534871051;7369.484136110421 16:31:05 INFO - PID 13817 | |4;prototype.html;510.9208072748723;516.349399756307;526.9552088072513;534.3454268521062;536.8416317186432;6124.3263241043505;6160.199174107371;6189.709807371268;6196;6224.315325314212;6125.070602760127;6181.6600086995195;6206.565540412173;6225.221847269091;6229.501639868811;5105.259737338084;5118.846434606968;5126.923096153542;5158.9742051289695;5160;4830.816449969745;5130.846074617749;5144.3312369392115;5152.433232344439;5158.174692049273;4888.388951381077;4947.727874966876;4951.950480495185;4967.205247160455;4976.253561965716;4916.557509824133;4980.501949805027;4986.980272989427;4988.551030407262;5039.269305950654;4390.978045109754;4419.381286619876;4463.397441345409;4489.842855500075;4494.325851122325;6066.514678825727;6108.694565271719;6112.877742445171;6113.205283313141;6140.3552626974415;5705.2012718219485;5718.285214348207;5759.884802303973;5771.826845194651;5775.566832487538;6505.577137486048;6518.250401203827;6604.834879128012;6609.306022867578;6620.569662971891;4848.539388758062;4850.781714822841;4862.465128835825;4878.878028049292;4889.731064791435;6568.310327415648;6666.23338316095;6689.732410703566;6826.863462730717;6910.2053263874795;4982.90034199314;5019.447860735316;5026.1204289249235;5032.370953630796;5032.72320022395;5010.874728131826;5031.396232452056;5032.547070763649;5086.313347698014;5121.334226550524;5684.261046063985;5697.686627235459;5709.685967271756;5724.370319264877;5749.482546570829;6497.967510162419;6600.174978127734;6600.471962243009;6622.635755033423;6657.305195616479;1751.2050148597534;1753.8246175382615;1761.7093179625474;1763.5238485608813;1780.8931464112195;1185.6502331812137;1212.1393810394718;1223.9571614993433;1230.7846126927932;1238.2817965580123;5713.800016999385;5723.139979506677;5746.856328591819;5801.82594522165;5860.912086318709;6675.1989761228;6701.597904125768;6703.22912865017;6703.966480167568;6718.816384675;5651.406602306781;5709.714514274269;5741.511971482387;5785.595008349459;5817.941820581825;3541.94687079694;3542.3800834854314;3544.751867369311;3562.1628917204434;3611.2235869287706;6451.322611125858;6507;6544.509161812788;6560.442362399154;6592.208934927839;6882.5870447773295;6911.274316196727;6915.101036865175;6924.840993459905;6936.7572134975035;6470.5147113965695;6472.773452929219;6495.967520162369;6497.415232629086;6554.344565543408;6036.8188954331445;6510.121133646897;6592.736290548324;6697.564658297195;6715;6580.7496575650475;6591.769288074895;6664.633445160563;6680.732770689118;6726.562773419712;6396.249612666598;6463.806085817433;6470.094186813756;6556.967215163893;6565.507586930904;4928;4972.303877457087;4985.975070124626;5004.697838994103;5011.4487406386;6481.837954051187;6620.3710647488415;6631.734730610721;6781.220159681699;6788.66056697173;6369.394907483782;6412.23053233615;6474.449671777763;6532.510061745293;6556.770513032021;6351.714172862325;6423.935760642334;6460.580062295936;6530.040987703765;6556.541042127005;6348.365163483615;6358.141650877073;6414.839629009312;6418.935810641834;6426.518011149276;6502.707378168088;6562.245341785756;6562.376574225441;6608.801735947929;6634.900476492953;6301.684915754286;6358.682065896594;6394.200724909387;6420.518461115528;6433.035044743326 16:31:05 INFO - PID 13817 | |5;yui.html;906.7234493479486;921.9354645174838;937.9062093790621;938.5260443476044;944.419182202945;18219.908900455495;19245.61508769824;19272.132754026068;19313.806861931378;21638;21230.89384553079;21489.46276343092;22006.559868802655;22012.559748805055;22024.229151979685;1015.7765291635828;1044.1229367331441;1051.8369652703805;1052.1109662335314;1052.468503405779;1023.5036007536339;1058.4020028683808;1061.1828891753346;1061.6708820265703;1063.6277302943986;1072.399456304468;1077.1382893685059;1078.2937176149635;1078.6979645699216;1110.7112150840799;1064.9627263045834;1065.9946700266487;1067.4395942130366;1070.1706177712297;1108;782.3584660578329;782.8786538086606;783.3615603283306;792.0416296281506;815.2377527012203;19464.124114414884;19884.70172947407;19910;19917.402477925687;21016.5796684067;21740;22214;22234;22259.44351391212;22266;16507.83492165075;16797.32810687571;17000.659986800318;17078.06070666113;17189.914050429667;3662.963370366289;3672.706183505313;3682.0978860179425;3692.9261414771554;3695.5565332160045;125489;127541.36229318794;128396;132157.99999999904;133220;16891;17325.393611223797;17453.12734363277;17469.912650436665;17525.64948701019;31167.844160779052;31640.208994774854;31779.20551986219;31822.840885795424;31915.202119947186;7880.64537095832;8161.673533058611;8172.346212303001;8180.713675021346;8804.47173169612;3967.4048892666333;4059.3910913362643;4070.7964601769795;4084.223997440477;4095.1809638072505;5076.517730815566;5094.439611642716;5119.129747942859;5121.9743901281;5143.871403214875;1069;1090.4983707494641;1097.8188598881095;1111.9944400277948;1112.3715100967927;645.515863102673;649.8245473722069;654.2084078265257;657.8190997475637;682.2938258902112;11344.602938897098;11410.600628977945;11431.028362589106;11649.728302981006;12491.312977786309;651.9348065193537;659.2715049869921;659.8020593821834;664.4983037806426;679.9354061364163;5034.144195486776;5115.974420127875;5152.716600587004;5233.790648374023;5275;99115;101169.98830011606;105307.94692053135;108047;108722.45638771755;91996.72602411595;93511.53244233735;95477;96666;99465;79019.60490197512;79944.60027699941;81010.99999999882;81637.59181204175;83776;10166.339187952759;10179.338343007681;10202.795944081225;10217.008096722317;10326.638567650096;37579.81210093932;37593.62406375901;37693.434598481595;39135;39712.2057558853;47286.527134729586;48382.758086209345;48410;49204.507954919995;50090.74954625204;14893.106413615218;14914.179720115064;14937.178455185069;14989.700205996038;15130.092194468367;15778.13220272896;15873.68252634964;15879.364825406854;15911.363545458053;16015.35938562491;15778.368865245262;15802.20988950525;15847.603809904844;15867.761983570024;16299.511014669579;15373;15373.615659608598;15375.76936345978;15729.292181851615;15748.055116693035;15640.139792311533;15663.295151718428;15734.370625174864;15760.769042346521;16082.115483648511;10480.68557943263;10605.787884242427;10809.297395669257;10809.891901080888;11081.445927703422;11033.668989930315;11077.66766996959;11107.111431085332;11200.327980321206;11227.831582526433 16:31:05 INFO - PID 13817 | __end_tp_report 16:31:05 INFO - PID 13817 | __start_cc_report 16:31:05 INFO - PID 13817 | _x_x_mozilla_cycle_collect,359 16:31:05 INFO - PID 13817 | __end_cc_report 16:31:05 INFO - PID 13817 | __startTimestamp1502148665651__endTimestamp 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | ------- Summary: start ------- 16:31:05 INFO - PID 13817 | Number of tests: 6 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#0] dojo.html Cycles:165 Average:6241.11 Median:6490.97 stddev:738.70 (11.4%) stddev-sans-first:697.87 16:31:05 INFO - PID 13817 | Values: 3072.0 3187.0 3198.3 3201.8 3247.6 6178.6 6322.4 6326.6 6384.9 6395.6 6194.6 6297.0 6311.7 6327.5 6360.1 5750.1 5758.3 5778.2 5793.9 5803.7 5799.1 5823.2 5832.6 5882.6 5893.6 5795.1 5821.9 5823.9 5838.4 5886.7 5753.3 5794.9 5814.0 5864.6 5892.2 5556.6 5715.7 5716.3 5717.2 5756.3 6149.4 6203.8 6322.9 6326.3 6332.2 6634.6 6709.6 6737.5 6742.8 6834.2 6789.9 6833.0 6842.3 6854.7 6861.6 6320.6 6332.1 6333.8 6337.2 6342.7 6954.0 6976.9 6979.3 6979.7 6980.6 6592.2 6614.7 6643.1 6664.0 6672.1 6739.2 6772.0 6773.2 6775.7 6794.5 6753.6 6781.2 6805.8 6857.1 6875.9 6775.7 6793.2 6802.4 6883.4 6904.7 5371.1 5375.9 5446.9 5465.8 5520.9 4727.2 4732.6 4742.6 4781.9 4787.9 5808.0 5870.6 5886.3 5898.5 5902.7 6829.6 6844.0 6849.8 6849.9 6867.9 5749.3 5853.6 5860.9 5879.6 5895.0 5969.4 6020.9 6027.5 6034.1 6039.9 6527.3 6532.1 6613.6 6630.3 6635.2 6696.1 6742.3 6796.6 6843.2 6875.4 6472.7 6491.0 6523.4 6523.5 6532.9 6585.6 6621.4 6624.7 6627.4 6685.4 6865.1 6888.9 6946.6 6964.5 6971.8 6484.4 6589.9 6610.0 6632.2 6738.4 6584.8 6591.6 6606.9 6607.7 6610.5 6447.1 6450.0 6511.6 6511.6 6518.4 6421.4 6502.8 6603.3 6654.8 6655.4 6441.7 6472.3 6498.8 6526.2 6551.0 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#1] ext.html Cycles:180 Average:37799.04 Median:33753.08 stddev:55177.26 (163.5%) stddev-sans-first:55262.31 16:31:05 INFO - PID 13817 | Values: 852.4 876.1 1147.0 1177.2 1180.7 40487.0 41120.8 41139.6 41194.4 41201.0 40494.6 40749.8 40806.2 40810.0 40912.4 7524.5 7625.1 7661.8 7663.5 7682.1 7511.2 7551.7 7610.1 7610.3 7610.7 7509.2 7544.9 7615.3 7643.7 7672.5 7591.0 7621.8 7631.4 7634.9 7642.0 7524.7 7585.5 7610.6 7611.8 7621.6 36998.0 37108.0 37295.0 37392.3 37450.4 3560.2 3574.0 3581.2 3586.9 3588.2 29450.7 29526.6 29577.9 29625.4 29703.3 4831.0 4950.8 5001.4 5059.6 5127.2 188553.0 188682.0 191159.0 191289.0 192298.0 42285.0 42609.1 47355.8 47533.0 48359.5 50696.2 50985.7 51038.2 51049.2 51097.7 16528.3 16636.9 16656.6 16657.7 16669.0 13736.7 13750.4 13755.6 13757.5 13811.3 14048.1 14180.3 14181.9 14284.6 14436.9 5732.6 5798.4 5799.7 5956.9 5993.9 1009.3 1016.9 1022.5 1025.3 1043.1 22974.4 23838.2 23858.2 29326.7 30026.8 1101.6 1104.8 1109.5 1111.3 1119.9 12375.8 12517.5 12534.2 12633.3 12746.0 229790.0 234510.0 234946.0 235576.0 235629.0 50371.0 50521.7 50865.0 50975.0 50994.5 1452.4 1476.7 1480.4 1490.9 1502.2 22849.9 22937.0 23033.4 23169.5 23285.5 36668.6 36676.0 36757.0 36880.3 37016.6 211565.0 211854.0 211909.0 213303.0 214397.0 29416.6 29907.7 29940.0 32504.8 33287.2 39764.0 41308.0 41466.8 41671.6 41936.0 30863.5 31154.2 31401.5 32063.8 32300.8 30747.4 30794.8 31039.4 31109.7 31351.0 33736.5 33769.7 33858.5 33890.3 34074.6 32979.5 33406.2 33810.3 33844.2 33884.7 23943.0 25571.4 25579.0 25664.5 25794.2 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#2] jquery.html Cycles:180 Average:36758.57 Median:21631.17 stddev:83823.25 (387.5%) stddev-sans-first:84014.36 16:31:05 INFO - PID 13817 | Values: 568.7 572.6 575.9 577.5 595.2 22717.3 22758.8 23670.1 23682.9 23738.4 25982.7 26598.2 26666.9 26669.3 26810.2 6357.3 6481.6 6503.9 6521.3 6521.3 6463.2 6544.1 6675.4 6999.9 7081.9 7034.0 7090.0 7095.1 7095.5 7102.3 7030.8 7048.7 7062.8 7073.0 7090.2 6886.2 6929.1 6937.1 6945.5 6954.3 31202.4 31838.4 32582.7 32876.5 33034.8 1964.6 2002.0 2004.6 2007.2 2013.0 19844.9 20357.2 20403.0 20434.8 20452.8 2458.2 2505.6 2541.3 2621.8 2634.2 145123.0 148237.0 148248.3 148538.0 148895.0 19371.9 22260.6 22364.6 22665.2 23071.7 44617.6 44764.0 44861.0 44888.8 44991.3 12313.0 12406.7 12448.1 12489.4 12516.6 9060.9 10405.1 10470.3 10481.2 10799.2 10284.0 11645.7 11777.6 11878.6 11953.5 4534.8 4614.7 4668.0 4706.7 4833.7 970.6 977.6 992.6 993.4 1005.4 20433.7 20444.9 20613.4 20642.4 21001.8 1030.3 1032.4 1034.3 1039.2 1040.8 11122.9 11166.4 11197.8 11282.7 11330.9 490071.0 492537.0 493538.0 501613.0 504550.0 116205.0 116871.4 117982.4 119640.0 121089.4 1198.0 1203.7 1215.7 1216.2 1222.0 17839.5 17875.7 17956.6 18392.9 20965.3 58210.0 59192.0 59611.0 60009.4 60805.4 70458.6 70778.0 71101.6 71606.0 72459.6 14950.4 15434.8 15547.7 15576.3 15586.8 23599.2 24351.8 24813.5 25376.9 25449.2 19253.8 19506.9 19603.0 19628.6 19659.0 15939.7 17095.7 17208.9 17390.8 17902.7 17221.7 18156.4 18188.0 18297.8 20047.0 15048.8 15064.6 15100.8 15337.9 15348.8 17156.6 17536.2 18463.4 19124.1 19132.0 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#3] mootools.html Cycles:180 Average:8946.91 Median:2646.50 stddev:6087.09 (230.0%) stddev-sans-first:6077.47 16:31:05 INFO - PID 13817 | Values: 1360.0 1371.1 1376.0 1394.1 1418.3 13717.5 14215.8 14364.8 14407.2 14410.0 14509.6 14895.3 14904.6 14910.6 14930.5 2659.0 2728.2 2728.7 2729.0 2731.3 2613.9 2667.7 2683.5 2707.5 2786.8 2718.5 2756.5 2757.8 2763.3 2764.1 2642.3 2657.2 2668.9 2670.4 2675.0 2610.5 2650.7 2659.7 2660.3 2682.4 13980.5 14042.9 14069.5 14081.0 14099.4 7649.7 7940.4 7948.4 7955.3 7962.7 5154.2 5246.0 5262.2 5368.7 5378.1 1856.3 1874.6 1887.6 1916.4 1949.4 22968.4 23638.3 23650.2 23692.0 23712.5 7095.8 7114.9 7173.7 7192.1 7263.7 18741.3 18765.8 18782.4 18789.0 18789.1 7799.5 8086.7 8096.0 8123.4 8127.1 7057.5 7214.1 7265.0 7281.0 7282.0 5119.3 5393.8 5440.7 5452.6 5485.8 1573.8 1614.5 1640.9 1726.3 1771.0 875.2 895.5 898.9 903.4 905.7 7740.7 7899.0 7911.5 8007.8 8108.0 971.2 983.8 1012.3 1012.6 1029.0 5093.1 5111.7 5377.3 5441.9 5466.8 18926.6 18990.3 19563.8 19637.4 19650.2 19255.7 19340.9 19397.1 19452.9 19540.8 10544.1 10633.7 10859.6 10859.9 10937.2 8330.6 8498.2 8523.0 8824.3 8855.7 16863.7 17152.7 17278.0 17298.6 17613.5 16918.6 17218.4 17245.7 17256.8 17842.1 12611.6 12697.7 12770.0 12773.4 12775.6 12202.7 12226.3 12389.6 12394.1 12436.9 10500.9 10615.8 10624.3 10802.4 10907.4 10141.5 10217.4 10387.6 10520.3 10589.0 8743.1 8879.8 8912.5 8913.5 8920.2 7171.5 7185.1 7199.7 7217.1 7254.1 7147.9 7235.4 7308.3 7343.7 7369.5 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#4] prototype.html Cycles:180 Average:5504.81 Median:6124.70 stddev:1533.97 (25.0%) stddev-sans-first:1491.77 16:31:05 INFO - PID 13817 | Values: 510.9 516.3 527.0 534.3 536.8 6124.3 6160.2 6189.7 6196.0 6224.3 6125.1 6181.7 6206.6 6225.2 6229.5 5105.3 5118.8 5126.9 5159.0 5160.0 4830.8 5130.8 5144.3 5152.4 5158.2 4888.4 4947.7 4952.0 4967.2 4976.3 4916.6 4980.5 4987.0 4988.6 5039.3 4391.0 4419.4 4463.4 4489.8 4494.3 6066.5 6108.7 6112.9 6113.2 6140.4 5705.2 5718.3 5759.9 5771.8 5775.6 6505.6 6518.3 6604.8 6609.3 6620.6 4848.5 4850.8 4862.5 4878.9 4889.7 6568.3 6666.2 6689.7 6826.9 6910.2 4982.9 5019.4 5026.1 5032.4 5032.7 5010.9 5031.4 5032.5 5086.3 5121.3 5684.3 5697.7 5709.7 5724.4 5749.5 6498.0 6600.2 6600.5 6622.6 6657.3 1751.2 1753.8 1761.7 1763.5 1780.9 1185.7 1212.1 1224.0 1230.8 1238.3 5713.8 5723.1 5746.9 5801.8 5860.9 6675.2 6701.6 6703.2 6704.0 6718.8 5651.4 5709.7 5741.5 5785.6 5817.9 3541.9 3542.4 3544.8 3562.2 3611.2 6451.3 6507.0 6544.5 6560.4 6592.2 6882.6 6911.3 6915.1 6924.8 6936.8 6470.5 6472.8 6496.0 6497.4 6554.3 6036.8 6510.1 6592.7 6697.6 6715.0 6580.7 6591.8 6664.6 6680.7 6726.6 6396.2 6463.8 6470.1 6557.0 6565.5 4928.0 4972.3 4986.0 5004.7 5011.4 6481.8 6620.4 6631.7 6781.2 6788.7 6369.4 6412.2 6474.4 6532.5 6556.8 6351.7 6423.9 6460.6 6530.0 6556.5 6348.4 6358.1 6414.8 6418.9 6426.5 6502.7 6562.2 6562.4 6608.8 6634.9 6301.7 6358.7 6394.2 6420.5 6433.0 16:31:05 INFO - PID 13817 | 16:31:05 INFO - PID 13817 | [#5] yui.html Cycles:180 Average:22311.98 Median:19258.87 stddev:31032.64 (161.1%) stddev-sans-first:31078.07 16:31:05 INFO - PID 13817 | Values: 906.7 921.9 937.9 938.5 944.4 18219.9 19245.6 19272.1 19313.8 21638.0 21230.9 21489.5 22006.6 22012.6 22024.2 1015.8 1044.1 1051.8 1052.1 1052.5 1023.5 1058.4 1061.2 1061.7 1063.6 1072.4 1077.1 1078.3 1078.7 1110.7 1065.0 1066.0 1067.4 1070.2 1108.0 782.4 782.9 783.4 792.0 815.2 19464.1 19884.7 19910.0 19917.4 21016.6 21740.0 22214.0 22234.0 22259.4 22266.0 16507.8 16797.3 17000.7 17078.1 17189.9 3663.0 3672.7 3682.1 3692.9 3695.6 125489.0 127541.4 128396.0 132158.0 133220.0 16891.0 17325.4 17453.1 17469.9 17525.6 31167.8 31640.2 31779.2 31822.8 31915.2 7880.6 8161.7 8172.3 8180.7 8804.5 3967.4 4059.4 4070.8 4084.2 4095.2 5076.5 5094.4 5119.1 5122.0 5143.9 1069.0 1090.5 1097.8 1112.0 1112.4 645.5 649.8 654.2 657.8 682.3 11344.6 11410.6 11431.0 11649.7 12491.3 651.9 659.3 659.8 664.5 679.9 5034.1 5116.0 5152.7 5233.8 5275.0 99115.0 101170.0 105307.9 108047.0 108722.5 91996.7 93511.5 95477.0 96666.0 99465.0 79019.6 79944.6 81011.0 81637.6 83776.0 10166.3 10179.3 10202.8 10217.0 10326.6 37579.8 37593.6 37693.4 39135.0 39712.2 47286.5 48382.8 48410.0 49204.5 50090.7 14893.1 14914.2 14937.2 14989.7 15130.1 15778.1 15873.7 15879.4 15911.4 16015.4 15778.4 15802.2 15847.6 15867.8 16299.5 15373.0 15373.6 15375.8 15729.3 15748.1 15640.1 15663.3 15734.4 15760.8 16082.1 10480.7 10605.8 10809.3 10809.9 11081.4 11033.7 11077.7 11107.1 11200.3 11227.8 16:31:05 INFO - PID 13817 | -------- Summary: end -------- 16:31:05 INFO - PID 13817 | 16:31:06 INFO - TEST-INFO | 13817: exit 0 16:31:06 INFO - TEST-OK | dromaeo_css | took 1112576ms 16:31:06 INFO - TEST-START | kraken 16:31:06 INFO - Initialising browser for kraken test... 16:31:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33471/getInfo.html -profile /tmp/tmpTIl6Z0/profile 16:31:06 INFO - TEST-INFO | started process 14192 (/builds/slave/test/build/application/firefox/firefox http://localhost:33471/getInfo.html) 16:31:12 INFO - TEST-INFO | 14192: exit 0 16:31:13 INFO - Browser initialized. 16:31:13 INFO - Running cycle 1/1 for kraken test... 16:31:13 INFO - TEST-INFO | started process 14418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIl6Z0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:14 INFO - PID 14418 | 16:31:14 INFO - PID 14418 | (/builds/slave/test/build/application/firefox/firefox:14472): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:31:14 INFO - PID 14418 | 16:31:24 INFO - PID 14418 | RSS: Main: 174256128 16:31:24 INFO - PID 14418 | 16:31:27 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33471/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:27 INFO - PID 14418 | RSS: Main: 178810880 16:31:27 INFO - PID 14418 | 16:31:30 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33471/tests/kraken/driver.html?testName=audio-dft) 16:31:31 INFO - PID 14418 | RSS: Main: 179941376 16:31:31 INFO - PID 14418 | 16:31:34 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33471/tests/kraken/driver.html?testName=audio-fft) 16:31:35 INFO - PID 14418 | RSS: Main: 173805568 16:31:35 INFO - PID 14418 | 16:31:37 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33471/tests/kraken/driver.html?testName=audio-oscillator) 16:31:37 INFO - PID 14418 | RSS: Main: 174886912 16:31:37 INFO - PID 14418 | 16:31:40 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:40 INFO - PID 14418 | RSS: Main: 175431680 16:31:40 INFO - PID 14418 | 16:31:43 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33471/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:44 INFO - PID 14418 | RSS: Main: 177131520 16:31:44 INFO - PID 14418 | 16:31:48 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33471/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:48 INFO - PID 14418 | RSS: Main: 177004544 16:31:48 INFO - PID 14418 | 16:31:51 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33471/tests/kraken/driver.html?testName=json-parse-financial) 16:31:52 INFO - PID 14418 | RSS: Main: 177180672 16:31:52 INFO - PID 14418 | 16:31:53 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:54 INFO - PID 14418 | RSS: Main: 177410048 16:31:54 INFO - PID 14418 | 16:31:56 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:57 INFO - PID 14418 | RSS: Main: 174338048 16:31:57 INFO - PID 14418 | 16:31:59 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:59 INFO - PID 14418 | RSS: Main: 174268416 16:31:59 INFO - PID 14418 | 16:32:02 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:03 INFO - PID 14418 | RSS: Main: 175316992 16:32:03 INFO - PID 14418 | 16:32:06 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:07 INFO - PID 14418 | RSS: Main: 174804992 16:32:07 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | Cycle 1(1): loaded http://localhost:33471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33471/tests/kraken/driver.html?testName=ai-astar) 16:32:09 INFO - PID 14418 | RSS: Main: 176168960 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | __start_tp_report 16:32:09 INFO - PID 14418 | _x_x_mozilla_page_load 16:32:09 INFO - PID 14418 | _x_x_mozilla_page_load_details 16:32:09 INFO - PID 14418 | |i|pagename|runs| 16:32:09 INFO - PID 14418 | |0;ai-astar;98;106;108;109;111;108;108;101;111;107 16:32:09 INFO - PID 14418 | |1;audio-beat-detection;142;122;145;179;118;146;152;117;170;120 16:32:09 INFO - PID 14418 | |2;audio-dft;164;164;163;163;163;171;165;166;163;170 16:32:09 INFO - PID 14418 | |3;audio-fft;74;76;75;172;75;75;74;75;157;76 16:32:09 INFO - PID 14418 | |4;audio-oscillator;79;82;129;79;78;78;128;79;79;125 16:32:09 INFO - PID 14418 | |5;imaging-gaussian-blur;114;118;117;114;114;117;119;114;114;114 16:32:09 INFO - PID 14418 | |6;imaging-darkroom;152;152;150;151;150;151;152;152;150;154 16:32:09 INFO - PID 14418 | |7;imaging-desaturate;94;94;95;94;94;94;94;100;99;94 16:32:09 INFO - PID 14418 | |8;json-parse-financial;53;53;56;53;53;52;56;55;57;53 16:32:09 INFO - PID 14418 | |9;json-stringify-tinderbox;54;54;54;59;55;57;54;55;55;60 16:32:09 INFO - PID 14418 | |10;stanford-crypto-aes;78;78;85;95;77;86;80;82;87;80 16:32:09 INFO - PID 14418 | |11;stanford-crypto-ccm;133;128;127;129;129;131;135;132;127;178 16:32:09 INFO - PID 14418 | |12;stanford-crypto-pbkdf2;174;177;197;182;195;174;169;173;181;172 16:32:09 INFO - PID 14418 | |13;stanford-crypto-sha256-iterative;77;68;65;67;67;72;66;67;64;72 16:32:09 INFO - PID 14418 | __end_tp_report 16:32:09 INFO - PID 14418 | __start_cc_report 16:32:09 INFO - PID 14418 | _x_x_mozilla_cycle_collect,979 16:32:09 INFO - PID 14418 | __end_cc_report 16:32:09 INFO - PID 14418 | __startTimestamp1502148729301__endTimestamp 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | ------- Summary: start ------- 16:32:09 INFO - PID 14418 | Number of tests: 14 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.50 stddev:4.16 (3.8%) stddev-sans-first:3.00 16:32:09 INFO - PID 14418 | Values: 98.0 106.0 108.0 109.0 111.0 108.0 108.0 101.0 111.0 107.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:145.50 stddev:22.00 (15.1%) stddev-sans-first:23.33 16:32:09 INFO - PID 14418 | Values: 142.0 122.0 145.0 179.0 118.0 146.0 152.0 117.0 170.0 120.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.97 (1.8%) stddev-sans-first:3.12 16:32:09 INFO - PID 14418 | Values: 164.0 164.0 163.0 163.0 163.0 171.0 165.0 166.0 163.0 170.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:37.91 (50.5%) stddev-sans-first:39.59 16:32:09 INFO - PID 14418 | Values: 74.0 76.0 75.0 172.0 75.0 75.0 74.0 75.0 157.0 76.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:23.32 (29.5%) stddev-sans-first:24.13 16:32:09 INFO - PID 14418 | Values: 79.0 82.0 129.0 79.0 78.0 78.0 128.0 79.0 79.0 125.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:2.01 (1.7%) stddev-sans-first:2.06 16:32:09 INFO - PID 14418 | Values: 114.0 118.0 117.0 114.0 114.0 117.0 119.0 114.0 114.0 114.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 16:32:09 INFO - PID 14418 | Values: 152.0 152.0 150.0 151.0 150.0 151.0 152.0 152.0 150.0 154.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.30 (2.4%) stddev-sans-first:2.40 16:32:09 INFO - PID 14418 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 100.0 99.0 94.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.73 (3.2%) stddev-sans-first:1.79 16:32:09 INFO - PID 14418 | Values: 53.0 53.0 56.0 53.0 53.0 52.0 56.0 55.0 57.0 53.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.21 (4.0%) stddev-sans-first:2.26 16:32:09 INFO - PID 14418 | Values: 54.0 54.0 54.0 59.0 55.0 57.0 54.0 55.0 55.0 60.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:5.55 (6.7%) stddev-sans-first:5.61 16:32:09 INFO - PID 14418 | Values: 78.0 78.0 85.0 95.0 77.0 86.0 80.0 82.0 87.0 80.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:131.50 stddev:15.37 (11.7%) stddev-sans-first:16.29 16:32:09 INFO - PID 14418 | Values: 133.0 128.0 127.0 129.0 129.0 131.0 135.0 132.0 127.0 178.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:179.00 stddev:9.61 (5.4%) stddev-sans-first:9.99 16:32:09 INFO - PID 14418 | Values: 174.0 177.0 197.0 182.0 195.0 174.0 169.0 173.0 181.0 172.0 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.50 stddev:3.98 (5.9%) stddev-sans-first:2.79 16:32:09 INFO - PID 14418 | Values: 77.0 68.0 65.0 67.0 67.0 72.0 66.0 67.0 64.0 72.0 16:32:09 INFO - PID 14418 | -------- Summary: end -------- 16:32:09 INFO - PID 14418 | 16:32:09 INFO - PID 14418 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:32:09 INFO - TEST-INFO | 14418: exit 0 16:32:09 INFO - TEST-OK | kraken | took 63681ms 16:32:09 INFO - SUITE-END | took 1176s 16:32:10 INFO - Completed test suite (00:19:36) 16:32:10 INFO - javascript benchmark 16:32:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8588.48918566961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.9539206911886, 3186.984065079674, 3198.2963747975446, 3201.7598680098968, 3247.6102867655886, 6178.629282243069, 6322.367763223681, 6326.588771729846, 6384.872302553952, 6395.616263024222, 6194.628322300665, 6297.0, 6311.747530098791, 6327.525435592326, 6360.077788720633, 5750.108733146369, 5758.251427314464, 5778.191053252548, 5793.884122317551, 5803.6517808931385, 5799.072148456248, 5823.184754134425, 5832.562557808182, 5882.647041177543, 5893.55798315126, 5795.072788353864, 5821.912671309934, 5823.883522329572, 5838.386969368219, 5886.705664716768, 5753.309602847664, 5794.942050579524, 5813.970930145365, 5864.560157988168, 5892.234009578749, 5556.611037227396, 5715.685637289947, 5716.3426205986425, 5717.228174196472, 5756.338021127582, 6149.41580549847, 6203.8138855834395, 6322.9051564226575, 6326.335734747877, 6332.208473940757, 6634.601923884582, 6709.597424154566, 6737.461003119788, 6742.797716068526, 6834.179898412222, 6789.864202715968, 6832.965835170792, 6842.315768423167, 6854.657267136673, 6861.5539989901, 6320.557560970734, 6332.145160403379, 6333.841653958688, 6337.2395312562785, 6342.682865856688, 6954.026436298922, 6976.895346569806, 6979.267176946449, 6979.685914133876, 6980.581165130108, 6592.17597800275, 6614.7023383947835, 6643.136392269071, 6664.033715111282, 6672.065910772496, 6739.224989126215, 6772.018057381652, 6773.221079575814, 6775.695093720795, 6794.524383293221, 6753.594784312859, 6781.152355955505, 6805.795826125224, 6857.142857142857, 6875.862482750317, 6775.728970841111, 6793.150856142982, 6802.3537763912345, 6883.380495755406, 6904.723811047602, 5371.086915224421, 5375.919361209585, 5446.91829622556, 5465.836024919259, 5520.944790552124, 4727.24364101749, 4732.645051621073, 4742.644301677388, 4781.904361912742, 4787.928181077286, 5808.0, 5870.589058765845, 5886.293644762656, 5898.469137777534, 5902.734376953047, 6829.590224586541, 6843.965780171166, 6849.828754281183, 6849.897251541231, 6867.862642747217, 5749.281339832521, 5853.560982926298, 5860.882782344414, 5879.588428809942, 5894.970525147347, 5969.373215812364, 6020.909686354708, 6027.547933904974, 6034.094885767082, 6039.8792024159275, 6527.314631963671, 6532.118164047888, 6613.636250006296, 6630.336966303331, 6635.170603674541, 6696.129503164558, 6742.292059333699, 6796.558223715443, 6843.213030501556, 6875.4155896749335, 6472.708728107341, 6490.967545162244, 6523.380278873499, 6523.510736694861, 6532.869342613026, 6585.6377899216, 6621.370969757865, 6624.701888414937, 6627.436667883284, 6685.364890335411, 6865.141857267841, 6888.896666550106, 6946.583205007716, 6964.477664175106, 6971.8257043572285, 6484.351564843478, 6589.934100658932, 6610.0, 6632.2372927114, 6738.427233685192, 6584.8353791155605, 6591.571547849375, 6606.9008964866525, 6607.669616519251, 6610.504212184202, 6447.129637498878, 6450.000249961264, 6511.576747511396, 6511.609303441809, 6518.413342799171, 6421.422072013541, 6502.772402965874, 6603.306652801387, 6654.800355989328, 6655.367740064686, 6441.677916104082, 6472.255690595642, 6498.772542960974, 6526.151600291932, 6550.967245163743], "value": 6185.323777738445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.3947996922185, 876.0801158783275, 1146.9655910322692, 1177.2465622001926, 1180.7402371478272, 40487.0, 41120.79439602798, 41139.58860411395, 41194.38208426876, 41200.99999999996, 40494.59505404945, 40749.79625101878, 40806.18387632246, 40810.0, 40912.386314205236, 7524.473286869935, 7625.123110842269, 7661.770146895602, 7663.540187588763, 7682.116556595979, 7511.248875112499, 7551.735689250877, 7610.086789585258, 7610.277023682741, 7610.657520411595, 7509.211532789061, 7544.924550754477, 7615.314621684048, 7643.732469363574, 7672.539647621133, 7591.013168288115, 7621.7713468595475, 7631.35133513652, 7634.885476717854, 7642.0, 7524.699012039512, 7585.544867307979, 7610.6194690265265, 7611.771646850603, 7621.58081305528, 36998.0, 37108.0, 37295.0, 37392.25215495675, 37450.43824342637, 3560.1633616100194, 3574.0, 3581.176329444216, 3586.910327241814, 3588.22853086585, 29450.70549294501, 29526.55710164349, 29577.852110739525, 29625.40749185004, 29703.25741856471, 4831.033793241366, 4950.777215025297, 5001.44984051754, 5059.62052846038, 5127.154019586764, 188553.0, 188682.0, 191159.04420477946, 191289.0, 192298.0, 42285.0, 42609.147817043486, 47355.763221183675, 47533.0, 48359.5164048355, 50696.23955640668, 50985.7450712744, 51038.234426483636, 51049.234261486105, 51097.744511277204, 16528.338866445207, 16636.916815415847, 16656.583585410463, 16657.66684666324, 16669.0, 13736.725265494633, 13750.449982000808, 13755.587332380044, 13757.518486852912, 13811.309434528233, 14048.086874353134, 14180.290985450893, 14181.858181418054, 14284.642883927778, 14436.855631443761, 5732.633331837627, 5798.449147330997, 5799.739011744482, 5956.880862382728, 5993.880122397615, 1009.3187098708343, 1016.8627235323285, 1022.5091955861079, 1025.3284098915221, 1043.1081425381342, 22974.425639358815, 23838.165664202017, 23858.16496422617, 29326.706732932398, 30026.84986575097, 1101.6144349477618, 1104.7900898829196, 1109.5312928733504, 1111.3332000799455, 1119.9104071674246, 12375.75248495025, 12517.49930002808, 12534.23874409046, 12633.305168215653, 12746.044046696536, 229790.0, 234510.0, 234946.0, 235576.0, 235629.0, 50371.0, 50521.74739126281, 50865.0, 50975.0, 50994.49005509972, 1452.3827373366278, 1476.6751314710962, 1480.4448331875547, 1490.8509149085005, 1502.233860731035, 22849.885750571142, 22937.0, 23033.424164395354, 23169.536609268056, 23285.53428931446, 36668.63331366652, 36676.0, 36757.0, 36880.26239475249, 37016.62983370132, 211565.0, 211854.0, 211909.0, 213303.0, 214397.0, 29416.55875161917, 29907.70092299049, 29940.0, 32504.83747581247, 33287.16782080467, 39764.0, 41307.96730081772, 41466.792666036476, 41671.58328416798, 41936.0, 30863.537046943864, 31154.22114447157, 31401.52897706582, 32063.839680801448, 32300.83849580737, 30747.38505229838, 30794.846025769726, 31039.379212415173, 31109.68890311068, 31351.0, 33736.49395259024, 33769.66230337665, 33858.49212261867, 33890.3221935555, 34074.63701451914, 32979.505307420884, 33406.164845879044, 33810.3237935235, 33844.15389615181, 33884.66115338815, 23943.0, 25571.36071598225, 25578.98893759928, 25664.486710266065, 25794.226173214833], "value": 17220.643908721395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.673013017515, 572.5505478199611, 575.8848230353929, 577.4571902411735, 595.2351228671157, 22717.31848044557, 22758.772412275874, 23670.05319787211, 23682.88158559207, 23738.406539836513, 25982.740172598267, 26598.202053938414, 26666.866665666694, 26669.333266668342, 26810.195694129157, 6357.300696923347, 6481.611103333791, 6503.934960650404, 6521.250056243522, 6521.282658907517, 6463.159789227418, 6544.0511125886715, 6675.365840245169, 6999.895001574981, 7081.858362832741, 7033.964830175842, 7090.042844216016, 7095.113110861143, 7095.503314767969, 7102.254263302357, 7030.7539236127, 7048.68280927357, 7062.788116356517, 7073.0, 7090.184628767706, 6886.173659160882, 6929.133858267716, 6937.098177236978, 6945.548539344977, 6954.269801670853, 31202.375952481052, 31838.363232735446, 32582.6741732582, 32876.50685239724, 33034.83482582572, 1964.6463636545416, 2002.0, 2004.6191223667602, 2007.177057406471, 2013.0035632362074, 19844.90077549603, 20357.185712571478, 20403.0, 20434.795652043587, 20452.77283363003, 2458.1519375815315, 2505.649209110726, 2541.263033720237, 2621.764041236298, 2634.183403145031, 145123.0, 148236.99999999892, 148248.2587587066, 148538.0, 148895.0, 19371.903140484206, 22260.554788904454, 22364.55270894573, 22665.2067177648, 23071.653925191134, 44617.55382446134, 44764.0, 44861.0, 44888.775556122666, 44991.32513012308, 12313.0, 12406.689832754253, 12448.066395020409, 12489.375531223403, 12516.624501264976, 9060.864087038699, 10405.115565177044, 10470.319429237228, 10481.161507079416, 10799.190060745475, 10284.0, 11645.708857278467, 11777.646670599896, 11878.643640690792, 11953.521859125538, 4534.818607255739, 4614.738777998824, 4667.95332046682, 4706.670533062653, 4833.685810422311, 970.5875003123645, 977.628501169551, 992.5979978108877, 993.4238141877694, 1005.3666190300064, 20433.69349459759, 20444.897775511326, 20613.381598552067, 20642.380728578166, 21001.789982099985, 1030.299396410448, 1032.396048311746, 1034.2656713733184, 1039.1738567838586, 1040.7970445763156, 11122.944385278022, 11166.385848778395, 11197.776044479066, 11282.661520154408, 11330.94334528322, 490071.0, 492537.0, 493538.0, 501613.0, 504550.0, 116205.0, 116871.41564292125, 117982.41008794901, 119640.0, 121089.39455302844, 1198.0475521959888, 1203.7111093337535, 1215.6960759810047, 1216.2398500936915, 1222.0406980520427, 17839.46481605554, 17875.73186402179, 17956.640867182843, 18392.908035459735, 20965.26621568238, 58210.0, 59192.0, 59611.0, 60009.39990600213, 60805.39194607997, 70458.64770676114, 70778.0, 71101.64449177722, 71606.0, 72459.63770181115, 14950.401983920521, 15434.84565154379, 15547.689046219239, 15576.299066541806, 15586.76619850726, 23599.174028908907, 24351.75648243495, 24813.503729924938, 25376.87311563504, 25449.236522904343, 19253.80746192576, 19506.90246548815, 19603.0, 19628.60742785165, 19659.0, 15939.681206376039, 17095.7435638468, 17208.913955430144, 17390.82609173892, 17902.731459027866, 17221.74167387465, 18156.364527241483, 18188.0, 18297.81702182961, 20047.0, 15048.774268385763, 15064.623384415478, 15100.773488397463, 15337.923310383376, 15348.846511534743, 17156.57108572246, 17536.210870511113, 18463.353782617545, 19124.139413726138, 19132.0], "value": 13078.089989378857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.9660008499786, 1371.0813754784294, 1376.0, 1394.0938390046474, 1418.2766788937643, 13717.519886803964, 14215.786763198561, 14364.784528232072, 14407.207603581799, 14410.0, 14509.564713058626, 14895.329710163041, 14904.552863414116, 14910.627234319147, 14930.477433289838, 2658.9734102658917, 2728.2224565998695, 2728.6998430172666, 2728.9590656140076, 2731.3308239481257, 2613.9346516337055, 2667.679878414593, 2683.5303821831103, 2707.4585082983385, 2786.7770578353784, 2718.4563087382503, 2756.517609418354, 2757.8345299282005, 2763.281546797827, 2764.14311563416, 2642.2733748219202, 2657.1895571850578, 2668.933276668089, 2670.4258584404347, 2674.9567668609257, 2610.530104581175, 2650.721674224198, 2659.6542449481635, 2660.3349162709324, 2682.383051898055, 13980.510682126076, 14042.85957140436, 14069.507567235098, 14081.0, 14099.436022559084, 7649.6940122395035, 7940.404469664741, 7948.364130869517, 7955.323797477221, 7962.681492740284, 5154.201098829687, 5246.0, 5262.236975638511, 5368.677879327252, 5378.139497680391, 1856.2574970011967, 1874.578219900525, 1887.5941672540332, 1916.444231172958, 1949.362535470212, 22968.42578935523, 23638.29085127449, 23650.172243971552, 23692.0, 23712.525749484914, 7095.787126386217, 7114.928850711427, 7173.713051477883, 7192.065031545865, 7263.745768898063, 18741.25034998612, 18765.81234187668, 18782.436526904214, 18789.0, 18789.060546972596, 7799.5320280783335, 8086.676532938734, 8096.02847658273, 8123.4313598047565, 8127.146649601825, 7057.505974581833, 7214.134303883568, 7265.0, 7280.96359518199, 7282.0, 5119.308893299357, 5393.811216607478, 5440.700761458158, 5452.618316717871, 5485.780568777204, 1573.8190108137483, 1614.53178578211, 1640.8769342299374, 1726.326732574297, 1770.9822901771074, 875.1554749666602, 895.4850960697624, 898.9146031127033, 903.3811838890381, 905.6603773584906, 7740.690372385042, 7898.960505197552, 7911.485753426009, 8007.759767206993, 8107.959460202661, 971.1745016735719, 983.8229118758549, 1012.291396022787, 1012.6127205728052, 1028.9742756430999, 5093.083245015859, 5111.667741596784, 5377.274068000848, 5441.945580544223, 5466.753996070186, 18926.62146757057, 18990.335338263096, 19563.804361956198, 19637.410877673694, 19650.21399144047, 19255.711164332548, 19340.903295483433, 19397.127129279215, 19452.902735486514, 19540.804591954184, 10544.103751181083, 10633.73415664599, 10859.619913302997, 10859.945700271606, 10937.234393592531, 8330.583800754008, 8498.235158835734, 8522.957385213282, 8824.3381746368, 8855.690050848189, 16863.662726745642, 17152.74270885913, 17278.0, 17298.567535811704, 17613.471595852145, 16918.57703557421, 17218.397356092475, 17245.65508689844, 17256.827431725524, 17842.107894604957, 12611.621651350475, 12697.682557936125, 12770.0, 12773.425195866022, 12775.552855650008, 12202.694932626755, 12226.266424014588, 12389.62831115068, 12394.132410731163, 12436.875631243573, 10500.947495262475, 10615.787684246427, 10624.309419887682, 10802.405867677038, 10907.400092994962, 10141.49292535385, 10217.438040907822, 10387.584496620353, 10520.316179448311, 10589.046985771318, 8743.081976392386, 8879.778005549913, 8912.465252084636, 8913.509756963429, 8920.24177944856, 7171.462140339391, 7185.065941427581, 7199.6760145794615, 7217.133943926762, 7254.129504459499, 7147.928520714934, 7235.421166306788, 7308.269173082649, 7343.669534871051, 7369.484136110421], "value": 6549.151692103822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.9208072748723, 516.349399756307, 526.9552088072513, 534.3454268521062, 536.8416317186432, 6124.3263241043505, 6160.199174107371, 6189.709807371268, 6196.0, 6224.315325314212, 6125.070602760127, 6181.6600086995195, 6206.565540412173, 6225.221847269091, 6229.501639868811, 5105.259737338084, 5118.846434606968, 5126.923096153542, 5158.9742051289695, 5160.0, 4830.816449969745, 5130.846074617749, 5144.3312369392115, 5152.433232344439, 5158.174692049273, 4888.388951381077, 4947.727874966876, 4951.950480495185, 4967.205247160455, 4976.253561965716, 4916.557509824133, 4980.501949805027, 4986.980272989427, 4988.551030407262, 5039.269305950654, 4390.978045109754, 4419.381286619876, 4463.397441345409, 4489.842855500075, 4494.325851122325, 6066.514678825727, 6108.694565271719, 6112.877742445171, 6113.205283313141, 6140.3552626974415, 5705.2012718219485, 5718.285214348207, 5759.884802303973, 5771.826845194651, 5775.566832487538, 6505.577137486048, 6518.250401203827, 6604.834879128012, 6609.306022867578, 6620.569662971891, 4848.539388758062, 4850.781714822841, 4862.465128835825, 4878.878028049292, 4889.731064791435, 6568.310327415648, 6666.23338316095, 6689.732410703566, 6826.863462730717, 6910.2053263874795, 4982.90034199314, 5019.447860735316, 5026.1204289249235, 5032.370953630796, 5032.72320022395, 5010.874728131826, 5031.396232452056, 5032.547070763649, 5086.313347698014, 5121.334226550524, 5684.261046063985, 5697.686627235459, 5709.685967271756, 5724.370319264877, 5749.482546570829, 6497.967510162419, 6600.174978127734, 6600.471962243009, 6622.635755033423, 6657.305195616479, 1751.2050148597534, 1753.8246175382615, 1761.7093179625474, 1763.5238485608813, 1780.8931464112195, 1185.6502331812137, 1212.1393810394718, 1223.9571614993433, 1230.7846126927932, 1238.2817965580123, 5713.800016999385, 5723.139979506677, 5746.856328591819, 5801.82594522165, 5860.912086318709, 6675.1989761228, 6701.597904125768, 6703.22912865017, 6703.966480167568, 6718.816384675, 5651.406602306781, 5709.714514274269, 5741.511971482387, 5785.595008349459, 5817.941820581825, 3541.94687079694, 3542.3800834854314, 3544.751867369311, 3562.1628917204434, 3611.2235869287706, 6451.322611125858, 6507.0, 6544.509161812788, 6560.442362399154, 6592.208934927839, 6882.5870447773295, 6911.274316196727, 6915.101036865175, 6924.840993459905, 6936.7572134975035, 6470.5147113965695, 6472.773452929219, 6495.967520162369, 6497.415232629086, 6554.344565543408, 6036.8188954331445, 6510.121133646897, 6592.736290548324, 6697.564658297195, 6715.0, 6580.7496575650475, 6591.769288074895, 6664.633445160563, 6680.732770689118, 6726.562773419712, 6396.249612666598, 6463.806085817433, 6470.094186813756, 6556.967215163893, 6565.507586930904, 4928.0, 4972.303877457087, 4985.975070124626, 5004.697838994103, 5011.4487406386, 6481.837954051187, 6620.3710647488415, 6631.734730610721, 6781.220159681699, 6788.66056697173, 6369.394907483782, 6412.23053233615, 6474.449671777763, 6532.510061745293, 6556.770513032021, 6351.714172862325, 6423.935760642334, 6460.580062295936, 6530.040987703765, 6556.541042127005, 6348.365163483615, 6358.141650877073, 6414.839629009312, 6418.935810641834, 6426.518011149276, 6502.707378168088, 6562.245341785756, 6562.376574225441, 6608.801735947929, 6634.900476492953, 6301.684915754286, 6358.682065896594, 6394.200724909387, 6420.518461115528, 6433.035044743326], "value": 5055.655173821072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.7234493479486, 921.9354645174838, 937.9062093790621, 938.5260443476044, 944.419182202945, 18219.908900455495, 19245.61508769824, 19272.132754026068, 19313.806861931378, 21638.0, 21230.89384553079, 21489.46276343092, 22006.559868802655, 22012.559748805055, 22024.229151979685, 1015.7765291635828, 1044.1229367331441, 1051.8369652703805, 1052.1109662335314, 1052.468503405779, 1023.5036007536339, 1058.4020028683808, 1061.1828891753346, 1061.6708820265703, 1063.6277302943986, 1072.399456304468, 1077.1382893685059, 1078.2937176149635, 1078.6979645699216, 1110.7112150840799, 1064.9627263045834, 1065.9946700266487, 1067.4395942130366, 1070.1706177712297, 1108.0, 782.3584660578329, 782.8786538086606, 783.3615603283306, 792.0416296281506, 815.2377527012203, 19464.124114414884, 19884.70172947407, 19910.0, 19917.402477925687, 21016.5796684067, 21740.0, 22214.0, 22234.0, 22259.44351391212, 22266.0, 16507.83492165075, 16797.32810687571, 17000.659986800318, 17078.06070666113, 17189.914050429667, 3662.963370366289, 3672.706183505313, 3682.0978860179425, 3692.9261414771554, 3695.5565332160045, 125489.0, 127541.36229318794, 128396.0, 132157.99999999904, 133220.0, 16891.0, 17325.393611223797, 17453.12734363277, 17469.912650436665, 17525.64948701019, 31167.844160779052, 31640.208994774854, 31779.20551986219, 31822.840885795424, 31915.202119947186, 7880.64537095832, 8161.673533058611, 8172.346212303001, 8180.713675021346, 8804.47173169612, 3967.4048892666333, 4059.3910913362643, 4070.7964601769795, 4084.223997440477, 4095.1809638072505, 5076.517730815566, 5094.439611642716, 5119.129747942859, 5121.9743901281, 5143.871403214875, 1069.0, 1090.4983707494641, 1097.8188598881095, 1111.9944400277948, 1112.3715100967927, 645.515863102673, 649.8245473722069, 654.2084078265257, 657.8190997475637, 682.2938258902112, 11344.602938897098, 11410.600628977945, 11431.028362589106, 11649.728302981006, 12491.312977786309, 651.9348065193537, 659.2715049869921, 659.8020593821834, 664.4983037806426, 679.9354061364163, 5034.144195486776, 5115.974420127875, 5152.716600587004, 5233.790648374023, 5275.0, 99115.0, 101169.98830011606, 105307.94692053135, 108047.0, 108722.45638771755, 91996.72602411595, 93511.53244233735, 95477.0, 96666.0, 99465.0, 79019.60490197512, 79944.60027699941, 81010.99999999882, 81637.59181204175, 83776.0, 10166.339187952759, 10179.338343007681, 10202.795944081225, 10217.008096722317, 10326.638567650096, 37579.81210093932, 37593.62406375901, 37693.434598481595, 39135.0, 39712.2057558853, 47286.527134729586, 48382.758086209345, 48410.0, 49204.507954919995, 50090.74954625204, 14893.106413615218, 14914.179720115064, 14937.178455185069, 14989.700205996038, 15130.092194468367, 15778.13220272896, 15873.68252634964, 15879.364825406854, 15911.363545458053, 16015.35938562491, 15778.368865245262, 15802.20988950525, 15847.603809904844, 15867.761983570024, 16299.511014669579, 15373.0, 15373.615659608598, 15375.76936345978, 15729.292181851615, 15748.055116693035, 15640.139792311533, 15663.295151718428, 15734.370625174864, 15760.769042346521, 16082.115483648511, 10480.68557943263, 10605.787884242427, 10809.297395669257, 10809.891901080888, 11081.445927703422, 11033.668989930315, 11077.66766996959, 11107.111431085332, 11200.327980321206, 11227.831582526433], "value": 8700.708835831872, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 108.0, 109.0, 111.0, 108.0, 108.0, 101.0, 111.0, 107.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 145.0, 179.0, 118.0, 146.0, 152.0, 117.0, 170.0, 120.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 163.0, 171.0, 165.0, 166.0, 163.0, 170.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 172.0, 75.0, 75.0, 74.0, 75.0, 157.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 129.0, 79.0, 78.0, 78.0, 128.0, 79.0, 79.0, 125.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 114.0, 114.0, 117.0, 119.0, 114.0, 114.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 151.0, 150.0, 151.0, 152.0, 152.0, 150.0, 154.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 100.0, 99.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 53.0, 53.0, 52.0, 56.0, 55.0, 57.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 59.0, 55.0, 57.0, 54.0, 55.0, 55.0, 60.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 85.0, 95.0, 77.0, 86.0, 80.0, 82.0, 87.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 127.0, 129.0, 129.0, 131.0, 135.0, 132.0, 127.0, 178.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 197.0, 182.0, 195.0, 174.0, 169.0, 173.0, 181.0, 172.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 68.0, 65.0, 67.0, 67.0, 72.0, 66.0, 67.0, 64.0, 72.0], "value": 68.5, "unit": "score"}]}]} 16:32:10 INFO - Return code: 0 16:32:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:10 INFO - # TBPL SUCCESS # 16:32:10 INFO - Running post-action listener: _package_coverage_data 16:32:10 INFO - Running post-action listener: _resource_record_post_action 16:32:10 INFO - [mozharness: 2017-08-07 23:32:10.559640Z] Finished run-tests step (success) 16:32:10 INFO - Running post-run listener: _resource_record_post_run 16:32:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431271936; Read time: 16; Write time: 305040 16:32:10 INFO - TinderboxPrint: CPU usage
13.2% 16:32:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:32:10 INFO - TinderboxPrint: I/O write bytes / time
431,271,936 / 305,040 16:32:10 INFO - TinderboxPrint: CPU idle
8,273.3 (86.8%) 16:32:10 INFO - TinderboxPrint: CPU user
1,206.8 (12.7%) 16:32:10 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106340352; Read time: 0; Write time: 84868 16:32:10 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:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 324276224; Read time: 0; Write time: 220132 16:32:11 INFO - Running post-run listener: _upload_blobber_files 16:32:11 INFO - Blob upload gear active. 16:32:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:11 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:11 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:11 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:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:17 INFO - (blobuploader) - INFO - Done attempting. 16:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:20 INFO - (blobuploader) - INFO - Done attempting. 16:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:29 INFO - (blobuploader) - INFO - Done attempting. 16:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:33 INFO - (blobuploader) - INFO - Done attempting. 16:32:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:33 INFO - Return code: 0 16:32:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70697f42e4a607ef4d3cc1e30597e8cedc50a1d2aa1115da4aa34ed94f1e8711eb72bcd1d02073138e4e530495a2962a01c19951d901973bda943c4602825216", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5753022074101c54373c15799d1ab61e43de07dd727c67db80c3b09637fae9d9367e41b889da325e612be76aa2513fc7d5937ab67a514961bb30a6051e706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55561461e6fbeaae7f222c77bcffee62f081d73fd948ebfeb0a64b3d16d6517b1aea54ed3df159a25aa4a4418cd18ecd6347c1667496c029f5ba0a2ad1ebf692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772c5fcc4482ba0a45f8a4d90bc6ce14a56cc6f9633314ea221439bf876afc469aa7f097666f44c79c87859271f00c408a0987b2922d2dbbf33470fff1f94cb8"} 16:32:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:33 INFO - Contents: 16:32:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70697f42e4a607ef4d3cc1e30597e8cedc50a1d2aa1115da4aa34ed94f1e8711eb72bcd1d02073138e4e530495a2962a01c19951d901973bda943c4602825216", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5753022074101c54373c15799d1ab61e43de07dd727c67db80c3b09637fae9d9367e41b889da325e612be76aa2513fc7d5937ab67a514961bb30a6051e706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55561461e6fbeaae7f222c77bcffee62f081d73fd948ebfeb0a64b3d16d6517b1aea54ed3df159a25aa4a4418cd18ecd6347c1667496c029f5ba0a2ad1ebf692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772c5fcc4482ba0a45f8a4d90bc6ce14a56cc6f9633314ea221439bf876afc469aa7f097666f44c79c87859271f00c408a0987b2922d2dbbf33470fff1f94cb8"} 16:32:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:33 INFO - Copying logs to upload dir... 16:32:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.199121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-08-07 16:32:33.140982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 16:32:33.149946) ========= 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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70697f42e4a607ef4d3cc1e30597e8cedc50a1d2aa1115da4aa34ed94f1e8711eb72bcd1d02073138e4e530495a2962a01c19951d901973bda943c4602825216", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5753022074101c54373c15799d1ab61e43de07dd727c67db80c3b09637fae9d9367e41b889da325e612be76aa2513fc7d5937ab67a514961bb30a6051e706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55561461e6fbeaae7f222c77bcffee62f081d73fd948ebfeb0a64b3d16d6517b1aea54ed3df159a25aa4a4418cd18ecd6347c1667496c029f5ba0a2ad1ebf692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772c5fcc4482ba0a45f8a4d90bc6ce14a56cc6f9633314ea221439bf876afc469aa7f097666f44c79c87859271f00c408a0987b2922d2dbbf33470fff1f94cb8"} build_url:https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/YyZs7crNS8KmVZtD6qtlsg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70697f42e4a607ef4d3cc1e30597e8cedc50a1d2aa1115da4aa34ed94f1e8711eb72bcd1d02073138e4e530495a2962a01c19951d901973bda943c4602825216", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5753022074101c54373c15799d1ab61e43de07dd727c67db80c3b09637fae9d9367e41b889da325e612be76aa2513fc7d5937ab67a514961bb30a6051e706", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55561461e6fbeaae7f222c77bcffee62f081d73fd948ebfeb0a64b3d16d6517b1aea54ed3df159a25aa4a4418cd18ecd6347c1667496c029f5ba0a2ad1ebf692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772c5fcc4482ba0a45f8a4d90bc6ce14a56cc6f9633314ea221439bf876afc469aa7f097666f44c79c87859271f00c408a0987b2922d2dbbf33470fff1f94cb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 16:32:33.174799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:32:33.175148) ========= 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=826874ccc97bd7bf541b4875000001d5-1502147481.882361-1822512002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 16:32:33.260316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 16:32:33.262695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 16:32:33.263021) ========= ========= Total master_lag: 0.17 =========