builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1501581614.96 results: success (0) revision: 8d09df72c2e9b923bb84fe9741a668988834c393 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:14.959872) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:14.960295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:14.970622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:15.641180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:15.641494) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 03:00:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.9M=0s 2017-08-01 03:00:16 (49.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131490 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:15.889062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:15.889357) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014505 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:15.993225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.010579) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d09df72c2e9b923bb84fe9741a668988834c393 --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 8d09df72c2e9b923bb84fe9741a668988834c393 --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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 03:00:16,324 truncating revision to first 12 chars 2017-08-01 03:00:16,324 Setting DEBUG logging. 2017-08-01 03:00:16,324 attempt 1/10 2017-08-01 03:00:16,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d09df72c2e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 03:00:16,806 unpacking tar archive at: mozilla-central-8d09df72c2e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794878 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.879722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.880029) ========= script_repo_revision: 8d09df72c2e9b923bb84fe9741a668988834c393 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.880401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.886715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:00:16.925921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-01 03:00:16.926214) ========= /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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:00:17 INFO - MultiFileLogger online at 20170801 03:00:17 in /builds/slave/test 03:00:17 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 03:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:17 INFO - {'append_to_log': False, 03:00:17 INFO - 'base_work_dir': '/builds/slave/test', 03:00:17 INFO - 'blob_upload_branch': 'Firefox', 03:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:17 INFO - 'branch': 'Firefox', 03:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:17 INFO - 'code_coverage': False, 03:00:17 INFO - 'config_files': ('talos/linux_config.py',), 03:00:17 INFO - 'default_actions': ('clobber', 03:00:17 INFO - 'read-buildbot-config', 03:00:17 INFO - 'download-and-extract', 03:00:17 INFO - 'populate-webroot', 03:00:17 INFO - 'create-virtualenv', 03:00:17 INFO - 'install', 03:00:17 INFO - 'setup-mitmproxy', 03:00:17 INFO - 'run-tests'), 03:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:17 INFO - 'disable_ccov_upload': False, 03:00:17 INFO - 'download_minidump_stackwalk': True, 03:00:17 INFO - 'download_symbols': 'ondemand', 03:00:17 INFO - 'enable_stylo': False, 03:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:17 INFO - 'gecko_profile': False, 03:00:17 INFO - 'gecko_profile_interval': 0, 03:00:17 INFO - 'installer_path': 'installer.exe', 03:00:17 INFO - 'log_level': 'info', 03:00:17 INFO - 'log_name': 'talos', 03:00:17 INFO - 'log_to_console': True, 03:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:00:17 INFO - 'opt_config_files': (), 03:00:17 INFO - 'pip_index': False, 03:00:17 INFO - 'suite': 'dromaeojs-e10s', 03:00:17 INFO - 'system_bits': '32', 03:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:17 INFO - 'title': 'talos-linux64-ix-036', 03:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:17 INFO - 'use_talos_json': True, 03:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:17 INFO - 'work_dir': 'build'} 03:00:17 INFO - [mozharness: 2017-08-01 10:00:17.290175Z] Running clobber step. 03:00:17 INFO - Running pre-action listener: _resource_record_pre_action 03:00:17 INFO - Running main action method: clobber 03:00:17 INFO - rmtree: /builds/slave/test/build 03:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:18 INFO - Running post-action listener: _resource_record_post_action 03:00:18 INFO - [mozharness: 2017-08-01 10:00:18.982847Z] Finished clobber step (success) 03:00:18 INFO - [mozharness: 2017-08-01 10:00:18.982947Z] Running read-buildbot-config step. 03:00:18 INFO - Running pre-action listener: _resource_record_pre_action 03:00:18 INFO - Running main action method: read_buildbot_config 03:00:18 INFO - Using buildbot properties: 03:00:18 INFO - { 03:00:18 INFO - "project": "", 03:00:18 INFO - "product": "firefox", 03:00:18 INFO - "who": "archaeopteryx@coole-files.de", 03:00:18 INFO - "installer_path": "public/build/target.tar.bz2", 03:00:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:00:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:00:18 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:00:18 INFO - "stage_platform": "linux64-stylosequential", 03:00:18 INFO - "basedir": "/builds/slave/test", 03:00:18 INFO - "buildnumber": 11, 03:00:18 INFO - "platform": "ubuntu64_hw_styloseq", 03:00:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:00:18 INFO - "slavebuilddir": "test", 03:00:18 INFO - "taskId": "NX-33Cp2Slm9jrSQ0gQ8dQ", 03:00:18 INFO - "branch": "mozilla-central", 03:00:18 INFO - "script_repo_revision": "production", 03:00:18 INFO - "revision": "8d09df72c2e9b923bb84fe9741a668988834c393", 03:00:18 INFO - "slavename": "talos-linux64-ix-036", 03:00:18 INFO - "repo_path": "mozilla-central" 03:00:18 INFO - } 03:00:18 INFO - Finding installer, test and symbols from parent task. 03:00:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NX-33Cp2Slm9jrSQ0gQ8dQ'}, attempt #1 03:00:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NX-33Cp2Slm9jrSQ0gQ8dQ'}, attempt #1 03:00:19 INFO - Task dependencies: K1rcztDYQuCRwJgRJPvvbg 03:00:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg'}, attempt #1 03:00:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 03:00:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.test_packages.json 03:00:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.crashreporter-symbols.zip 03:00:20 INFO - Running post-action listener: _resource_record_post_action 03:00:20 INFO - [mozharness: 2017-08-01 10:00:20.314129Z] Finished read-buildbot-config step (success) 03:00:20 INFO - [mozharness: 2017-08-01 10:00:20.314350Z] Running download-and-extract step. 03:00:20 INFO - Running pre-action listener: _resource_record_pre_action 03:00:20 INFO - Running main action method: download_and_extract 03:00:20 INFO - mkdir: /builds/slave/test/build/tests 03:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:20 INFO - trying https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.test_packages.json 03:00:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:00:20 INFO - Downloaded 989 bytes. 03:00:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:00:20 INFO - Using the following test package requirements: 03:00:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:00:20 INFO - u'common': [u'target.common.tests.zip'], 03:00:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:00:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:00:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:00:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:00:20 INFO - u'mozbase': [u'target.common.tests.zip'], 03:00:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:00:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:00:20 INFO - u'web-platform': [u'target.common.tests.zip', 03:00:20 INFO - u'target.web-platform.tests.tar.gz'], 03:00:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:00:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip 03:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip into memory 03:00:22 INFO - Content-Length response header: 72390344 03:00:22 INFO - Bytes received: 72390344 03:00:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:00:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip 03:00:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:00:33 INFO - Fetch https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.common.tests.zip into memory 03:00:35 INFO - Content-Length response header: 72390344 03:00:35 INFO - Bytes received: 72390344 03:00:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.talos.tests.zip 03:00:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:00:47 INFO - Fetch https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.talos.tests.zip into memory 03:00:48 INFO - Content-Length response header: 14496467 03:00:48 INFO - Bytes received: 14496467 03:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:48 INFO - trying https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 03:00:48 INFO - Downloading https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:00:49 INFO - Downloaded 62277921 bytes. 03:00:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 03:00:49 INFO - mkdir: /builds/slave/test/properties 03:00:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:49 INFO - Contents: 03:00:49 INFO - build_url:https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 03:00:49 INFO - Running post-action listener: _resource_record_post_action 03:00:49 INFO - Running post-action listener: set_extra_try_arguments 03:00:49 INFO - [mozharness: 2017-08-01 10:00:49.550289Z] Finished download-and-extract step (success) 03:00:49 INFO - [mozharness: 2017-08-01 10:00:49.550387Z] Running populate-webroot step. 03:00:49 INFO - Running pre-action listener: _resource_record_pre_action 03:00:49 INFO - Running main action method: populate_webroot 03:00:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:49 INFO - 'tests': ['damp', 'tps']}, 03:00:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:00:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:00:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:00:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:49 INFO - 'ts_paint', 03:00:49 INFO - 'tpaint', 03:00:49 INFO - 'sessionrestore', 03:00:49 INFO - 'sessionrestore_many_windows', 03:00:49 INFO - 'sessionrestore_no_auto_restore', 03:00:49 INFO - 'tabpaint']}, 03:00:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:00:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:00:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:49 INFO - 'talos_options': ['--mitmproxy', 03:00:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:49 INFO - '--firstNonBlankPaint'], 03:00:49 INFO - 'tests': ['quantum_pageload_google', 03:00:49 INFO - 'quantum_pageload_youtube', 03:00:49 INFO - 'quantum_pageload_amazon', 03:00:49 INFO - 'quantum_pageload_facebook']}, 03:00:49 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:49 INFO - 'talos_options': ['--stylo', 03:00:49 INFO - '--mitmproxy', 03:00:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:49 INFO - '--firstNonBlankPaint'], 03:00:49 INFO - 'tests': ['quantum_pageload_google', 03:00:49 INFO - 'quantum_pageload_youtube', 03:00:49 INFO - 'quantum_pageload_amazon', 03:00:49 INFO - 'quantum_pageload_facebook']}, 03:00:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:49 INFO - 'tsvgr_opacity', 03:00:49 INFO - 'tart', 03:00:49 INFO - 'tscrollx', 03:00:49 INFO - 'cart', 03:00:49 INFO - 'tsvg_static']}, 03:00:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:49 INFO - 'talos_options': ['--stylo', 03:00:49 INFO - '--stylo-threads=1', 03:00:49 INFO - '--mitmproxy', 03:00:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:49 INFO - '--firstNonBlankPaint'], 03:00:49 INFO - 'tests': ['tp6_google', 03:00:49 INFO - 'tp6_youtube', 03:00:49 INFO - 'tp6_amazon', 03:00:49 INFO - 'tp6_facebook']}, 03:00:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:49 INFO - 'talos_options': ['--xperf_path', 03:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:49 INFO - 'tests': ['tp5n']}}} 03:00:49 INFO - Running post-action listener: _resource_record_post_action 03:00:49 INFO - [mozharness: 2017-08-01 10:00:49.558994Z] Finished populate-webroot step (success) 03:00:49 INFO - [mozharness: 2017-08-01 10:00:49.559083Z] Running create-virtualenv step. 03:00:49 INFO - Running pre-action listener: _resource_record_pre_action 03:00:49 INFO - Running main action method: create_virtualenv 03:00:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:49 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 03:00:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:00:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:49 INFO - Using real prefix '/usr' 03:00:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:52 INFO - Installing pip.................done. 03:00:52 INFO - Return code: 0 03:00:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:52 INFO - Reading from file tmpfile_stdout 03:00:52 INFO - Output received: 03:00:52 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) 03:00:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:52 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')]} 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:52 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')]} 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:52 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00:52 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 03:00:52 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 03:00:52 INFO - Using env: {'DISPLAY': ':0', 03:00:52 INFO - 'HOME': '/home/cltbld', 03:00:52 INFO - 'LANG': 'en_US.UTF-8', 03:00:52 INFO - 'LANGUAGE': 'en_US:en', 03:00:52 INFO - 'LOGNAME': 'cltbld', 03:00:52 INFO - 'MAIL': '/var/mail/cltbld', 03:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:52 INFO - 'MOZ_NO_REMOTE': '1', 03:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:52 INFO - 'NO_EM_RESTART': '1', 03:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:52 INFO - 'PWD': '/builds/slave/test', 03:00:52 INFO - 'SHELL': '/bin/bash', 03:00:52 INFO - 'SHLVL': '1', 03:00:52 INFO - 'TERM': 'linux', 03:00:52 INFO - 'TMOUT': '86400', 03:00:52 INFO - 'USER': 'cltbld', 03:00:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:52 INFO - '_': '/tools/buildbot/bin/python'} 03:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:52 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 03:00:52 INFO - Cleaning up... 03:00:52 INFO - Return code: 0 03:00:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:52 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')]} 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:52 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')]} 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:52 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00:52 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 03:00:52 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 03:00:52 INFO - Using env: {'DISPLAY': ':0', 03:00:52 INFO - 'HOME': '/home/cltbld', 03:00:52 INFO - 'LANG': 'en_US.UTF-8', 03:00:52 INFO - 'LANGUAGE': 'en_US:en', 03:00:52 INFO - 'LOGNAME': 'cltbld', 03:00:52 INFO - 'MAIL': '/var/mail/cltbld', 03:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:52 INFO - 'MOZ_NO_REMOTE': '1', 03:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:52 INFO - 'NO_EM_RESTART': '1', 03:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:52 INFO - 'PWD': '/builds/slave/test', 03:00:52 INFO - 'SHELL': '/bin/bash', 03:00:52 INFO - 'SHLVL': '1', 03:00:52 INFO - 'TERM': 'linux', 03:00:52 INFO - 'TMOUT': '86400', 03:00:52 INFO - 'USER': 'cltbld', 03:00:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:52 INFO - '_': '/tools/buildbot/bin/python'} 03:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:52 INFO - Downloading/unpacking psutil>=3.1.1 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:53 INFO - Installing collected packages: psutil 03:00:53 INFO - Running setup.py install for psutil 03:00:54 INFO - building 'psutil._psutil_linux' extension 03:00:54 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 03:00:54 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 03:00:54 INFO - building 'psutil._psutil_posix' extension 03:00:54 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 03:00:54 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 03:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:54 INFO - Successfully installed psutil 03:00:54 INFO - Cleaning up... 03:00:54 INFO - Return code: 0 03:00:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00:54 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 03:00:54 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 03:00:54 INFO - Using env: {'DISPLAY': ':0', 03:00:54 INFO - 'HOME': '/home/cltbld', 03:00:54 INFO - 'LANG': 'en_US.UTF-8', 03:00:54 INFO - 'LANGUAGE': 'en_US:en', 03:00:54 INFO - 'LOGNAME': 'cltbld', 03:00:54 INFO - 'MAIL': '/var/mail/cltbld', 03:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:54 INFO - 'MOZ_NO_REMOTE': '1', 03:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:54 INFO - 'NO_EM_RESTART': '1', 03:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:54 INFO - 'PWD': '/builds/slave/test', 03:00:54 INFO - 'SHELL': '/bin/bash', 03:00:54 INFO - 'SHLVL': '1', 03:00:54 INFO - 'TERM': 'linux', 03:00:54 INFO - 'TMOUT': '86400', 03:00:54 INFO - 'USER': 'cltbld', 03:00:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:54 INFO - '_': '/tools/buildbot/bin/python'} 03:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:54 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 03:00:54 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 03:00:54 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 03:00:54 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 03:00:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:55 INFO - Installing collected packages: mozsystemmonitor 03:00:55 INFO - Running setup.py install for mozsystemmonitor 03:00:55 INFO - Successfully installed mozsystemmonitor 03:00:55 INFO - Cleaning up... 03:00:55 INFO - Return code: 0 03:00:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:55 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')]} 03:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:55 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')]} 03:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:55 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00:55 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 03:00:55 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 03:00:55 INFO - Using env: {'DISPLAY': ':0', 03:00:55 INFO - 'HOME': '/home/cltbld', 03:00:55 INFO - 'LANG': 'en_US.UTF-8', 03:00:55 INFO - 'LANGUAGE': 'en_US:en', 03:00:55 INFO - 'LOGNAME': 'cltbld', 03:00:55 INFO - 'MAIL': '/var/mail/cltbld', 03:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:55 INFO - 'MOZ_NO_REMOTE': '1', 03:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:55 INFO - 'NO_EM_RESTART': '1', 03:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:55 INFO - 'PWD': '/builds/slave/test', 03:00:55 INFO - 'SHELL': '/bin/bash', 03:00:55 INFO - 'SHLVL': '1', 03:00:55 INFO - 'TERM': 'linux', 03:00:55 INFO - 'TMOUT': '86400', 03:00:55 INFO - 'USER': 'cltbld', 03:00:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:55 INFO - '_': '/tools/buildbot/bin/python'} 03:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:56 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:56 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 03:00:56 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 03:00:56 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 03:00:56 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 03:00:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00: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 03:00: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 03:00: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 03:00: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 03:00:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:57 INFO - warning: no files found matching '*.txt' 03:00:57 INFO - no previously-included directories found matching 'build' 03:00:57 INFO - no previously-included directories found matching 'dist' 03:00:57 INFO - no previously-included directories found matching '.git*' 03:00:57 INFO - Installing collected packages: jsonschema, functools32 03:00:57 INFO - Running setup.py install for functools32 03:00:57 INFO - warning: no files found matching '*.txt' 03:00:57 INFO - no previously-included directories found matching 'build' 03:00:57 INFO - no previously-included directories found matching 'dist' 03:00:57 INFO - no previously-included directories found matching '.git*' 03:00:57 INFO - Successfully installed jsonschema functools32 03:00:57 INFO - Cleaning up... 03:00:57 INFO - Return code: 0 03:00:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00: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', '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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00: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 functools32==3.2.3-2 03:00:57 INFO - Using env: {'DISPLAY': ':0', 03:00:57 INFO - 'HOME': '/home/cltbld', 03:00:57 INFO - 'LANG': 'en_US.UTF-8', 03:00:57 INFO - 'LANGUAGE': 'en_US:en', 03:00:57 INFO - 'LOGNAME': 'cltbld', 03:00:57 INFO - 'MAIL': '/var/mail/cltbld', 03:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:57 INFO - 'MOZ_NO_REMOTE': '1', 03:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:57 INFO - 'NO_EM_RESTART': '1', 03:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:57 INFO - 'PWD': '/builds/slave/test', 03:00:57 INFO - 'SHELL': '/bin/bash', 03:00:57 INFO - 'SHLVL': '1', 03:00:57 INFO - 'TERM': 'linux', 03:00:57 INFO - 'TMOUT': '86400', 03:00:57 INFO - 'USER': 'cltbld', 03:00:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:57 INFO - '_': '/tools/buildbot/bin/python'} 03:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:57 INFO - Cleaning up... 03:00:57 INFO - Return code: 0 03:00:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00: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', '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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00: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 blobuploader==1.2.4 03:00:57 INFO - Using env: {'DISPLAY': ':0', 03:00:57 INFO - 'HOME': '/home/cltbld', 03:00:57 INFO - 'LANG': 'en_US.UTF-8', 03:00:57 INFO - 'LANGUAGE': 'en_US:en', 03:00:57 INFO - 'LOGNAME': 'cltbld', 03:00:57 INFO - 'MAIL': '/var/mail/cltbld', 03:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:57 INFO - 'MOZ_NO_REMOTE': '1', 03:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:57 INFO - 'NO_EM_RESTART': '1', 03:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:57 INFO - 'PWD': '/builds/slave/test', 03:00:57 INFO - 'SHELL': '/bin/bash', 03:00:57 INFO - 'SHLVL': '1', 03:00:57 INFO - 'TERM': 'linux', 03:00:57 INFO - 'TMOUT': '86400', 03:00:57 INFO - 'USER': 'cltbld', 03:00:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:57 INFO - '_': '/tools/buildbot/bin/python'} 03:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00: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 03:00: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 03:00: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 03:00: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 03:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00: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 03:00: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 03:00: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 03:00: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 03:00:59 INFO - Downloading docopt-0.6.1.tar.gz 03:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:59 INFO - Running setup.py install for blobuploader 03:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:59 INFO - Running setup.py install for requests 03:01:00 INFO - Running setup.py install for docopt 03:01:00 INFO - Successfully installed blobuploader requests docopt 03:01:00 INFO - Cleaning up... 03:01:00 INFO - Return code: 0 03:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:00 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:01:00 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 03:01:00 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 03:01:00 INFO - Using env: {'DISPLAY': ':0', 03:01:00 INFO - 'HOME': '/home/cltbld', 03:01:00 INFO - 'LANG': 'en_US.UTF-8', 03:01:00 INFO - 'LANGUAGE': 'en_US:en', 03:01:00 INFO - 'LOGNAME': 'cltbld', 03:01:00 INFO - 'MAIL': '/var/mail/cltbld', 03:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:00 INFO - 'MOZ_NO_REMOTE': '1', 03:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:00 INFO - 'NO_EM_RESTART': '1', 03:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:00 INFO - 'PWD': '/builds/slave/test', 03:01:00 INFO - 'SHELL': '/bin/bash', 03:01:00 INFO - 'SHLVL': '1', 03:01:00 INFO - 'TERM': 'linux', 03:01:00 INFO - 'TMOUT': '86400', 03:01:00 INFO - 'USER': 'cltbld', 03:01:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:00 INFO - '_': '/tools/buildbot/bin/python'} 03:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:00 INFO - Running setup.py (path:/tmp/pip-mk5yCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:00 INFO - Running setup.py (path:/tmp/pip-m4ByQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:00 INFO - Running setup.py (path:/tmp/pip-j2jPpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:00 INFO - Running setup.py (path:/tmp/pip-WK2llH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:00 INFO - Running setup.py (path:/tmp/pip-3FNxgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:00 INFO - Running setup.py (path:/tmp/pip-nAN4fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:01 INFO - Running setup.py (path:/tmp/pip-tK4ne4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:01 INFO - Running setup.py (path:/tmp/pip-_DkKOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:01 INFO - Running setup.py (path:/tmp/pip-XYXIdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:01 INFO - Running setup.py (path:/tmp/pip-OKLeuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:01 INFO - Running setup.py (path:/tmp/pip-okVgQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:01 INFO - Running setup.py (path:/tmp/pip-isujD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:01 INFO - Running setup.py (path:/tmp/pip-vCUugK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:01 INFO - Running setup.py (path:/tmp/pip-ourj17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:01 INFO - Running setup.py (path:/tmp/pip-yHbaNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:01 INFO - Running setup.py (path:/tmp/pip-gB_aiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:01 INFO - Running setup.py (path:/tmp/pip-KEgzMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:01 INFO - Running setup.py install for manifestparser 03:01:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:01 INFO - Running setup.py install for mozcrash 03:01:02 INFO - Running setup.py install for mozdebug 03:01:02 INFO - Running setup.py install for mozdevice 03:01:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for mozfile 03:01:02 INFO - Running setup.py install for mozhttpd 03:01:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for mozinfo 03:01:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for mozInstall 03:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for mozleak 03:01:02 INFO - Running setup.py install for mozlog 03:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for moznetwork 03:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:02 INFO - Running setup.py install for mozprocess 03:01:03 INFO - Running setup.py install for mozprofile 03:01:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:03 INFO - Running setup.py install for mozrunner 03:01:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:03 INFO - Running setup.py install for mozscreenshot 03:01:03 INFO - Running setup.py install for moztest 03:01:03 INFO - Running setup.py install for mozversion 03:01:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:03 INFO - Cleaning up... 03:01:03 INFO - Return code: 0 03:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01: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')]} 03:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:03 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:01:03 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 03:01:03 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 03:01:03 INFO - Using env: {'DISPLAY': ':0', 03:01:03 INFO - 'HOME': '/home/cltbld', 03:01:03 INFO - 'LANG': 'en_US.UTF-8', 03:01:03 INFO - 'LANGUAGE': 'en_US:en', 03:01:03 INFO - 'LOGNAME': 'cltbld', 03:01:03 INFO - 'MAIL': '/var/mail/cltbld', 03:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:03 INFO - 'MOZ_NO_REMOTE': '1', 03:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:03 INFO - 'NO_EM_RESTART': '1', 03:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:03 INFO - 'PWD': '/builds/slave/test', 03:01:03 INFO - 'SHELL': '/bin/bash', 03:01:03 INFO - 'SHLVL': '1', 03:01:03 INFO - 'TERM': 'linux', 03:01:03 INFO - 'TMOUT': '86400', 03:01:03 INFO - 'USER': 'cltbld', 03:01:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:03 INFO - '_': '/tools/buildbot/bin/python'} 03:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:03 INFO - Running setup.py (path:/tmp/pip-WfITwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:03 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)) 03:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:03 INFO - Running setup.py (path:/tmp/pip-qXZ4jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:03 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)) 03:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:03 INFO - Running setup.py (path:/tmp/pip-DlbhMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:04 INFO - Running setup.py (path:/tmp/pip-nE1iIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:04 INFO - Running setup.py (path:/tmp/pip-L_jXJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:04 INFO - Running setup.py (path:/tmp/pip-7Qg3Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:04 INFO - Running setup.py (path:/tmp/pip-hSJzWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:04 INFO - Running setup.py (path:/tmp/pip-iNb7vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:04 INFO - Running setup.py (path:/tmp/pip-Nv_ZAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:04 INFO - Running setup.py (path:/tmp/pip-QsSgrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:04 INFO - Running setup.py (path:/tmp/pip-aghuq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:04 INFO - Running setup.py (path:/tmp/pip-Pwy5tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:04 INFO - Running setup.py (path:/tmp/pip-D2U1ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:04 INFO - Running setup.py (path:/tmp/pip-jIV3gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:04 INFO - Running setup.py (path:/tmp/pip-bKir9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:04 INFO - Running setup.py (path:/tmp/pip-F1iLef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:04 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)) 03:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:04 INFO - Running setup.py (path:/tmp/pip-YyXEo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:05 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)) 03:01:05 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)) 03:01:05 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)) 03:01:05 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)) 03:01:05 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)) 03:01:05 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)) 03:01:05 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)) 03:01:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01: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 03:01: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 03:01: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 03:01: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 03:01:06 INFO - Downloading blessings-1.6.tar.gz 03:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:06 INFO - Installing collected packages: blessings 03:01:06 INFO - Running setup.py install for blessings 03:01:06 INFO - Successfully installed blessings 03:01:06 INFO - Cleaning up... 03:01:06 INFO - Return code: 0 03:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:06 INFO - Reading from file tmpfile_stdout 03:01:06 INFO - Current package versions: 03:01:06 INFO - argparse == 1.2.1 03:01:06 INFO - blessings == 1.6 03:01:06 INFO - blobuploader == 1.2.4 03:01:06 INFO - docopt == 0.6.1 03:01:06 INFO - functools32 == 3.2.3-2 03:01:06 INFO - jsonschema == 2.5.1 03:01:06 INFO - manifestparser == 1.1 03:01:06 INFO - mozInstall == 1.13 03:01:06 INFO - mozcrash == 1.0 03:01:06 INFO - mozdebug == 0.1 03:01:06 INFO - mozdevice == 0.51 03:01:06 INFO - mozfile == 1.2 03:01:06 INFO - mozhttpd == 0.7 03:01:06 INFO - mozinfo == 0.10 03:01:06 INFO - mozleak == 0.1 03:01:06 INFO - mozlog == 3.5 03:01:06 INFO - moznetwork == 0.27 03:01:06 INFO - mozprocess == 0.25 03:01:06 INFO - mozprofile == 0.28 03:01:06 INFO - mozrunner == 6.13 03:01:06 INFO - mozscreenshot == 0.1 03:01:06 INFO - mozsystemmonitor == 0.3 03:01:06 INFO - moztest == 0.8 03:01:06 INFO - mozversion == 1.4 03:01:06 INFO - psutil == 3.1.1 03:01:06 INFO - requests == 1.2.3 03:01:06 INFO - wsgiref == 0.1.2 03:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01: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')]} 03:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:06 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 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:01:06 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 03:01:06 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 03:01:06 INFO - Using env: {'DISPLAY': ':0', 03:01:06 INFO - 'HOME': '/home/cltbld', 03:01:06 INFO - 'LANG': 'en_US.UTF-8', 03:01:06 INFO - 'LANGUAGE': 'en_US:en', 03:01:06 INFO - 'LOGNAME': 'cltbld', 03:01:06 INFO - 'MAIL': '/var/mail/cltbld', 03:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:06 INFO - 'MOZ_NO_REMOTE': '1', 03:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:06 INFO - 'NO_EM_RESTART': '1', 03:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:06 INFO - 'PWD': '/builds/slave/test', 03:01:06 INFO - 'SHELL': '/bin/bash', 03:01:06 INFO - 'SHLVL': '1', 03:01:06 INFO - 'TERM': 'linux', 03:01:06 INFO - 'TMOUT': '86400', 03:01:06 INFO - 'USER': 'cltbld', 03:01:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:06 INFO - '_': '/tools/buildbot/bin/python'} 03:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:01:06 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 03:01:06 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 03:01:06 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 03:01:06 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 03:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:01:07 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)) 03:01:07 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)) 03:01:07 INFO - Installing collected packages: simplejson 03:01:07 INFO - Running setup.py install for simplejson 03:01:08 INFO - building 'simplejson._speedups' extension 03:01:08 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 03:01:08 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 03:01:08 INFO - Successfully installed simplejson 03:01:08 INFO - Cleaning up... 03:01:08 INFO - Return code: 0 03:01:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf93d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', '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 03:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:01:08 INFO - Using env: {'DISPLAY': ':0', 03:01:08 INFO - 'HOME': '/home/cltbld', 03:01:08 INFO - 'LANG': 'en_US.UTF-8', 03:01:08 INFO - 'LANGUAGE': 'en_US:en', 03:01:08 INFO - 'LOGNAME': 'cltbld', 03:01:08 INFO - 'MAIL': '/var/mail/cltbld', 03:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:08 INFO - 'MOZ_NO_REMOTE': '1', 03:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:08 INFO - 'NO_EM_RESTART': '1', 03:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:08 INFO - 'PWD': '/builds/slave/test', 03:01:08 INFO - 'SHELL': '/bin/bash', 03:01:08 INFO - 'SHLVL': '1', 03:01:08 INFO - 'TERM': 'linux', 03:01:08 INFO - 'TMOUT': '86400', 03:01:08 INFO - 'USER': 'cltbld', 03:01:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:08 INFO - '_': '/tools/buildbot/bin/python'} 03:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:09 INFO - Cleaning up... 03:01:09 INFO - Return code: 0 03:01:09 INFO - Running post-action listener: _resource_record_post_action 03:01:09 INFO - Running post-action listener: _start_resource_monitoring 03:01:09 INFO - Starting resource monitoring. 03:01:09 INFO - [mozharness: 2017-08-01 10:01:09.238749Z] Finished create-virtualenv step (success) 03:01:09 INFO - [mozharness: 2017-08-01 10:01:09.239256Z] Running install step. 03:01:09 INFO - Running pre-action listener: _resource_record_pre_action 03:01:09 INFO - Running main action method: install 03:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:09 INFO - Reading from file tmpfile_stdout 03:01:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:09 INFO - Reading from file tmpfile_stdout 03:01:09 INFO - Output received: 03:01:09 INFO - Usage: mozinstall [options] installer 03:01:09 INFO - Options: 03:01:09 INFO - -h, --help show this help message and exit 03:01:09 INFO - -d DEST, --destination=DEST 03:01:09 INFO - Directory to install application into. [default: 03:01:09 INFO - "/builds/slave/test"] 03:01:09 INFO - --app=APP Application being installed. [default: firefox] 03:01:09 INFO - mkdir: /builds/slave/test/build/application 03:01:09 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'] 03:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:01:27 INFO - Reading from file tmpfile_stdout 03:01:27 INFO - Output received: 03:01:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:01:27 INFO - Running post-action listener: _resource_record_post_action 03:01:27 INFO - [mozharness: 2017-08-01 10:01:27.686489Z] Finished install step (success) 03:01:27 INFO - [mozharness: 2017-08-01 10:01:27.686744Z] Running setup-mitmproxy step. 03:01:27 INFO - Running pre-action listener: _resource_record_pre_action 03:01:27 INFO - Running main action method: setup_mitmproxy 03:01:27 INFO - Skipping: mitmproxy is not required 03:01:27 INFO - Running post-action listener: _resource_record_post_action 03:01:27 INFO - [mozharness: 2017-08-01 10:01:27.687877Z] Finished setup-mitmproxy step (success) 03:01:27 INFO - [mozharness: 2017-08-01 10:01:27.688097Z] Running run-tests step. 03:01:27 INFO - Running pre-action listener: _resource_record_pre_action 03:01:27 INFO - Running pre-action listener: _set_gcov_prefix 03:01:27 INFO - Running main action method: run_tests 03:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:27 INFO - Python 2.7.3 03:01:27 INFO - Return code: 0 03:01:27 INFO - grabbing minidump binary from tooltool 03:01: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')]} 03:01:27 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 0xf90eb0>, '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 0xf91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf92240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:27 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 03:01:27 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 03:01:27 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 03:01:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:27 INFO - Return code: 0 03:01:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:01:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:27 INFO - ENV: RUST_BACKTRACE is now 1 03:01:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:01:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:27 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/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 03:01:27 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/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 03:01:27 INFO - Using env: {'DISPLAY': ':0', 03:01:27 INFO - 'HOME': '/home/cltbld', 03:01:27 INFO - 'LANG': 'en_US.UTF-8', 03:01:27 INFO - 'LANGUAGE': 'en_US:en', 03:01:27 INFO - 'LOGNAME': 'cltbld', 03:01:27 INFO - 'MAIL': '/var/mail/cltbld', 03:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:27 INFO - 'MOZ_NO_REMOTE': '1', 03:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:27 INFO - 'NO_EM_RESTART': '1', 03:01:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:27 INFO - 'PWD': '/builds/slave/test', 03:01:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:27 INFO - 'RUST_BACKTRACE': '1', 03:01:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:01:27 INFO - 'SHELL': '/bin/bash', 03:01:27 INFO - 'SHLVL': '1', 03:01:27 INFO - 'STYLO_FORCE_ENABLED': '1', 03:01:27 INFO - 'TERM': 'linux', 03:01:27 INFO - 'TMOUT': '86400', 03:01:27 INFO - 'USER': 'cltbld', 03:01:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637', 03:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:27 INFO - '_': '/tools/buildbot/bin/python'} 03:01:27 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/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 03:01:28 INFO - mozversion application_buildid: 20170801091417 03:01:28 INFO - mozversion application_changeset: 8d09df72c2e9b923bb84fe9741a668988834c393 03:01:28 INFO - mozversion application_display_name: Nightly 03:01:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:28 INFO - mozversion application_name: Firefox 03:01:28 INFO - mozversion application_remotingname: firefox 03:01:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:28 INFO - mozversion application_vendor: Mozilla 03:01:28 INFO - mozversion application_version: 56.0a1 03:01:28 INFO - mozversion platform_buildid: 20170801091417 03:01:28 INFO - mozversion platform_changeset: 8d09df72c2e9b923bb84fe9741a668988834c393 03:01:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:28 INFO - mozversion platform_version: 56.0a1 03:01:28 INFO - using testdate: 1501581688 03:01:28 INFO - actual date: 1501581688 03:01:28 INFO - starting webserver on 'localhost:35480' 03:01:28 INFO - SUITE-START | Running 2 tests 03:01:28 INFO - TEST-START | dromaeo_css 03:01:28 INFO - Initialising browser for dromaeo_css test... 03:01:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35480/getInfo.html -profile /tmp/tmpu8tVmg/profile 03:01:28 INFO - TEST-INFO | started process 19345 (/builds/slave/test/build/application/firefox/firefox http://localhost:35480/getInfo.html) 03:01:34 INFO - TEST-INFO | 19345: exit 0 03:01:34 INFO - Browser initialized. 03:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:34 INFO - TEST-INFO | started process 19571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8tVmg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:35 INFO - PID 19571 | 03:01:35 INFO - PID 19571 | (/builds/slave/test/build/application/firefox/firefox:19625): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:01:35 INFO - PID 19571 | 03:01:45 INFO - PID 19571 | RSS: Main: 173961216 03:01:45 INFO - PID 19571 | 03:04:46 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35480/tests/dromaeo/cssquery-ext.html) 03:04:47 INFO - PID 19571 | RSS: Main: 173572096 03:04:47 INFO - PID 19571 | 03:07:48 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-ext.html (next: http://localhost:35480/tests/dromaeo/cssquery-jquery.html) 03:07:49 INFO - PID 19571 | RSS: Main: 173916160 03:07:49 INFO - PID 19571 | 03:10:51 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35480/tests/dromaeo/cssquery-mootools.html) 03:10:52 INFO - PID 19571 | RSS: Main: 173985792 03:10:52 INFO - PID 19571 | 03:13:53 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35480/tests/dromaeo/cssquery-prototype.html) 03:13:54 INFO - PID 19571 | RSS: Main: 174059520 03:13:54 INFO - PID 19571 | 03:16:58 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35480/tests/dromaeo/cssquery-yui.html) 03:16:59 INFO - PID 19571 | RSS: Main: 177819648 03:16:59 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | Cycle 1(1): loaded http://localhost:35480/tests/dromaeo/cssquery-yui.html (next: http://localhost:35480/tests/dromaeo/cssquery-dojo.html) 03:20:01 INFO - PID 19571 | RSS: Main: 177922048 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | __start_tp_report 03:20:01 INFO - PID 19571 | _x_x_mozilla_page_load 03:20:01 INFO - PID 19571 | _x_x_mozilla_page_load_details 03:20:01 INFO - PID 19571 | |i|pagename|runs| 03:20:01 INFO - PID 19571 | |0;dojo.html;3092.443360195164;3143.95284070739;3176.396484667913;3195.744340452764;3200.183953091963;6159.353267906872;6173.969130154349;6221.906671399927;6227.906581401283;6250.187475628168;6065.2721673399255;6141.539384546166;6147.262328520584;6159.8152055438295;6171.50627949764;5613.045782217023;5628.296462942132;5652.039153343921;5659.943400566003;5718.799842005531;5658.91511627326;5710.657360558359;5775.768969241225;5779.682117483537;5801.506871915893;5692;5693.345265294462;5730.971345143268;5769.105788602773;5782.479576838084;5484.561235101182;5525.696086715229;5546.889062218733;5598.412166722517;5693.373728889819;5538.141588053818;5582.078956972095;5582.525485333752;5598.776048958078;5622.100463925753;5912.290525137011;6058.787942422038;6085.056816193497;6132.264128304588;6204.503639708858;6528.347165283481;6545.770898018546;6558.639274839882;6567.408933195988;6569.540132190748;6611.371919667624;6620.205575330943;6622.4370928471135;6625.536212465129;6629.867402651968;6076.4834989025985;6113.663748493831;6202.162708034448;6217.316095229521;6272.498200143978;6716.764913228014;6747;6773.254941956381;6831.965840170867;6859.451243900476;6417.133686952295;6417.197850268716;6485.870282594322;6501.122348482989;6541.149650545493;6456.418922297016;6515.674216289167;6540.640264785482;6565.474762019027;6647.268800431949;6532.216134063943;6554.80335589933;6593.604383736991;6602.471802255808;6644.103046088716;6569.981652843817;6689.1972963244725;6701.229358623723;6706.664666766642;6707.798766037026;5438.673679579238;5463.399026107125;5480.342358916876;5488.1493368527945;5488.9725551371985;4528.320751887178;4638.884027899329;4639.048994956026;4716.811327546929;4721.362616046858;5730.971345143331;5752.424757524214;5754.482096611325;5780.855478613068;5784.479396854304;6570.244421891448;6575.046618240328;6656.301088385747;6661.034150048215;6666.733330666719;5750.769969201185;5765.164051212634;5829.358770535237;5832;5832.212651292106;5460.370657767588;5854.970725146347;5858;5858.7070646468355;5872.471477567039;6402.231732192166;6408.55140140195;6421.646809425526;6442.871142577123;6443.838904027437;6729.495287853529;6757.695903684247;6759.3240675933985;6759.357861003196;6762.120924279812;6449.355064493513;6460.418562329413;6460.967695161682;6472.902906456501;6504.349565043647;6499.1876015498065;6509.056186852785;6591.34086591337;6596.5052621052655;6600.141981542369;6539.378759018076;6546.083548303146;6611.173603299588;6650.83372915681;6737.29258427858;6355.777547785805;6408.743650253938;6409.9038514423255;6415.743370265137;6530.869382612226;6350.491960643045;6362.745490180341;6399.552031357946;6457.289698133108;6459.580127291711;6275.843103922439;6343.682815859281;6397.8720425592155;6402.807915762534;6409.519286053472;6471.25580558223;6498.155239818793;6535.542512024303;6565.409113179837;6597.1423714916755;6197.938020619917;6278.0896769967185;6284.402981716729;6289.7484100635465;6351.2060992375955 03:20:01 INFO - PID 19571 | |1;ext.html;806.1696452653769;816.0941355095839;846.572480897147;861.2291998661202;870.856308709063;42381.78809105954;42978.140437191316;43006.569934300605;43067.56932430682;43245.35131973019;39234.411483827695;39445.40831887524;39543.20913581727;39564;39635.20729585407;6850.280720524335;7024.157101147869;7024.2273349931465;7025.051618031552;7028.332308430717;6926.653667316639;6996.8950465743055;7016.894746578805;7019.754308599175;7022.227554968949;7640.083190017178;7866.252705992922;7872.881906771403;7877.7636670899965;7880.133185349636;7599.81000474987;7765.805854853617;7828.099768526607;7841.68633254672;7846.960765196194;7589.506682065648;7617.80955476112;7628.923710762877;7701.037370328709;7706.460547761659;38643.22713545741;38982;39009.609903900884;39226.41160382597;39290.41064384037;3596.946045809315;3626.2384899170943;3627.673509384168;3627.891163265106;3648.7445878788494;32551.674483255338;32608.83695581507;32621.51067733986;32629.347413051844;32663.18342041468;4864.440589332201;4873.975630121862;4889.217725163957;4903.975480122613;4906.362172917497;183977;184770;185117;187657;197345;49411.50588494069;49608.255876161886;49619;49787.25319120216;49979;52892.471075289526;52941.470585294424;53092.20361694578;53203.467965319855;53253;16257.593560160854;16287.348506059861;16305.266263018193;16318.510444686679;16647;13666.52167174164;13741.175529468264;13763.862361376257;13774.586762397144;13781.586552403443;14215.289235538181;14218.431262749582;14240.572782816533;14340.928295358457;14488.275586220647;5592.356878958891;5613.129964855454;5712.000399930079;5751;5768.884622307531;977.9902200978041;979.3637615522763;988.3723835364596;1017.1201910347644;1019.8521214423866;22079.558408831734;22172;22455.88772056129;22674.546509069725;22844.086236550684;1086.4947799273375;1092.5411327242577;1113.3932007056173;1122.5117074072805;1125.4091601909063;11713.824292635618;11810.232334898204;11870.406479675981;11986.460609272604;12041.217320874115;219336;220608;221149;221512;221945;53194.73402632962;53308.73345633325;53319.20021199685;53481.465185347646;53566.464335356926;1479.5857159995435;1491.5551656064988;1493.3429291111877;1505.2022428113119;1506.0361368724025;21792.97984151758;21813.623902002884;22286.44283892851;22710.31869043931;23023.53952920966;34647;35155.472667910515;35213.29573408466;35488.822555887054;35622.28755424929;190662;191468;191597;191751;191972;32783.67216327806;33497.83251083729;33861.49207761935;33956.3208735819;34040.65959340375;42791.786041069594;42885.1422971545;42946.35580466358;43585.56414435815;43606.345904812086;29917;30799.2300192497;31277.530837037008;31288.843555782987;31308.530372044894;29423.411531769674;29504.40991180207;31070.37859242848;31227.84386078055;31383.529247060855;35999;36047.45928811018;36085.45871811977;36283.27433451264;36450.63549364579;33440;33449.66550334466;34016.14959626029;34293.142671433416;34939.47590786191;23745.52508949846;24403.02387904464;24564;24860.37849053788;24966.251012469656 03:20:01 INFO - PID 19571 | |2;jquery.html;576.7347020370629;584.5469760935277;587.2483221476512;593.7624950019991;598.9251343582051;22120.446988825268;22247.22134725285;23094.884525577392;23127.843607819625;23196;23699.407514812137;25504.107356242534;25581.87209063957;25603.743962560417;25728.614070788954;6517.3808488193545;6687.164104486939;6697.095892054584;6703.631300278483;6710.899336509932;6262.467690246312;6540.051692504584;6540.542162048659;6619.106420633225;6623.867522649544;6507.6420796856155;6511.3488651134985;6518.217813862343;6522.543421960465;6529.934700653004;6466.385693359123;6498.545101842873;6498.967505162467;6500.4474619657385;6502.999999999976;6014.8195554133445;6064.727087281083;6069.757209711606;6083.330833608344;6092.421219984094;29430;29525.852370738008;29876.253093672833;29919.700802992127;30553.694463055308;1898.734177215191;1940.2433051110079;1941.7184508246226;1942.3881477334594;1942.465821898975;18861.434156975174;18970.62058758817;19338.129784159606;19343.80656193448;19371.903140484348;2378.5124049569795;2418.5042066376527;2435.281591930385;2440.4021014851296;2458.803295736355;144591;147562.26218868943;148629.99999999892;148893;151726;14846.257687115602;14943.551693449213;15053.774193387108;15227.543173704807;15538;24152.396190095387;24160;24173.7582624175;24175.582441755683;24200.878995604908;10040.548175331982;10078.344907580984;10176.745581360525;10234.385936843813;10348.379097254188;9297.581608827484;9306.348555601044;9307.255419566418;9315.906840931504;9425.764355891157;8009.199080091944;9227.354085214105;9380.577873995686;9546;9590.952045239728;2567.306827156657;2635.3675117971547;2647.44521536718;2734.986325068362;2774.667039955218;929.9953500232591;949.7198326493701;956.0964888180603;960.6973803251954;968.331851022792;18697.345592904185;19100.713489297672;19101.90449047746;19947.102380392917;23600.40998975005;1009.7324209084599;1010.9292349535461;1032.8708911386077;1033.9069483746498;1052.778916427559;10631.415272160106;10981.12151027916;11077.667669969915;11120;11335.263207891461;539603;540489;541950;552743;553252;119086;125748;126743;126818;126819;1245.9252444853337;1261.936903154857;1301.7526669932872;1309.7511472820133;1311.5868501422212;19408.4177474676;20434.270660785634;20518;20849.270275540282;21065;58317.416825832894;59427.10859337027;60052.39947600468;60906.08640870302;61762;72024.27975720385;74065;75404.62297688695;75696.62151689206;76614;14155.221462819643;14466.638334041732;14589.489367872073;14614.926925365306;14626.926865365605;23294.883525582263;23760.762392376546;24179.758202418456;24193.637095443934;24195.79021048976;18214.544636384195;18368.448946531626;18445.9077704616;18552.628947421246;18596.814031859507;15595.454159104376;16290.185490725653;16561.337546498005;16679.16604169811;16807;17988.280468781624;19016.809831901504;19142.138603762585;19297;19339.12973916149;14597.489087881873;14624.268786560417;14631.561053168421;14654.047486913316;14692.118472891661;17023.40418085361;17160.74258886093;17201;18808.05959702037;18884.15021324071 03:20:01 INFO - PID 19571 | |3;mootools.html;1351.918884866908;1408.8309402871657;1419.8225221847265;1426.2155814302125;1432.6633241188313;13223.867761322384;13817.963652726035;13847.376868040938;13849.099808512452;13889.79165312521;14198.71602567948;14503.202323872209;14566.781498277534;14580.562583122522;14586.708265834677;2663.067926225815;2725.4140359822636;2733.808633395663;2734.234414363971;2736.6852811926683;2618.9738102619017;2812.3531587734833;2822.7741780657498;2829.5472724364104;2833.0509279391426;2729.0584748261817;2732.79504037197;2760.903368382107;2771.1686494051705;2773.6131934032983;2634.7233540478355;2677.477891811098;2681.1688376603315;2700.486907487571;2736.5484695025198;2605.049157057679;2605.7524535169127;2639.3797457597448;2643.339165208698;2643.3655922578637;13490.123141995738;13685;13692.931535342359;13723.725525489534;13935.09421887574;7512.624368781594;7853.764387068397;7872.370210383156;7882.80292992674;7889.211078892123;5091.847244582631;5314.468553144693;5334.279872217278;5338.572914166857;5399.433059528771;1621.456811967992;1653.9503814885452;1671.6740235654052;1719.6904557179703;1720.2001069502617;22584;22858.54282914349;23197.53604927892;23204.18785342505;23239;6357.4914006879335;6591.604503729792;6789.456843452512;6796.966015169893;6798.5241033128195;15838.76241856373;15866.44467443634;15873.603159921095;15888.523344299689;15909.363625454853;7295.781126566211;7493.437992150611;7496.362809161283;7501.062367204099;7504.474686771982;6867.21361288359;6973;7064.1876184238445;7114.466415018791;7198.280171982865;5017.799288028438;5028.120078986163;5057.8735531612;5150.562202212854;5176.948230517647;1511.833698293187;1518.5899807052035;1525.1306755149458;1525.192646713648;1535.0559405965473;830.4270053662954;834.5535138700766;847.588919374103;882.4131952251809;892.1569117184329;6775.627340496221;6888.586684798928;7004.544704594185;7020.824479388056;7075.893861592081;707.6249587718518;710.1017213225274;720.9062821833128;727.6652739739673;736.2196072163417;3981.7411868228473;4309.719868208556;4558.407407037064;4584.426946631671;4739.218029025173;18635.347762828234;19299.131539080776;19307;19320.4203873884;19391.4182574523;18478.722819157723;18981.525461863286;19024.71462928057;19197.520061998563;19247.037648117817;10344.741381465523;10411.167106631452;10640.095591874622;10651.094656954245;10676.946615266874;6699.296573859675;7344.632768361454;7349.118105827335;7468.253174682488;7532.5857077859055;15753.212339382755;16720;17033.48899533016;17146.05696686694;17199.05405202726;16988.83011169922;17092.145392730064;17265.91367043207;17458.650826983136;17760.733588996434;11130.443477826238;11536.134789890624;11823.881761182622;11856.644300670649;11856.703582410164;12905;13048.934755326163;13126.409311581192;13187.934060329637;13220;10214.540345684314;10480.318779279323;10697.839532406864;10709.678709638723;10784.245102842726;10129.493525323556;10380.48097595102;10668.679939601825;10707.732306692395;10789.406582637715;8644;8995.055519170393;9018.819623607622;9040.231580315747;9064.90935090667;6120.693965301628;6156.722947467464;6247.250329960434;6346.143270658402;6464.967675161783;6476.740930362733;6726.159230096238;6782.864342713019;6832.795016149524;6930.410915072275 03:20:01 INFO - PID 19571 | |4;prototype.html;493.85925011371756;494.68834634180484;521.7834598641563;527.3803281144654;527.3934974779002;6184.351232772663;6186.566940314174;6222.782202622898;6240.62556246625;6258.937410625898;5882.4705776480105;6058.697065146747;6080.571065799533;6107.69461526923;6139.478144357735;4820.975895120519;4853.247746599282;4874.902501949977;4974.950250497503;5028.949710502903;4905.681130726492;4915.139850526161;4939.036887806861;4955.776990035439;4999.350084489011;4747.789313724996;4896;4905.705657660534;4920.212765957447;4950.232713929328;4879.731614761205;4883.9267410988505;4903.975480122613;4916.410030796292;4974.37820272466;4401.625861801751;4406.501789391622;4415.757133357664;4429.114177164548;4436.356728274414;5998.850028749316;6003.339632640406;6012.96993515034;6082.148499210114;6140.385961403868;5579.358373786985;5643.068893632546;5687.800926967578;5703.201551782754;5723.77104915807;6418.261899881527;6479.64361960092;6485.546011779177;6525.5626174201525;6566.573172743804;4767.475577686451;4821.590164835993;4831.25115607078;4845.927311090337;4867.780949857265;6857.314268573153;6897.172339319263;6917.688704008281;6930.722771089201;6965.616891070989;4893.681910675866;4923.655344125948;4951.282064100686;4952.752362381866;4995.650304478724;5071.644984851099;5072.289879416885;5077.111505486525;5083.440821509631;5088.643794934393;5651.689157096399;5666.546676265972;5682.40334764852;5695.629784064023;5696.658200507983;6376.426121649074;6420.390062944013;6436.292007879129;6455.903161452582;6574.638394888327;1659;1659.945934331684;1688.5440930948575;1729.1699984007746;1779.5106345754762;1211.1340391620033;1212.1090998116376;1229.4160273870018;1238.928326997159;1255.8179064035664;5607.41122182165;5666.376698563155;5702.572307076985;5706.600537962386;5752.165935939265;6386.393292637192;6581.367453018831;6627.536072474977;6653.2681405045405;6683.866322673519;5711.314642242957;5758.481736643638;5772.884542309214;5803.970980145073;5832.795852145155;3564.7504674672523;3571.5178450909316;3573.249617580337;3574.267275208576;3622.637736226409;6424.775132870327;6520.282768895418;6529.934700653028;6533.640649764214;6559.573627714183;6923.065386172903;6926.411255043277;6929.203141638776;6940.548864323803;6968;6484.416402523795;6492.188476440445;6495.545311828127;6526.282108967915;6546.836329091716;6613.702383392662;6652.501062420241;6658.434033107046;6709.698063587248;6712.731490740316;6584.901226481702;6590.373914478117;6630.171228596426;6649.301823308483;6661.533692641662;6330.841728956629;6352.315656918883;6365.872682546231;6408.58344207625;6426.775062872777;4939.6542242042715;4962.727050012284;4978.47725988766;4989.975050124872;5029.245613157909;6655.800325990228;6690.130283063365;6711.530192886451;6730.192376914802;6765.932340676531;6356.618602883842;6363.936360636334;6389.456896163878;6436.9034464484;6442.162518872517;6398.808035758934;6429.903551446826;6438.356164383712;6508.60948343101;6524.151860258136;6035.426634469718;6212.1303017578475;6279.937200628118;6317.178766760292;6429.32492088324;6334.398232167937;6411.3909178627955;6434.485241180788;6438.066480360228;6461.030845373231;6178.7219575120125;6289.9056514153235;6307.085472606538;6316.936830631635;6334.398232167937 03:20:01 INFO - PID 19571 | |5;yui.html;878.8242351529695;891.1623074310148;895.6596493332532;900.9864852027221;910.1626503616671;17894.194761235743;19010.239590416382;19100.044997750127;19131.521711957208;19136.425907222772;19981.40055798325;20771.792282077175;20860.37418877436;20862.582748345023;20866.269680561185;1003.9648612298571;1024.0578667625803;1025.60514202032;1029.927905046647;1030.3148406309795;973.8441849304113;999.6301368493667;1054.0408228512056;1056.6407421476697;1061.8460323253123;1104.5471356743737;1104.7624760676454;1105.2429086076063;1109.8224284114544;1110.21729680575;1085.8534097896802;1094.485591771866;1097.1223021582703;1099.384344766925;1100.4552746390507;803;806.1615919443772;806.7418426103649;807.5074204735107;810.6473683947502;18728.906355468273;19438.70841937372;19451.805481945143;19491.707624385646;19668.901655491773;20199.19203231869;20483.28308509195;20953.26663566768;21021.5795684087;21036;15561.688766224725;15811.130387828665;15859.603509912344;16002.119883406407;16345.918270408572;3397.5583174187445;3413.7098346640564;3421.2131209821882;3426.7258619310646;3428.9485657715154;120215.39892300483;122052;127313;127748.36125819404;129043.35478322642;14712.779308310384;14874.776878346833;14910.776338354934;15120.092794432368;15125.773113403087;30516.84741576278;30757.538636920464;30939.0718278452;31144.065678029696;31235;8231.46495477792;8344.207300306462;8344.582770861432;8393.580320983927;8399.328053755686;4024.5774193709826;4093.672506199497;4109.198706252312;4114.423980642712;4115.464989551339;4801.68789028712;5259.500347466985;5801.158831969341;5855.824325270249;5861.3552509223955;1041.4844651897358;1055.2613170780485;1074.1621535202555;1074.9892501075046;1075.714935542082;664.7939138866967;669.6183175589964;686.9519133660596;694.3160986428364;701.4949236549676;12651.810222846665;13455.596332110052;13683.863161368457;13802.895768338509;14047.438102475786;650.4178760009764;670.289493137276;687.4191308344441;690.9063797002739;696.9965150174216;5181.3782346118705;5676.864627074601;6035.939640603538;6129.632222066691;6152.323244443108;98761;100780.49609751905;102137.48931255296;107163.46418268015;107471.8505629883;82901.58549207335;84230.15769842223;89973.55013224891;91095.54452227829;91301.54349228212;73779.63110184415;74741.62629186819;77023;77604.61197693975;77639.61180194176;12011.63965081049;12299.631011069681;12482.750344992868;12554.246745195318;12585.433655485342;33225.833870830495;34931.65068349284;35661.465078023335;35669.82165089158;36467.27065458729;44247.336289955034;45976.31035534403;46906.76546617245;47266.52733472759;48998.51001490082;17824;18128.27486900509;18134.274629014693;18300.90849545744;18469.81530184681;14992.352370765098;19373.8062619372;20306.187752489735;20556.58886822285;20568.79431205669;16582;17996.910015449837;18071.457856264333;18131.093445327944;18139.637207255517;18052.368167114088;18059.909700451415;18162.636747264718;18226.45320640383;18415.26338946427;16115.516534503984;16823.24295406734;17013.48959531216;17133.22900469507;17213.225404856563;11756.529738810352;12375.257484550955;12882.806757898827;12988.35058247065;13260.80108798388;13527;14023.50917717875;14043.929780351033;14422.783658244925;14542.345594448063 03:20:01 INFO - PID 19571 | __end_tp_report 03:20:01 INFO - PID 19571 | __start_cc_report 03:20:01 INFO - PID 19571 | _x_x_mozilla_cycle_collect,382 03:20:01 INFO - PID 19571 | __end_cc_report 03:20:01 INFO - PID 19571 | __startTimestamp1501582801374__endTimestamp 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | ------- Summary: start ------- 03:20:01 INFO - PID 19571 | Number of tests: 6 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#0] dojo.html Cycles:165 Average:6097.30 Median:6351.21 stddev:705.54 (11.1%) stddev-sans-first:667.16 03:20:01 INFO - PID 19571 | Values: 3092.4 3144.0 3176.4 3195.7 3200.2 6159.4 6174.0 6221.9 6227.9 6250.2 6065.3 6141.5 6147.3 6159.8 6171.5 5613.0 5628.3 5652.0 5659.9 5718.8 5658.9 5710.7 5775.8 5779.7 5801.5 5692.0 5693.3 5731.0 5769.1 5782.5 5484.6 5525.7 5546.9 5598.4 5693.4 5538.1 5582.1 5582.5 5598.8 5622.1 5912.3 6058.8 6085.1 6132.3 6204.5 6528.3 6545.8 6558.6 6567.4 6569.5 6611.4 6620.2 6622.4 6625.5 6629.9 6076.5 6113.7 6202.2 6217.3 6272.5 6716.8 6747.0 6773.3 6832.0 6859.5 6417.1 6417.2 6485.9 6501.1 6541.1 6456.4 6515.7 6540.6 6565.5 6647.3 6532.2 6554.8 6593.6 6602.5 6644.1 6570.0 6689.2 6701.2 6706.7 6707.8 5438.7 5463.4 5480.3 5488.1 5489.0 4528.3 4638.9 4639.0 4716.8 4721.4 5731.0 5752.4 5754.5 5780.9 5784.5 6570.2 6575.0 6656.3 6661.0 6666.7 5750.8 5765.2 5829.4 5832.0 5832.2 5460.4 5855.0 5858.0 5858.7 5872.5 6402.2 6408.6 6421.6 6442.9 6443.8 6729.5 6757.7 6759.3 6759.4 6762.1 6449.4 6460.4 6461.0 6472.9 6504.3 6499.2 6509.1 6591.3 6596.5 6600.1 6539.4 6546.1 6611.2 6650.8 6737.3 6355.8 6408.7 6409.9 6415.7 6530.9 6350.5 6362.7 6399.6 6457.3 6459.6 6275.8 6343.7 6397.9 6402.8 6409.5 6471.3 6498.2 6535.5 6565.4 6597.1 6197.9 6278.1 6284.4 6289.7 6351.2 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#1] ext.html Cycles:180 Average:37096.67 Median:35555.56 stddev:51968.21 (146.2%) stddev-sans-first:52042.56 03:20:01 INFO - PID 19571 | Values: 806.2 816.1 846.6 861.2 870.9 42381.8 42978.1 43006.6 43067.6 43245.4 39234.4 39445.4 39543.2 39564.0 39635.2 6850.3 7024.2 7024.2 7025.1 7028.3 6926.7 6996.9 7016.9 7019.8 7022.2 7640.1 7866.3 7872.9 7877.8 7880.1 7599.8 7765.8 7828.1 7841.7 7847.0 7589.5 7617.8 7628.9 7701.0 7706.5 38643.2 38982.0 39009.6 39226.4 39290.4 3596.9 3626.2 3627.7 3627.9 3648.7 32551.7 32608.8 32621.5 32629.3 32663.2 4864.4 4874.0 4889.2 4904.0 4906.4 183977.0 184770.0 185117.0 187657.0 197345.0 49411.5 49608.3 49619.0 49787.3 49979.0 52892.5 52941.5 53092.2 53203.5 53253.0 16257.6 16287.3 16305.3 16318.5 16647.0 13666.5 13741.2 13763.9 13774.6 13781.6 14215.3 14218.4 14240.6 14340.9 14488.3 5592.4 5613.1 5712.0 5751.0 5768.9 978.0 979.4 988.4 1017.1 1019.9 22079.6 22172.0 22455.9 22674.5 22844.1 1086.5 1092.5 1113.4 1122.5 1125.4 11713.8 11810.2 11870.4 11986.5 12041.2 219336.0 220608.0 221149.0 221512.0 221945.0 53194.7 53308.7 53319.2 53481.5 53566.5 1479.6 1491.6 1493.3 1505.2 1506.0 21793.0 21813.6 22286.4 22710.3 23023.5 34647.0 35155.5 35213.3 35488.8 35622.3 190662.0 191468.0 191597.0 191751.0 191972.0 32783.7 33497.8 33861.5 33956.3 34040.7 42791.8 42885.1 42946.4 43585.6 43606.3 29917.0 30799.2 31277.5 31288.8 31308.5 29423.4 29504.4 31070.4 31227.8 31383.5 35999.0 36047.5 36085.5 36283.3 36450.6 33440.0 33449.7 34016.1 34293.1 34939.5 23745.5 24403.0 24564.0 24860.4 24966.3 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#2] jquery.html Cycles:180 Average:37170.06 Median:23649.91 stddev:91814.36 (388.2%) stddev-sans-first:92030.82 03:20:01 INFO - PID 19571 | Values: 576.7 584.5 587.2 593.8 598.9 22120.4 22247.2 23094.9 23127.8 23196.0 23699.4 25504.1 25581.9 25603.7 25728.6 6517.4 6687.2 6697.1 6703.6 6710.9 6262.5 6540.1 6540.5 6619.1 6623.9 6507.6 6511.3 6518.2 6522.5 6529.9 6466.4 6498.5 6499.0 6500.4 6503.0 6014.8 6064.7 6069.8 6083.3 6092.4 29430.0 29525.9 29876.3 29919.7 30553.7 1898.7 1940.2 1941.7 1942.4 1942.5 18861.4 18970.6 19338.1 19343.8 19371.9 2378.5 2418.5 2435.3 2440.4 2458.8 144591.0 147562.3 148630.0 148893.0 151726.0 14846.3 14943.6 15053.8 15227.5 15538.0 24152.4 24160.0 24173.8 24175.6 24200.9 10040.5 10078.3 10176.7 10234.4 10348.4 9297.6 9306.3 9307.3 9315.9 9425.8 8009.2 9227.4 9380.6 9546.0 9591.0 2567.3 2635.4 2647.4 2735.0 2774.7 930.0 949.7 956.1 960.7 968.3 18697.3 19100.7 19101.9 19947.1 23600.4 1009.7 1010.9 1032.9 1033.9 1052.8 10631.4 10981.1 11077.7 11120.0 11335.3 539603.0 540489.0 541950.0 552743.0 553252.0 119086.0 125748.0 126743.0 126818.0 126819.0 1245.9 1261.9 1301.8 1309.8 1311.6 19408.4 20434.3 20518.0 20849.3 21065.0 58317.4 59427.1 60052.4 60906.1 61762.0 72024.3 74065.0 75404.6 75696.6 76614.0 14155.2 14466.6 14589.5 14614.9 14626.9 23294.9 23760.8 24179.8 24193.6 24195.8 18214.5 18368.4 18445.9 18552.6 18596.8 15595.5 16290.2 16561.3 16679.2 16807.0 17988.3 19016.8 19142.1 19297.0 19339.1 14597.5 14624.3 14631.6 14654.0 14692.1 17023.4 17160.7 17201.0 18808.1 18884.2 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#3] mootools.html Cycles:180 Average:8589.17 Median:2643.35 stddev:5932.09 (224.4%) stddev-sans-first:5923.81 03:20:01 INFO - PID 19571 | Values: 1351.9 1408.8 1419.8 1426.2 1432.7 13223.9 13818.0 13847.4 13849.1 13889.8 14198.7 14503.2 14566.8 14580.6 14586.7 2663.1 2725.4 2733.8 2734.2 2736.7 2619.0 2812.4 2822.8 2829.5 2833.1 2729.1 2732.8 2760.9 2771.2 2773.6 2634.7 2677.5 2681.2 2700.5 2736.5 2605.0 2605.8 2639.4 2643.3 2643.4 13490.1 13685.0 13692.9 13723.7 13935.1 7512.6 7853.8 7872.4 7882.8 7889.2 5091.8 5314.5 5334.3 5338.6 5399.4 1621.5 1654.0 1671.7 1719.7 1720.2 22584.0 22858.5 23197.5 23204.2 23239.0 6357.5 6591.6 6789.5 6797.0 6798.5 15838.8 15866.4 15873.6 15888.5 15909.4 7295.8 7493.4 7496.4 7501.1 7504.5 6867.2 6973.0 7064.2 7114.5 7198.3 5017.8 5028.1 5057.9 5150.6 5176.9 1511.8 1518.6 1525.1 1525.2 1535.1 830.4 834.6 847.6 882.4 892.2 6775.6 6888.6 7004.5 7020.8 7075.9 707.6 710.1 720.9 727.7 736.2 3981.7 4309.7 4558.4 4584.4 4739.2 18635.3 19299.1 19307.0 19320.4 19391.4 18478.7 18981.5 19024.7 19197.5 19247.0 10344.7 10411.2 10640.1 10651.1 10676.9 6699.3 7344.6 7349.1 7468.3 7532.6 15753.2 16720.0 17033.5 17146.1 17199.1 16988.8 17092.1 17265.9 17458.7 17760.7 11130.4 11536.1 11823.9 11856.6 11856.7 12905.0 13048.9 13126.4 13187.9 13220.0 10214.5 10480.3 10697.8 10709.7 10784.2 10129.5 10380.5 10668.7 10707.7 10789.4 8644.0 8995.1 9018.8 9040.2 9064.9 6120.7 6156.7 6247.3 6346.1 6465.0 6476.7 6726.2 6782.9 6832.8 6930.4 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#4] prototype.html Cycles:180 Average:5462.62 Median:6069.63 stddev:1532.79 (25.3%) stddev-sans-first:1491.03 03:20:01 INFO - PID 19571 | Values: 493.9 494.7 521.8 527.4 527.4 6184.4 6186.6 6222.8 6240.6 6258.9 5882.5 6058.7 6080.6 6107.7 6139.5 4821.0 4853.2 4874.9 4975.0 5028.9 4905.7 4915.1 4939.0 4955.8 4999.4 4747.8 4896.0 4905.7 4920.2 4950.2 4879.7 4883.9 4904.0 4916.4 4974.4 4401.6 4406.5 4415.8 4429.1 4436.4 5998.9 6003.3 6013.0 6082.1 6140.4 5579.4 5643.1 5687.8 5703.2 5723.8 6418.3 6479.6 6485.5 6525.6 6566.6 4767.5 4821.6 4831.3 4845.9 4867.8 6857.3 6897.2 6917.7 6930.7 6965.6 4893.7 4923.7 4951.3 4952.8 4995.7 5071.6 5072.3 5077.1 5083.4 5088.6 5651.7 5666.5 5682.4 5695.6 5696.7 6376.4 6420.4 6436.3 6455.9 6574.6 1659.0 1659.9 1688.5 1729.2 1779.5 1211.1 1212.1 1229.4 1238.9 1255.8 5607.4 5666.4 5702.6 5706.6 5752.2 6386.4 6581.4 6627.5 6653.3 6683.9 5711.3 5758.5 5772.9 5804.0 5832.8 3564.8 3571.5 3573.2 3574.3 3622.6 6424.8 6520.3 6529.9 6533.6 6559.6 6923.1 6926.4 6929.2 6940.5 6968.0 6484.4 6492.2 6495.5 6526.3 6546.8 6613.7 6652.5 6658.4 6709.7 6712.7 6584.9 6590.4 6630.2 6649.3 6661.5 6330.8 6352.3 6365.9 6408.6 6426.8 4939.7 4962.7 4978.5 4990.0 5029.2 6655.8 6690.1 6711.5 6730.2 6765.9 6356.6 6363.9 6389.5 6436.9 6442.2 6398.8 6429.9 6438.4 6508.6 6524.2 6035.4 6212.1 6279.9 6317.2 6429.3 6334.4 6411.4 6434.5 6438.1 6461.0 6178.7 6289.9 6307.1 6316.9 6334.4 03:20:01 INFO - PID 19571 | 03:20:01 INFO - PID 19571 | [#5] yui.html Cycles:180 Average:22063.64 Median:19445.26 stddev:29587.85 (152.2%) stddev-sans-first:29628.09 03:20:01 INFO - PID 19571 | Values: 878.8 891.2 895.7 901.0 910.2 17894.2 19010.2 19100.0 19131.5 19136.4 19981.4 20771.8 20860.4 20862.6 20866.3 1004.0 1024.1 1025.6 1029.9 1030.3 973.8 999.6 1054.0 1056.6 1061.8 1104.5 1104.8 1105.2 1109.8 1110.2 1085.9 1094.5 1097.1 1099.4 1100.5 803.0 806.2 806.7 807.5 810.6 18728.9 19438.7 19451.8 19491.7 19668.9 20199.2 20483.3 20953.3 21021.6 21036.0 15561.7 15811.1 15859.6 16002.1 16345.9 3397.6 3413.7 3421.2 3426.7 3428.9 120215.4 122052.0 127313.0 127748.4 129043.4 14712.8 14874.8 14910.8 15120.1 15125.8 30516.8 30757.5 30939.1 31144.1 31235.0 8231.5 8344.2 8344.6 8393.6 8399.3 4024.6 4093.7 4109.2 4114.4 4115.5 4801.7 5259.5 5801.2 5855.8 5861.4 1041.5 1055.3 1074.2 1075.0 1075.7 664.8 669.6 687.0 694.3 701.5 12651.8 13455.6 13683.9 13802.9 14047.4 650.4 670.3 687.4 690.9 697.0 5181.4 5676.9 6035.9 6129.6 6152.3 98761.0 100780.5 102137.5 107163.5 107471.9 82901.6 84230.2 89973.6 91095.5 91301.5 73779.6 74741.6 77023.0 77604.6 77639.6 12011.6 12299.6 12482.8 12554.2 12585.4 33225.8 34931.7 35661.5 35669.8 36467.3 44247.3 45976.3 46906.8 47266.5 48998.5 17824.0 18128.3 18134.3 18300.9 18469.8 14992.4 19373.8 20306.2 20556.6 20568.8 16582.0 17996.9 18071.5 18131.1 18139.6 18052.4 18059.9 18162.6 18226.5 18415.3 16115.5 16823.2 17013.5 17133.2 17213.2 11756.5 12375.3 12882.8 12988.4 13260.8 13527.0 14023.5 14043.9 14422.8 14542.3 03:20:01 INFO - PID 19571 | -------- Summary: end -------- 03:20:01 INFO - PID 19571 | 03:20:02 INFO - TEST-INFO | 19571: exit 0 03:20:02 INFO - TEST-OK | dromaeo_css | took 1114073ms 03:20:02 INFO - TEST-START | kraken 03:20:02 INFO - Initialising browser for kraken test... 03:20:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35480/getInfo.html -profile /tmp/tmpMN2Cc2/profile 03:20:02 INFO - TEST-INFO | started process 19950 (/builds/slave/test/build/application/firefox/firefox http://localhost:35480/getInfo.html) 03:20:08 INFO - TEST-INFO | 19950: exit 0 03:20:08 INFO - Browser initialized. 03:20:08 INFO - Running cycle 1/1 for kraken test... 03:20:08 INFO - TEST-INFO | started process 20176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMN2Cc2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:09 INFO - PID 20176 | 03:20:09 INFO - PID 20176 | (/builds/slave/test/build/application/firefox/firefox:20231): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:20:09 INFO - PID 20176 | 03:20:19 INFO - PID 20176 | RSS: Main: 174669824 03:20:19 INFO - PID 20176 | 03:20:22 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35480/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:23 INFO - PID 20176 | RSS: Main: 179306496 03:20:23 INFO - PID 20176 | 03:20:25 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35480/tests/kraken/driver.html?testName=audio-dft) 03:20:26 INFO - PID 20176 | RSS: Main: 179580928 03:20:26 INFO - PID 20176 | 03:20:29 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35480/tests/kraken/driver.html?testName=audio-fft) 03:20:30 INFO - PID 20176 | RSS: Main: 174952448 03:20:30 INFO - PID 20176 | 03:20:32 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35480/tests/kraken/driver.html?testName=audio-oscillator) 03:20:33 INFO - PID 20176 | RSS: Main: 175865856 03:20:33 INFO - PID 20176 | 03:20:35 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:35 INFO - PID 20176 | RSS: Main: 175468544 03:20:35 INFO - PID 20176 | 03:20:39 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35480/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:39 INFO - PID 20176 | RSS: Main: 177819648 03:20:39 INFO - PID 20176 | 03:20:43 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35480/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:43 INFO - PID 20176 | RSS: Main: 177356800 03:20:43 INFO - PID 20176 | 03:20:46 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35480/tests/kraken/driver.html?testName=json-parse-financial) 03:20:47 INFO - PID 20176 | RSS: Main: 177950720 03:20:47 INFO - PID 20176 | 03:20:49 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:49 INFO - PID 20176 | RSS: Main: 177786880 03:20:49 INFO - PID 20176 | 03:20:51 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:52 INFO - PID 20176 | RSS: Main: 174866432 03:20:52 INFO - PID 20176 | 03:20:54 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:55 INFO - PID 20176 | RSS: Main: 174772224 03:20:55 INFO - PID 20176 | 03:20:58 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:58 INFO - PID 20176 | RSS: Main: 175345664 03:20:58 INFO - PID 20176 | 03:21:02 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:02 INFO - PID 20176 | RSS: Main: 175484928 03:21:02 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | Cycle 1(1): loaded http://localhost:35480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35480/tests/kraken/driver.html?testName=ai-astar) 03:21:04 INFO - PID 20176 | RSS: Main: 176947200 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | __start_tp_report 03:21:04 INFO - PID 20176 | _x_x_mozilla_page_load 03:21:04 INFO - PID 20176 | _x_x_mozilla_page_load_details 03:21:04 INFO - PID 20176 | |i|pagename|runs| 03:21:04 INFO - PID 20176 | |0;ai-astar;102;109;109;111;114;109;116;108;109;109 03:21:04 INFO - PID 20176 | |1;audio-beat-detection;151;119;141;170;123;148;148;121;172;119 03:21:04 INFO - PID 20176 | |2;audio-dft;163;163;163;163;162;161;164;168;165;165 03:21:04 INFO - PID 20176 | |3;audio-fft;73;79;74;166;75;77;80;77;163;75 03:21:04 INFO - PID 20176 | |4;audio-oscillator;78;78;141;88;79;78;131;80;79;121 03:21:04 INFO - PID 20176 | |5;imaging-gaussian-blur;115;120;114;119;114;114;114;115;118;116 03:21:04 INFO - PID 20176 | |6;imaging-darkroom;153;150;151;161;154;152;152;151;157;150 03:21:04 INFO - PID 20176 | |7;imaging-desaturate;99;94;94;93;93;94;94;95;96;94 03:21:04 INFO - PID 20176 | |8;json-parse-financial;59;57;57;64;57;57;57;56;56;57 03:21:04 INFO - PID 20176 | |9;json-stringify-tinderbox;58;63;60;54;54;53;62;54;54;54 03:21:04 INFO - PID 20176 | |10;stanford-crypto-aes;81;91;82;79;90;96;82;83;79;83 03:21:04 INFO - PID 20176 | |11;stanford-crypto-ccm;140;134;138;135;130;128;147;139;126;181 03:21:04 INFO - PID 20176 | |12;stanford-crypto-pbkdf2;181;180;191;177;183;178;183;183;178;182 03:21:04 INFO - PID 20176 | |13;stanford-crypto-sha256-iterative;69;83;67;69;72;73;67;71;70;70 03:21:04 INFO - PID 20176 | __end_tp_report 03:21:04 INFO - PID 20176 | __start_cc_report 03:21:04 INFO - PID 20176 | _x_x_mozilla_cycle_collect,967 03:21:04 INFO - PID 20176 | __end_cc_report 03:21:04 INFO - PID 20176 | __startTimestamp1501582864762__endTimestamp 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | ------- Summary: start ------- 03:21:04 INFO - PID 20176 | Number of tests: 14 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#0] ai-astar Cycles:10 Average:109.60 Median:109.00 stddev:3.72 (3.4%) stddev-sans-first:2.74 03:21:04 INFO - PID 20176 | Values: 102.0 109.0 109.0 111.0 114.0 109.0 116.0 108.0 109.0 109.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:148.00 stddev:20.25 (13.7%) stddev-sans-first:21.17 03:21:04 INFO - PID 20176 | Values: 151.0 119.0 141.0 170.0 123.0 148.0 148.0 121.0 172.0 119.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.95 (1.2%) stddev-sans-first:2.05 03:21:04 INFO - PID 20176 | Values: 163.0 163.0 163.0 163.0 162.0 161.0 164.0 168.0 165.0 165.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.28 (49.1%) stddev-sans-first:38.76 03:21:04 INFO - PID 20176 | Values: 73.0 79.0 74.0 166.0 75.0 77.0 80.0 77.0 163.0 75.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:78.50 stddev:25.25 (32.2%) stddev-sans-first:26.00 03:21:04 INFO - PID 20176 | Values: 78.0 78.0 141.0 88.0 79.0 78.0 131.0 80.0 79.0 121.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.50 stddev:2.28 (2.0%) stddev-sans-first:2.40 03:21:04 INFO - PID 20176 | Values: 115.0 120.0 114.0 119.0 114.0 114.0 114.0 115.0 118.0 116.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#6] imaging-darkroom Cycles:10 Average:153.10 Median:152.50 stddev:3.48 (2.3%) stddev-sans-first:3.69 03:21:04 INFO - PID 20176 | Values: 153.0 150.0 151.0 161.0 154.0 152.0 152.0 151.0 157.0 150.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.78 (1.9%) stddev-sans-first:0.93 03:21:04 INFO - PID 20176 | Values: 99.0 94.0 94.0 93.0 93.0 94.0 94.0 95.0 96.0 94.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:2.36 (4.1%) stddev-sans-first:2.46 03:21:04 INFO - PID 20176 | Values: 59.0 57.0 57.0 64.0 57.0 57.0 57.0 56.0 56.0 57.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.00 stddev:3.81 (6.8%) stddev-sans-first:4.00 03:21:04 INFO - PID 20176 | Values: 58.0 63.0 60.0 54.0 54.0 53.0 62.0 54.0 54.0 54.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.00 stddev:5.72 (6.9%) stddev-sans-first:5.92 03:21:04 INFO - PID 20176 | Values: 81.0 91.0 82.0 79.0 90.0 96.0 82.0 83.0 79.0 83.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.50 stddev:15.76 (11.4%) stddev-sans-first:16.72 03:21:04 INFO - PID 20176 | Values: 140.0 134.0 138.0 135.0 130.0 128.0 147.0 139.0 126.0 181.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:182.50 stddev:4.01 (2.2%) stddev-sans-first:4.24 03:21:04 INFO - PID 20176 | Values: 181.0 180.0 191.0 177.0 183.0 178.0 183.0 183.0 178.0 182.0 03:21:04 INFO - PID 20176 | 03:21:04 INFO - PID 20176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:4.61 (6.5%) stddev-sans-first:4.82 03:21:04 INFO - PID 20176 | Values: 69.0 83.0 67.0 69.0 72.0 73.0 67.0 71.0 70.0 70.0 03:21:04 INFO - PID 20176 | -------- Summary: end -------- 03:21:04 INFO - PID 20176 | 03:21:05 INFO - PID 20176 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:21:05 INFO - TEST-INFO | 20176: exit 0 03:21:05 INFO - TEST-OK | kraken | took 63346ms 03:21:05 INFO - SUITE-END | took 1177s 03:21:05 INFO - Completed test suite (00:19:37) 03:21:05 INFO - javascript benchmark 03:21:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8389.221417023842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.443360195164, 3143.95284070739, 3176.396484667913, 3195.744340452764, 3200.183953091963, 6159.353267906872, 6173.969130154349, 6221.906671399927, 6227.906581401283, 6250.187475628168, 6065.2721673399255, 6141.539384546166, 6147.262328520584, 6159.8152055438295, 6171.50627949764, 5613.045782217023, 5628.296462942132, 5652.039153343921, 5659.943400566003, 5718.799842005531, 5658.91511627326, 5710.657360558359, 5775.768969241225, 5779.682117483537, 5801.506871915893, 5692.0, 5693.345265294462, 5730.971345143268, 5769.105788602773, 5782.479576838084, 5484.561235101182, 5525.696086715229, 5546.889062218733, 5598.412166722517, 5693.373728889819, 5538.141588053818, 5582.078956972095, 5582.525485333752, 5598.776048958078, 5622.100463925753, 5912.290525137011, 6058.787942422038, 6085.056816193497, 6132.264128304588, 6204.503639708858, 6528.347165283481, 6545.770898018546, 6558.639274839882, 6567.408933195988, 6569.540132190748, 6611.371919667624, 6620.205575330943, 6622.4370928471135, 6625.536212465129, 6629.867402651968, 6076.4834989025985, 6113.663748493831, 6202.162708034448, 6217.316095229521, 6272.498200143978, 6716.764913228014, 6747.0, 6773.254941956381, 6831.965840170867, 6859.451243900476, 6417.133686952295, 6417.197850268716, 6485.870282594322, 6501.122348482989, 6541.149650545493, 6456.418922297016, 6515.674216289167, 6540.640264785482, 6565.474762019027, 6647.268800431949, 6532.216134063943, 6554.80335589933, 6593.604383736991, 6602.471802255808, 6644.103046088716, 6569.981652843817, 6689.1972963244725, 6701.229358623723, 6706.664666766642, 6707.798766037026, 5438.673679579238, 5463.399026107125, 5480.342358916876, 5488.1493368527945, 5488.9725551371985, 4528.320751887178, 4638.884027899329, 4639.048994956026, 4716.811327546929, 4721.362616046858, 5730.971345143331, 5752.424757524214, 5754.482096611325, 5780.855478613068, 5784.479396854304, 6570.244421891448, 6575.046618240328, 6656.301088385747, 6661.034150048215, 6666.733330666719, 5750.769969201185, 5765.164051212634, 5829.358770535237, 5832.0, 5832.212651292106, 5460.370657767588, 5854.970725146347, 5858.0, 5858.7070646468355, 5872.471477567039, 6402.231732192166, 6408.55140140195, 6421.646809425526, 6442.871142577123, 6443.838904027437, 6729.495287853529, 6757.695903684247, 6759.3240675933985, 6759.357861003196, 6762.120924279812, 6449.355064493513, 6460.418562329413, 6460.967695161682, 6472.902906456501, 6504.349565043647, 6499.1876015498065, 6509.056186852785, 6591.34086591337, 6596.5052621052655, 6600.141981542369, 6539.378759018076, 6546.083548303146, 6611.173603299588, 6650.83372915681, 6737.29258427858, 6355.777547785805, 6408.743650253938, 6409.9038514423255, 6415.743370265137, 6530.869382612226, 6350.491960643045, 6362.745490180341, 6399.552031357946, 6457.289698133108, 6459.580127291711, 6275.843103922439, 6343.682815859281, 6397.8720425592155, 6402.807915762534, 6409.519286053472, 6471.25580558223, 6498.155239818793, 6535.542512024303, 6565.409113179837, 6597.1423714916755, 6197.938020619917, 6278.0896769967185, 6284.402981716729, 6289.7484100635465, 6351.2060992375955], "value": 6045.497182790426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.1696452653769, 816.0941355095839, 846.572480897147, 861.2291998661202, 870.856308709063, 42381.78809105954, 42978.140437191316, 43006.569934300605, 43067.56932430682, 43245.35131973019, 39234.411483827695, 39445.40831887524, 39543.20913581727, 39564.0, 39635.20729585407, 6850.280720524335, 7024.157101147869, 7024.2273349931465, 7025.051618031552, 7028.332308430717, 6926.653667316639, 6996.8950465743055, 7016.894746578805, 7019.754308599175, 7022.227554968949, 7640.083190017178, 7866.252705992922, 7872.881906771403, 7877.7636670899965, 7880.133185349636, 7599.81000474987, 7765.805854853617, 7828.099768526607, 7841.68633254672, 7846.960765196194, 7589.506682065648, 7617.80955476112, 7628.923710762877, 7701.037370328709, 7706.460547761659, 38643.22713545741, 38982.0, 39009.609903900884, 39226.41160382597, 39290.41064384037, 3596.946045809315, 3626.2384899170943, 3627.673509384168, 3627.891163265106, 3648.7445878788494, 32551.674483255338, 32608.83695581507, 32621.51067733986, 32629.347413051844, 32663.18342041468, 4864.440589332201, 4873.975630121862, 4889.217725163957, 4903.975480122613, 4906.362172917497, 183977.0, 184770.0, 185117.0, 187657.0, 197345.0, 49411.50588494069, 49608.255876161886, 49619.0, 49787.25319120216, 49979.0, 52892.471075289526, 52941.470585294424, 53092.20361694578, 53203.467965319855, 53253.0, 16257.593560160854, 16287.348506059861, 16305.266263018193, 16318.510444686679, 16647.0, 13666.52167174164, 13741.175529468264, 13763.862361376257, 13774.586762397144, 13781.586552403443, 14215.289235538181, 14218.431262749582, 14240.572782816533, 14340.928295358457, 14488.275586220647, 5592.356878958891, 5613.129964855454, 5712.000399930079, 5751.0, 5768.884622307531, 977.9902200978041, 979.3637615522763, 988.3723835364596, 1017.1201910347644, 1019.8521214423866, 22079.558408831734, 22172.0, 22455.88772056129, 22674.546509069725, 22844.086236550684, 1086.4947799273375, 1092.5411327242577, 1113.3932007056173, 1122.5117074072805, 1125.4091601909063, 11713.824292635618, 11810.232334898204, 11870.406479675981, 11986.460609272604, 12041.217320874115, 219336.0, 220608.0, 221149.0, 221512.0, 221945.0, 53194.73402632962, 53308.73345633325, 53319.20021199685, 53481.465185347646, 53566.464335356926, 1479.5857159995435, 1491.5551656064988, 1493.3429291111877, 1505.2022428113119, 1506.0361368724025, 21792.97984151758, 21813.623902002884, 22286.44283892851, 22710.31869043931, 23023.53952920966, 34647.0, 35155.472667910515, 35213.29573408466, 35488.822555887054, 35622.28755424929, 190662.0, 191468.0, 191597.0, 191751.0, 191972.0, 32783.67216327806, 33497.83251083729, 33861.49207761935, 33956.3208735819, 34040.65959340375, 42791.786041069594, 42885.1422971545, 42946.35580466358, 43585.56414435815, 43606.345904812086, 29917.0, 30799.2300192497, 31277.530837037008, 31288.843555782987, 31308.530372044894, 29423.411531769674, 29504.40991180207, 31070.37859242848, 31227.84386078055, 31383.529247060855, 35999.0, 36047.45928811018, 36085.45871811977, 36283.27433451264, 36450.63549364579, 33440.0, 33449.66550334466, 34016.14959626029, 34293.142671433416, 34939.47590786191, 23745.52508949846, 24403.02387904464, 24564.0, 24860.37849053788, 24966.251012469656], "value": 17039.34772829335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7347020370629, 584.5469760935277, 587.2483221476512, 593.7624950019991, 598.9251343582051, 22120.446988825268, 22247.22134725285, 23094.884525577392, 23127.843607819625, 23196.0, 23699.407514812137, 25504.107356242534, 25581.87209063957, 25603.743962560417, 25728.614070788954, 6517.3808488193545, 6687.164104486939, 6697.095892054584, 6703.631300278483, 6710.899336509932, 6262.467690246312, 6540.051692504584, 6540.542162048659, 6619.106420633225, 6623.867522649544, 6507.6420796856155, 6511.3488651134985, 6518.217813862343, 6522.543421960465, 6529.934700653004, 6466.385693359123, 6498.545101842873, 6498.967505162467, 6500.4474619657385, 6502.999999999976, 6014.8195554133445, 6064.727087281083, 6069.757209711606, 6083.330833608344, 6092.421219984094, 29430.0, 29525.852370738008, 29876.253093672833, 29919.700802992127, 30553.694463055308, 1898.734177215191, 1940.2433051110079, 1941.7184508246226, 1942.3881477334594, 1942.465821898975, 18861.434156975174, 18970.62058758817, 19338.129784159606, 19343.80656193448, 19371.903140484348, 2378.5124049569795, 2418.5042066376527, 2435.281591930385, 2440.4021014851296, 2458.803295736355, 144591.0, 147562.26218868943, 148629.99999999892, 148893.0, 151726.0, 14846.257687115602, 14943.551693449213, 15053.774193387108, 15227.543173704807, 15538.0, 24152.396190095387, 24160.0, 24173.7582624175, 24175.582441755683, 24200.878995604908, 10040.548175331982, 10078.344907580984, 10176.745581360525, 10234.385936843813, 10348.379097254188, 9297.581608827484, 9306.348555601044, 9307.255419566418, 9315.906840931504, 9425.764355891157, 8009.199080091944, 9227.354085214105, 9380.577873995686, 9546.0, 9590.952045239728, 2567.306827156657, 2635.3675117971547, 2647.44521536718, 2734.986325068362, 2774.667039955218, 929.9953500232591, 949.7198326493701, 956.0964888180603, 960.6973803251954, 968.331851022792, 18697.345592904185, 19100.713489297672, 19101.90449047746, 19947.102380392917, 23600.40998975005, 1009.7324209084599, 1010.9292349535461, 1032.8708911386077, 1033.9069483746498, 1052.778916427559, 10631.415272160106, 10981.12151027916, 11077.667669969915, 11120.0, 11335.263207891461, 539603.0, 540489.0, 541950.0, 552743.0, 553252.0, 119086.0, 125748.0, 126743.0, 126818.0, 126819.0, 1245.9252444853337, 1261.936903154857, 1301.7526669932872, 1309.7511472820133, 1311.5868501422212, 19408.4177474676, 20434.270660785634, 20518.0, 20849.270275540282, 21065.0, 58317.416825832894, 59427.10859337027, 60052.39947600468, 60906.08640870302, 61762.0, 72024.27975720385, 74065.0, 75404.62297688695, 75696.62151689206, 76614.0, 14155.221462819643, 14466.638334041732, 14589.489367872073, 14614.926925365306, 14626.926865365605, 23294.883525582263, 23760.762392376546, 24179.758202418456, 24193.637095443934, 24195.79021048976, 18214.544636384195, 18368.448946531626, 18445.9077704616, 18552.628947421246, 18596.814031859507, 15595.454159104376, 16290.185490725653, 16561.337546498005, 16679.16604169811, 16807.0, 17988.280468781624, 19016.809831901504, 19142.138603762585, 19297.0, 19339.12973916149, 14597.489087881873, 14624.268786560417, 14631.561053168421, 14654.047486913316, 14692.118472891661, 17023.40418085361, 17160.74258886093, 17201.0, 18808.05959702037, 18884.15021324071], "value": 12164.926941957925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.918884866908, 1408.8309402871657, 1419.8225221847265, 1426.2155814302125, 1432.6633241188313, 13223.867761322384, 13817.963652726035, 13847.376868040938, 13849.099808512452, 13889.79165312521, 14198.71602567948, 14503.202323872209, 14566.781498277534, 14580.562583122522, 14586.708265834677, 2663.067926225815, 2725.4140359822636, 2733.808633395663, 2734.234414363971, 2736.6852811926683, 2618.9738102619017, 2812.3531587734833, 2822.7741780657498, 2829.5472724364104, 2833.0509279391426, 2729.0584748261817, 2732.79504037197, 2760.903368382107, 2771.1686494051705, 2773.6131934032983, 2634.7233540478355, 2677.477891811098, 2681.1688376603315, 2700.486907487571, 2736.5484695025198, 2605.049157057679, 2605.7524535169127, 2639.3797457597448, 2643.339165208698, 2643.3655922578637, 13490.123141995738, 13685.0, 13692.931535342359, 13723.725525489534, 13935.09421887574, 7512.624368781594, 7853.764387068397, 7872.370210383156, 7882.80292992674, 7889.211078892123, 5091.847244582631, 5314.468553144693, 5334.279872217278, 5338.572914166857, 5399.433059528771, 1621.456811967992, 1653.9503814885452, 1671.6740235654052, 1719.6904557179703, 1720.2001069502617, 22584.0, 22858.54282914349, 23197.53604927892, 23204.18785342505, 23239.0, 6357.4914006879335, 6591.604503729792, 6789.456843452512, 6796.966015169893, 6798.5241033128195, 15838.76241856373, 15866.44467443634, 15873.603159921095, 15888.523344299689, 15909.363625454853, 7295.781126566211, 7493.437992150611, 7496.362809161283, 7501.062367204099, 7504.474686771982, 6867.21361288359, 6973.0, 7064.1876184238445, 7114.466415018791, 7198.280171982865, 5017.799288028438, 5028.120078986163, 5057.8735531612, 5150.562202212854, 5176.948230517647, 1511.833698293187, 1518.5899807052035, 1525.1306755149458, 1525.192646713648, 1535.0559405965473, 830.4270053662954, 834.5535138700766, 847.588919374103, 882.4131952251809, 892.1569117184329, 6775.627340496221, 6888.586684798928, 7004.544704594185, 7020.824479388056, 7075.893861592081, 707.6249587718518, 710.1017213225274, 720.9062821833128, 727.6652739739673, 736.2196072163417, 3981.7411868228473, 4309.719868208556, 4558.407407037064, 4584.426946631671, 4739.218029025173, 18635.347762828234, 19299.131539080776, 19307.0, 19320.4203873884, 19391.4182574523, 18478.722819157723, 18981.525461863286, 19024.71462928057, 19197.520061998563, 19247.037648117817, 10344.741381465523, 10411.167106631452, 10640.095591874622, 10651.094656954245, 10676.946615266874, 6699.296573859675, 7344.632768361454, 7349.118105827335, 7468.253174682488, 7532.5857077859055, 15753.212339382755, 16720.0, 17033.48899533016, 17146.05696686694, 17199.05405202726, 16988.83011169922, 17092.145392730064, 17265.91367043207, 17458.650826983136, 17760.733588996434, 11130.443477826238, 11536.134789890624, 11823.881761182622, 11856.644300670649, 11856.703582410164, 12905.0, 13048.934755326163, 13126.409311581192, 13187.934060329637, 13220.0, 10214.540345684314, 10480.318779279323, 10697.839532406864, 10709.678709638723, 10784.245102842726, 10129.493525323556, 10380.48097595102, 10668.679939601825, 10707.732306692395, 10789.406582637715, 8644.0, 8995.055519170393, 9018.819623607622, 9040.231580315747, 9064.90935090667, 6120.693965301628, 6156.722947467464, 6247.250329960434, 6346.143270658402, 6464.967675161783, 6476.740930362733, 6726.159230096238, 6782.864342713019, 6832.795016149524, 6930.410915072275], "value": 6224.536212518282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.85925011371756, 494.68834634180484, 521.7834598641563, 527.3803281144654, 527.3934974779002, 6184.351232772663, 6186.566940314174, 6222.782202622898, 6240.62556246625, 6258.937410625898, 5882.4705776480105, 6058.697065146747, 6080.571065799533, 6107.69461526923, 6139.478144357735, 4820.975895120519, 4853.247746599282, 4874.902501949977, 4974.950250497503, 5028.949710502903, 4905.681130726492, 4915.139850526161, 4939.036887806861, 4955.776990035439, 4999.350084489011, 4747.789313724996, 4896.0, 4905.705657660534, 4920.212765957447, 4950.232713929328, 4879.731614761205, 4883.9267410988505, 4903.975480122613, 4916.410030796292, 4974.37820272466, 4401.625861801751, 4406.501789391622, 4415.757133357664, 4429.114177164548, 4436.356728274414, 5998.850028749316, 6003.339632640406, 6012.96993515034, 6082.148499210114, 6140.385961403868, 5579.358373786985, 5643.068893632546, 5687.800926967578, 5703.201551782754, 5723.77104915807, 6418.261899881527, 6479.64361960092, 6485.546011779177, 6525.5626174201525, 6566.573172743804, 4767.475577686451, 4821.590164835993, 4831.25115607078, 4845.927311090337, 4867.780949857265, 6857.314268573153, 6897.172339319263, 6917.688704008281, 6930.722771089201, 6965.616891070989, 4893.681910675866, 4923.655344125948, 4951.282064100686, 4952.752362381866, 4995.650304478724, 5071.644984851099, 5072.289879416885, 5077.111505486525, 5083.440821509631, 5088.643794934393, 5651.689157096399, 5666.546676265972, 5682.40334764852, 5695.629784064023, 5696.658200507983, 6376.426121649074, 6420.390062944013, 6436.292007879129, 6455.903161452582, 6574.638394888327, 1659.0, 1659.945934331684, 1688.5440930948575, 1729.1699984007746, 1779.5106345754762, 1211.1340391620033, 1212.1090998116376, 1229.4160273870018, 1238.928326997159, 1255.8179064035664, 5607.41122182165, 5666.376698563155, 5702.572307076985, 5706.600537962386, 5752.165935939265, 6386.393292637192, 6581.367453018831, 6627.536072474977, 6653.2681405045405, 6683.866322673519, 5711.314642242957, 5758.481736643638, 5772.884542309214, 5803.970980145073, 5832.795852145155, 3564.7504674672523, 3571.5178450909316, 3573.249617580337, 3574.267275208576, 3622.637736226409, 6424.775132870327, 6520.282768895418, 6529.934700653028, 6533.640649764214, 6559.573627714183, 6923.065386172903, 6926.411255043277, 6929.203141638776, 6940.548864323803, 6968.0, 6484.416402523795, 6492.188476440445, 6495.545311828127, 6526.282108967915, 6546.836329091716, 6613.702383392662, 6652.501062420241, 6658.434033107046, 6709.698063587248, 6712.731490740316, 6584.901226481702, 6590.373914478117, 6630.171228596426, 6649.301823308483, 6661.533692641662, 6330.841728956629, 6352.315656918883, 6365.872682546231, 6408.58344207625, 6426.775062872777, 4939.6542242042715, 4962.727050012284, 4978.47725988766, 4989.975050124872, 5029.245613157909, 6655.800325990228, 6690.130283063365, 6711.530192886451, 6730.192376914802, 6765.932340676531, 6356.618602883842, 6363.936360636334, 6389.456896163878, 6436.9034464484, 6442.162518872517, 6398.808035758934, 6429.903551446826, 6438.356164383712, 6508.60948343101, 6524.151860258136, 6035.426634469718, 6212.1303017578475, 6279.937200628118, 6317.178766760292, 6429.32492088324, 6334.398232167937, 6411.3909178627955, 6434.485241180788, 6438.066480360228, 6461.030845373231, 6178.7219575120125, 6289.9056514153235, 6307.085472606538, 6316.936830631635, 6334.398232167937], "value": 5012.605527789296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.8242351529695, 891.1623074310148, 895.6596493332532, 900.9864852027221, 910.1626503616671, 17894.194761235743, 19010.239590416382, 19100.044997750127, 19131.521711957208, 19136.425907222772, 19981.40055798325, 20771.792282077175, 20860.37418877436, 20862.582748345023, 20866.269680561185, 1003.9648612298571, 1024.0578667625803, 1025.60514202032, 1029.927905046647, 1030.3148406309795, 973.8441849304113, 999.6301368493667, 1054.0408228512056, 1056.6407421476697, 1061.8460323253123, 1104.5471356743737, 1104.7624760676454, 1105.2429086076063, 1109.8224284114544, 1110.21729680575, 1085.8534097896802, 1094.485591771866, 1097.1223021582703, 1099.384344766925, 1100.4552746390507, 803.0, 806.1615919443772, 806.7418426103649, 807.5074204735107, 810.6473683947502, 18728.906355468273, 19438.70841937372, 19451.805481945143, 19491.707624385646, 19668.901655491773, 20199.19203231869, 20483.28308509195, 20953.26663566768, 21021.5795684087, 21036.0, 15561.688766224725, 15811.130387828665, 15859.603509912344, 16002.119883406407, 16345.918270408572, 3397.5583174187445, 3413.7098346640564, 3421.2131209821882, 3426.7258619310646, 3428.9485657715154, 120215.39892300483, 122052.0, 127313.0, 127748.36125819404, 129043.35478322642, 14712.779308310384, 14874.776878346833, 14910.776338354934, 15120.092794432368, 15125.773113403087, 30516.84741576278, 30757.538636920464, 30939.0718278452, 31144.065678029696, 31235.0, 8231.46495477792, 8344.207300306462, 8344.582770861432, 8393.580320983927, 8399.328053755686, 4024.5774193709826, 4093.672506199497, 4109.198706252312, 4114.423980642712, 4115.464989551339, 4801.68789028712, 5259.500347466985, 5801.158831969341, 5855.824325270249, 5861.3552509223955, 1041.4844651897358, 1055.2613170780485, 1074.1621535202555, 1074.9892501075046, 1075.714935542082, 664.7939138866967, 669.6183175589964, 686.9519133660596, 694.3160986428364, 701.4949236549676, 12651.810222846665, 13455.596332110052, 13683.863161368457, 13802.895768338509, 14047.438102475786, 650.4178760009764, 670.289493137276, 687.4191308344441, 690.9063797002739, 696.9965150174216, 5181.3782346118705, 5676.864627074601, 6035.939640603538, 6129.632222066691, 6152.323244443108, 98761.0, 100780.49609751905, 102137.48931255296, 107163.46418268015, 107471.8505629883, 82901.58549207335, 84230.15769842223, 89973.55013224891, 91095.54452227829, 91301.54349228212, 73779.63110184415, 74741.62629186819, 77023.0, 77604.61197693975, 77639.61180194176, 12011.63965081049, 12299.631011069681, 12482.750344992868, 12554.246745195318, 12585.433655485342, 33225.833870830495, 34931.65068349284, 35661.465078023335, 35669.82165089158, 36467.27065458729, 44247.336289955034, 45976.31035534403, 46906.76546617245, 47266.52733472759, 48998.51001490082, 17824.0, 18128.27486900509, 18134.274629014693, 18300.90849545744, 18469.81530184681, 14992.352370765098, 19373.8062619372, 20306.187752489735, 20556.58886822285, 20568.79431205669, 16582.0, 17996.910015449837, 18071.457856264333, 18131.093445327944, 18139.637207255517, 18052.368167114088, 18059.909700451415, 18162.636747264718, 18226.45320640383, 18415.26338946427, 16115.516534503984, 16823.24295406734, 17013.48959531216, 17133.22900469507, 17213.225404856563, 11756.529738810352, 12375.257484550955, 12882.806757898827, 12988.35058247065, 13260.80108798388, 13527.0, 14023.50917717875, 14043.929780351033, 14422.783658244925, 14542.345594448063], "value": 8915.329222381186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 109.0, 111.0, 114.0, 109.0, 116.0, 108.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 141.0, 170.0, 123.0, 148.0, 148.0, 121.0, 172.0, 119.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 161.0, 164.0, 168.0, 165.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 74.0, 166.0, 75.0, 77.0, 80.0, 77.0, 163.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 141.0, 88.0, 79.0, 78.0, 131.0, 80.0, 79.0, 121.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 114.0, 119.0, 114.0, 114.0, 114.0, 115.0, 118.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 161.0, 154.0, 152.0, 152.0, 151.0, 157.0, 150.0], "value": 153.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 95.0, 96.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 64.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 60.0, 54.0, 54.0, 53.0, 62.0, 54.0, 54.0, 54.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 82.0, 79.0, 90.0, 96.0, 82.0, 83.0, 79.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 138.0, 135.0, 130.0, 128.0, 147.0, 139.0, 126.0, 181.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 191.0, 177.0, 183.0, 178.0, 183.0, 183.0, 178.0, 182.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 67.0, 69.0, 72.0, 73.0, 67.0, 71.0, 70.0, 70.0], "value": 71.1, "unit": "score"}]}]} 03:21:05 INFO - Return code: 0 03:21:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:06 INFO - # TBPL SUCCESS # 03:21:06 INFO - Running post-action listener: _package_coverage_data 03:21:06 INFO - Running post-action listener: _resource_record_post_action 03:21:06 INFO - [mozharness: 2017-08-01 10:21:06.021866Z] Finished run-tests step (success) 03:21:06 INFO - Running post-run listener: _resource_record_post_run 03:21:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 433217536; Read time: 280; Write time: 445564 03:21:06 INFO - TinderboxPrint: CPU usage
13.2% 03:21:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 280 03:21:06 INFO - TinderboxPrint: I/O write bytes / time
433,217,536 / 445,564 03:21:06 INFO - TinderboxPrint: CPU idle
8,277.8 (86.8%) 03:21:06 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 03:21:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:21:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 109215744; Read time: 0; Write time: 173852 03:21:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:21:06 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323293184; Read time: 264; Write time: 271704 03:21:06 INFO - Running post-run listener: _upload_blobber_files 03:21:06 INFO - Blob upload gear active. 03:21:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:06 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 03:21:06 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'] 03:21:06 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 03:21:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:07 INFO - (blobuploader) - INFO - Done attempting. 03:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:08 INFO - (blobuploader) - INFO - Done attempting. 03:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:09 INFO - (blobuploader) - INFO - Done attempting. 03:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:16 INFO - (blobuploader) - INFO - Done attempting. 03:21:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:16 INFO - Return code: 0 03:21:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/929a0a77a5b2c7899ac966541807ab1574e598879eda95a567c7dadd13f981688367d590ccea4d2e71d5a777497861f78a3467cbe9346d3c95c5eb3e654d23ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb654769412e379c1ac43539ac4345548b4dd765ef83df62f0de6dd734b88a77a5388abe446063eff46838364ad51a41c11a242926d7948ebd6e370983d1b435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d30efc08161b551d71e8b3bd6f9fa01b57dd7aca9a862634c030aa51e923c3ff58f71bb80b849da454303dbf2b55b094e441e82b91b5379337b325eb3b224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fd9632eeefbb73600080e28e313724174c4908bff2ccd7550617a5628e18f72922277a2b03f3719c063c394825ad316540075725544bc4fd4d2badbce8e153"} 03:21:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:16 INFO - Contents: 03:21:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/929a0a77a5b2c7899ac966541807ab1574e598879eda95a567c7dadd13f981688367d590ccea4d2e71d5a777497861f78a3467cbe9346d3c95c5eb3e654d23ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb654769412e379c1ac43539ac4345548b4dd765ef83df62f0de6dd734b88a77a5388abe446063eff46838364ad51a41c11a242926d7948ebd6e370983d1b435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d30efc08161b551d71e8b3bd6f9fa01b57dd7aca9a862634c030aa51e923c3ff58f71bb80b849da454303dbf2b55b094e441e82b91b5379337b325eb3b224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fd9632eeefbb73600080e28e313724174c4908bff2ccd7550617a5628e18f72922277a2b03f3719c063c394825ad316540075725544bc4fd4d2badbce8e153"} 03:21:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:16 INFO - Copying logs to upload dir... 03:21:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.935149 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-01 03:21:15.943622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:21:15.948390) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 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/929a0a77a5b2c7899ac966541807ab1574e598879eda95a567c7dadd13f981688367d590ccea4d2e71d5a777497861f78a3467cbe9346d3c95c5eb3e654d23ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb654769412e379c1ac43539ac4345548b4dd765ef83df62f0de6dd734b88a77a5388abe446063eff46838364ad51a41c11a242926d7948ebd6e370983d1b435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d30efc08161b551d71e8b3bd6f9fa01b57dd7aca9a862634c030aa51e923c3ff58f71bb80b849da454303dbf2b55b094e441e82b91b5379337b325eb3b224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fd9632eeefbb73600080e28e313724174c4908bff2ccd7550617a5628e18f72922277a2b03f3719c063c394825ad316540075725544bc4fd4d2badbce8e153"} build_url:https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/K1rcztDYQuCRwJgRJPvvbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/929a0a77a5b2c7899ac966541807ab1574e598879eda95a567c7dadd13f981688367d590ccea4d2e71d5a777497861f78a3467cbe9346d3c95c5eb3e654d23ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb654769412e379c1ac43539ac4345548b4dd765ef83df62f0de6dd734b88a77a5388abe446063eff46838364ad51a41c11a242926d7948ebd6e370983d1b435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d30efc08161b551d71e8b3bd6f9fa01b57dd7aca9a862634c030aa51e923c3ff58f71bb80b849da454303dbf2b55b094e441e82b91b5379337b325eb3b224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fd9632eeefbb73600080e28e313724174c4908bff2ccd7550617a5628e18f72922277a2b03f3719c063c394825ad316540075725544bc4fd4d2badbce8e153"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:21:15.973942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:21:15.974265) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501581448.574642-1947841637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:21:16.056352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:21:16.059748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:21:16.060050) ========= ========= Total master_lag: 0.45 =========