builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1501668090.78 results: success (0) revision: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:30.779294) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:30.779974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:30.780256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:30.885435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:30.885681) ========= 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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 03:01:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2017-08-02 03:01:31 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089042 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.004320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.004608) ========= 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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017907 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.077161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.077468) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52285ea5e54c73d3ed824544cef2ee3f195f05e6 --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 52285ea5e54c73d3ed824544cef2ee3f195f05e6 --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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 03:01:31,758 truncating revision to first 12 chars 2017-08-02 03:01:31,758 Setting DEBUG logging. 2017-08-02 03:01:31,758 attempt 1/10 2017-08-02 03:01:31,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52285ea5e54c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 03:01:32,281 unpacking tar archive at: mozilla-central-52285ea5e54c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913257 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.015732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.016012) ========= script_repo_revision: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.016343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.016601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.029485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-02 03:01:32.029765) ========= /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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:32 INFO - MultiFileLogger online at 20170802 03:01:32 in /builds/slave/test 03:01:32 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:01:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:32 INFO - {'append_to_log': False, 03:01:32 INFO - 'base_work_dir': '/builds/slave/test', 03:01:32 INFO - 'blob_upload_branch': 'Firefox', 03:01:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:32 INFO - 'branch': 'Firefox', 03:01:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:32 INFO - 'code_coverage': False, 03:01:32 INFO - 'config_files': ('talos/linux_config.py',), 03:01:32 INFO - 'default_actions': ('clobber', 03:01:32 INFO - 'read-buildbot-config', 03:01:32 INFO - 'download-and-extract', 03:01:32 INFO - 'populate-webroot', 03:01:32 INFO - 'create-virtualenv', 03:01:32 INFO - 'install', 03:01:32 INFO - 'setup-mitmproxy', 03:01:32 INFO - 'run-tests'), 03:01:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:32 INFO - 'disable_ccov_upload': False, 03:01:32 INFO - 'download_minidump_stackwalk': True, 03:01:32 INFO - 'download_symbols': 'ondemand', 03:01:32 INFO - 'enable_stylo': False, 03:01:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:32 INFO - 'gecko_profile': False, 03:01:32 INFO - 'gecko_profile_interval': 0, 03:01:32 INFO - 'installer_path': 'installer.exe', 03:01:32 INFO - 'log_level': 'info', 03:01:32 INFO - 'log_name': 'talos', 03:01:32 INFO - 'log_to_console': True, 03:01:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:32 INFO - 'opt_config_files': (), 03:01:32 INFO - 'pip_index': False, 03:01:32 INFO - 'suite': 'dromaeojs-e10s', 03:01:32 INFO - 'system_bits': '32', 03:01:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:32 INFO - 'title': 'talos-linux64-ix-020', 03:01:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:32 INFO - 'use_talos_json': True, 03:01:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:32 INFO - 'work_dir': 'build'} 03:01:32 INFO - [mozharness: 2017-08-02 10:01:32.815053Z] Running clobber step. 03:01:32 INFO - Running pre-action listener: _resource_record_pre_action 03:01:32 INFO - Running main action method: clobber 03:01:32 INFO - rmtree: /builds/slave/test/build 03:01:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:34 INFO - Running post-action listener: _resource_record_post_action 03:01:34 INFO - [mozharness: 2017-08-02 10:01:34.377369Z] Finished clobber step (success) 03:01:34 INFO - [mozharness: 2017-08-02 10:01:34.377481Z] Running read-buildbot-config step. 03:01:34 INFO - Running pre-action listener: _resource_record_pre_action 03:01:34 INFO - Running main action method: read_buildbot_config 03:01:34 INFO - Using buildbot properties: 03:01:34 INFO - { 03:01:34 INFO - "project": "", 03:01:34 INFO - "product": "firefox", 03:01:34 INFO - "who": "mtabara@mozilla.com", 03:01:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:01:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:01:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:01:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:01:34 INFO - "stage_platform": "linux64-stylosequential", 03:01:34 INFO - "basedir": "/builds/slave/test", 03:01:34 INFO - "buildnumber": 132, 03:01:34 INFO - "platform": "ubuntu64_hw_styloseq", 03:01:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:01:34 INFO - "slavebuilddir": "test", 03:01:34 INFO - "taskId": "I8ooUMokSwKkVwaF2SPdEA", 03:01:34 INFO - "branch": "mozilla-central", 03:01:34 INFO - "script_repo_revision": "production", 03:01:34 INFO - "revision": "52285ea5e54c73d3ed824544cef2ee3f195f05e6", 03:01:34 INFO - "slavename": "talos-linux64-ix-020", 03:01:34 INFO - "repo_path": "mozilla-central" 03:01:34 INFO - } 03:01:34 INFO - Finding installer, test and symbols from parent task. 03:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8ooUMokSwKkVwaF2SPdEA'}, attempt #1 03:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8ooUMokSwKkVwaF2SPdEA'}, attempt #1 03:01:35 INFO - Task dependencies: WPqz2tNLSqS-HHWkbIu55g 03:01:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g'}, attempt #1 03:01:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 03:01:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json 03:01:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.crashreporter-symbols.zip 03:01:35 INFO - Running post-action listener: _resource_record_post_action 03:01:35 INFO - [mozharness: 2017-08-02 10:01:35.741466Z] Finished read-buildbot-config step (success) 03:01:35 INFO - [mozharness: 2017-08-02 10:01:35.741692Z] Running download-and-extract step. 03:01:35 INFO - Running pre-action listener: _resource_record_pre_action 03:01:35 INFO - Running main action method: download_and_extract 03:01:35 INFO - mkdir: /builds/slave/test/build/tests 03:01:35 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:35 INFO - trying https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json 03:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:01:36 INFO - Downloaded 989 bytes. 03:01:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:01:36 INFO - Using the following test package requirements: 03:01:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:01:36 INFO - u'common': [u'target.common.tests.zip'], 03:01:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:01:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:01:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:01:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:01:36 INFO - u'mozbase': [u'target.common.tests.zip'], 03:01:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:01:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:01:36 INFO - u'web-platform': [u'target.common.tests.zip', 03:01:36 INFO - u'target.web-platform.tests.tar.gz'], 03:01:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:01:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:01:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip 03:01:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:36 INFO - Fetch https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip into memory 03:01:38 INFO - Content-Length response header: 72391728 03:01:38 INFO - Bytes received: 72391728 03:01:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:01:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip 03:01:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:50 INFO - Fetch https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.common.tests.zip into memory 03:01:52 INFO - Content-Length response header: 72391728 03:01:52 INFO - Bytes received: 72391728 03:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.talos.tests.zip 03:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.talos.tests.zip into memory 03:02:05 INFO - Content-Length response header: 14496467 03:02:05 INFO - Bytes received: 14496467 03:02:05 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:02:05 INFO - trying https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 03:02:05 INFO - Downloading https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:02:08 INFO - Downloaded 62280366 bytes. 03:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 03:02:08 INFO - mkdir: /builds/slave/test/properties 03:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:08 INFO - Contents: 03:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - Running post-action listener: set_extra_try_arguments 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.247065Z] Finished download-and-extract step (success) 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.247293Z] Running populate-webroot step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: populate_webroot 03:02:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['damp', 'tps']}, 03:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:02:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:08 INFO - 'ts_paint', 03:02:08 INFO - 'tpaint', 03:02:08 INFO - 'sessionrestore', 03:02:08 INFO - 'sessionrestore_many_windows', 03:02:08 INFO - 'sessionrestore_no_auto_restore', 03:02:08 INFO - 'tabpaint']}, 03:02:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:02:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:02:08 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:08 INFO - 'tsvgr_opacity', 03:02:08 INFO - 'tart', 03:02:08 INFO - 'tscrollx', 03:02:08 INFO - 'cart', 03:02:08 INFO - 'tsvg_static']}, 03:02:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:02:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--stylo-threads=1', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['tp6_google', 03:02:08 INFO - 'tp6_youtube', 03:02:08 INFO - 'tp6_amazon', 03:02:08 INFO - 'tp6_facebook']}, 03:02:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'talos_options': ['--xperf_path', 03:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:08 INFO - 'tests': ['tp5n']}}} 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.264777Z] Finished populate-webroot step (success) 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.264867Z] Running create-virtualenv step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: create_virtualenv 03:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:08 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:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:08 INFO - Using real prefix '/usr' 03:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:10 INFO - Installing pip.................done. 03:02:10 INFO - Return code: 0 03:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:02:11 INFO - Reading from file tmpfile_stdout 03:02:11 INFO - Output received: 03:02:11 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:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 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:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 INFO - Downloading/unpacking psutil>=3.1.1 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:12 INFO - Installing collected packages: psutil 03:02:12 INFO - Running setup.py install for psutil 03:02:12 INFO - building 'psutil._psutil_linux' extension 03:02:12 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:02:12 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:02:12 INFO - building 'psutil._psutil_posix' extension 03:02:12 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:02:13 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:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:13 INFO - Successfully installed psutil 03:02:13 INFO - Cleaning up... 03:02:13 INFO - Return code: 0 03:02:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:13 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:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:13 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:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:13 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:13 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:02:13 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:02:13 INFO - Using env: {'DISPLAY': ':0', 03:02:13 INFO - 'HOME': '/home/cltbld', 03:02:13 INFO - 'LANG': 'en_US.UTF-8', 03:02:13 INFO - 'LANGUAGE': 'en_US:en', 03:02:13 INFO - 'LOGNAME': 'cltbld', 03:02:13 INFO - 'MAIL': '/var/mail/cltbld', 03:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:13 INFO - 'MOZ_NO_REMOTE': '1', 03:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:13 INFO - 'NO_EM_RESTART': '1', 03:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:13 INFO - 'PWD': '/builds/slave/test', 03:02:13 INFO - 'SHELL': '/bin/bash', 03:02:13 INFO - 'SHLVL': '1', 03:02:13 INFO - 'TERM': 'linux', 03:02:13 INFO - 'TMOUT': '86400', 03:02:13 INFO - 'USER': 'cltbld', 03:02:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:13 INFO - '_': '/tools/buildbot/bin/python'} 03:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:14 INFO - Installing collected packages: mozsystemmonitor 03:02:14 INFO - Running setup.py install for mozsystemmonitor 03:02:14 INFO - Successfully installed mozsystemmonitor 03:02:14 INFO - Cleaning up... 03:02:14 INFO - Return code: 0 03:02:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:02:14 INFO - Using env: {'DISPLAY': ':0', 03:02:14 INFO - 'HOME': '/home/cltbld', 03:02:14 INFO - 'LANG': 'en_US.UTF-8', 03:02:14 INFO - 'LANGUAGE': 'en_US:en', 03:02:14 INFO - 'LOGNAME': 'cltbld', 03:02:14 INFO - 'MAIL': '/var/mail/cltbld', 03:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:14 INFO - 'MOZ_NO_REMOTE': '1', 03:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:14 INFO - 'NO_EM_RESTART': '1', 03:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:14 INFO - 'PWD': '/builds/slave/test', 03:02:14 INFO - 'SHELL': '/bin/bash', 03:02:14 INFO - 'SHLVL': '1', 03:02:14 INFO - 'TERM': 'linux', 03:02:14 INFO - 'TMOUT': '86400', 03:02:14 INFO - 'USER': 'cltbld', 03:02:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:14 INFO - '_': '/tools/buildbot/bin/python'} 03:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:16 INFO - warning: no files found matching '*.txt' 03:02:16 INFO - no previously-included directories found matching 'build' 03:02:16 INFO - no previously-included directories found matching 'dist' 03:02:16 INFO - no previously-included directories found matching '.git*' 03:02:16 INFO - Installing collected packages: jsonschema, functools32 03:02:16 INFO - Running setup.py install for functools32 03:02:16 INFO - warning: no files found matching '*.txt' 03:02:16 INFO - no previously-included directories found matching 'build' 03:02:16 INFO - no previously-included directories found matching 'dist' 03:02:16 INFO - no previously-included directories found matching '.git*' 03:02:16 INFO - Successfully installed jsonschema functools32 03:02:16 INFO - Cleaning up... 03:02:16 INFO - Return code: 0 03:02:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:16 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:16 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:02:16 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:02:16 INFO - Using env: {'DISPLAY': ':0', 03:02:16 INFO - 'HOME': '/home/cltbld', 03:02:16 INFO - 'LANG': 'en_US.UTF-8', 03:02:16 INFO - 'LANGUAGE': 'en_US:en', 03:02:16 INFO - 'LOGNAME': 'cltbld', 03:02:16 INFO - 'MAIL': '/var/mail/cltbld', 03:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:16 INFO - 'MOZ_NO_REMOTE': '1', 03:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:16 INFO - 'NO_EM_RESTART': '1', 03:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:16 INFO - 'PWD': '/builds/slave/test', 03:02:16 INFO - 'SHELL': '/bin/bash', 03:02:16 INFO - 'SHLVL': '1', 03:02:16 INFO - 'TERM': 'linux', 03:02:16 INFO - 'TMOUT': '86400', 03:02:16 INFO - 'USER': 'cltbld', 03:02:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:16 INFO - '_': '/tools/buildbot/bin/python'} 03:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:02:16 INFO - Cleaning up... 03:02:16 INFO - Return code: 0 03:02:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:16 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:16 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:02:16 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:02:16 INFO - Using env: {'DISPLAY': ':0', 03:02:16 INFO - 'HOME': '/home/cltbld', 03:02:16 INFO - 'LANG': 'en_US.UTF-8', 03:02:16 INFO - 'LANGUAGE': 'en_US:en', 03:02:16 INFO - 'LOGNAME': 'cltbld', 03:02:16 INFO - 'MAIL': '/var/mail/cltbld', 03:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:16 INFO - 'MOZ_NO_REMOTE': '1', 03:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:16 INFO - 'NO_EM_RESTART': '1', 03:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:16 INFO - 'PWD': '/builds/slave/test', 03:02:16 INFO - 'SHELL': '/bin/bash', 03:02:16 INFO - 'SHLVL': '1', 03:02:16 INFO - 'TERM': 'linux', 03:02:16 INFO - 'TMOUT': '86400', 03:02:16 INFO - 'USER': 'cltbld', 03:02:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:16 INFO - '_': '/tools/buildbot/bin/python'} 03:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:17 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:02:17 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:02:17 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:02:17 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:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:18 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:02:18 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:02:18 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:02:18 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:02:18 INFO - Downloading docopt-0.6.1.tar.gz 03:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:18 INFO - Running setup.py install for blobuploader 03:02:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:18 INFO - Running setup.py install for requests 03:02:18 INFO - Running setup.py install for docopt 03:02:19 INFO - Successfully installed blobuploader requests docopt 03:02:19 INFO - Cleaning up... 03:02:19 INFO - Return code: 0 03:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:19 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:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:19 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:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:19 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:19 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:02:19 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:02:19 INFO - Using env: {'DISPLAY': ':0', 03:02:19 INFO - 'HOME': '/home/cltbld', 03:02:19 INFO - 'LANG': 'en_US.UTF-8', 03:02:19 INFO - 'LANGUAGE': 'en_US:en', 03:02:19 INFO - 'LOGNAME': 'cltbld', 03:02:19 INFO - 'MAIL': '/var/mail/cltbld', 03:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:19 INFO - 'MOZ_NO_REMOTE': '1', 03:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:19 INFO - 'NO_EM_RESTART': '1', 03:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:19 INFO - 'PWD': '/builds/slave/test', 03:02:19 INFO - 'SHELL': '/bin/bash', 03:02:19 INFO - 'SHLVL': '1', 03:02:19 INFO - 'TERM': 'linux', 03:02:19 INFO - 'TMOUT': '86400', 03:02:19 INFO - 'USER': 'cltbld', 03:02:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:19 INFO - '_': '/tools/buildbot/bin/python'} 03:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:19 INFO - Running setup.py (path:/tmp/pip-0erfHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:19 INFO - Running setup.py (path:/tmp/pip-dlypwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:19 INFO - Running setup.py (path:/tmp/pip-vphq21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:19 INFO - Running setup.py (path:/tmp/pip-eZZQeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:19 INFO - Running setup.py (path:/tmp/pip-AN1iuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:19 INFO - Running setup.py (path:/tmp/pip-XsN399-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:19 INFO - Running setup.py (path:/tmp/pip-4mWXRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:19 INFO - Running setup.py (path:/tmp/pip-LrxlHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:19 INFO - Running setup.py (path:/tmp/pip-jXtVxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:19 INFO - Running setup.py (path:/tmp/pip-i5T9QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:20 INFO - Running setup.py (path:/tmp/pip-Oogo3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:20 INFO - Running setup.py (path:/tmp/pip-8UCxep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:20 INFO - Running setup.py (path:/tmp/pip-NParxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:20 INFO - Running setup.py (path:/tmp/pip-QvEHre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:20 INFO - Running setup.py (path:/tmp/pip-eRCktD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:20 INFO - Running setup.py (path:/tmp/pip-yHGm72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:20 INFO - Running setup.py (path:/tmp/pip-9XpdFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:20 INFO - Running setup.py install for manifestparser 03:02:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:20 INFO - Running setup.py install for mozcrash 03:02:20 INFO - Running setup.py install for mozdebug 03:02:20 INFO - Running setup.py install for mozdevice 03:02:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:20 INFO - Running setup.py install for mozfile 03:02:21 INFO - Running setup.py install for mozhttpd 03:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozinfo 03:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozInstall 03:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozleak 03:02:21 INFO - Running setup.py install for mozlog 03:02:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for moznetwork 03:02:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozprocess 03:02:21 INFO - Running setup.py install for mozprofile 03:02:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozrunner 03:02:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozscreenshot 03:02:22 INFO - Running setup.py install for moztest 03:02:22 INFO - Running setup.py install for mozversion 03:02:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:22 INFO - Cleaning up... 03:02:22 INFO - Return code: 0 03:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:22 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:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:22 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:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:22 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:22 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:02:22 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:02:22 INFO - Using env: {'DISPLAY': ':0', 03:02:22 INFO - 'HOME': '/home/cltbld', 03:02:22 INFO - 'LANG': 'en_US.UTF-8', 03:02:22 INFO - 'LANGUAGE': 'en_US:en', 03:02:22 INFO - 'LOGNAME': 'cltbld', 03:02:22 INFO - 'MAIL': '/var/mail/cltbld', 03:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:22 INFO - 'MOZ_NO_REMOTE': '1', 03:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:22 INFO - 'NO_EM_RESTART': '1', 03:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:22 INFO - 'PWD': '/builds/slave/test', 03:02:22 INFO - 'SHELL': '/bin/bash', 03:02:22 INFO - 'SHLVL': '1', 03:02:22 INFO - 'TERM': 'linux', 03:02:22 INFO - 'TMOUT': '86400', 03:02:22 INFO - 'USER': 'cltbld', 03:02:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:22 INFO - '_': '/tools/buildbot/bin/python'} 03:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:22 INFO - Running setup.py (path:/tmp/pip-g1TkYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:22 INFO - Running setup.py (path:/tmp/pip-9CSUPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:22 INFO - Running setup.py (path:/tmp/pip-qvGwBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:22 INFO - Running setup.py (path:/tmp/pip-AbEcgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:22 INFO - Running setup.py (path:/tmp/pip-02us5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:22 INFO - Running setup.py (path:/tmp/pip-KKttnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:22 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:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:22 INFO - Running setup.py (path:/tmp/pip-2w45VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:23 INFO - Running setup.py (path:/tmp/pip-2a2O7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:23 INFO - Running setup.py (path:/tmp/pip-qKmR0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:23 INFO - Running setup.py (path:/tmp/pip-AgI6A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:23 INFO - Running setup.py (path:/tmp/pip-UZIrXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:23 INFO - Running setup.py (path:/tmp/pip-SKjgxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:23 INFO - Running setup.py (path:/tmp/pip-nM99Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:23 INFO - Running setup.py (path:/tmp/pip-0UduqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:23 INFO - Running setup.py (path:/tmp/pip-IYMT5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:23 INFO - Running setup.py (path:/tmp/pip-0jGdlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:23 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:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:23 INFO - Running setup.py (path:/tmp/pip-6EpxTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:23 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:02:23 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:02:23 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:02:23 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:02:23 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:02:23 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:02:23 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:02:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:24 INFO - Downloading blessings-1.6.tar.gz 03:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:24 INFO - Installing collected packages: blessings 03:02:24 INFO - Running setup.py install for blessings 03:02:25 INFO - Successfully installed blessings 03:02:25 INFO - Cleaning up... 03:02:25 INFO - Return code: 0 03:02:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:25 INFO - Reading from file tmpfile_stdout 03:02:25 INFO - Current package versions: 03:02:25 INFO - argparse == 1.2.1 03:02:25 INFO - blessings == 1.6 03:02:25 INFO - blobuploader == 1.2.4 03:02:25 INFO - docopt == 0.6.1 03:02:25 INFO - functools32 == 3.2.3-2 03:02:25 INFO - jsonschema == 2.5.1 03:02:25 INFO - manifestparser == 1.1 03:02:25 INFO - mozInstall == 1.13 03:02:25 INFO - mozcrash == 1.0 03:02:25 INFO - mozdebug == 0.1 03:02:25 INFO - mozdevice == 0.51 03:02:25 INFO - mozfile == 1.2 03:02:25 INFO - mozhttpd == 0.7 03:02:25 INFO - mozinfo == 0.10 03:02:25 INFO - mozleak == 0.1 03:02:25 INFO - mozlog == 3.5 03:02:25 INFO - moznetwork == 0.27 03:02:25 INFO - mozprocess == 0.25 03:02:25 INFO - mozprofile == 0.28 03:02:25 INFO - mozrunner == 6.13 03:02:25 INFO - mozscreenshot == 0.1 03:02:25 INFO - mozsystemmonitor == 0.3 03:02:25 INFO - moztest == 0.8 03:02:25 INFO - mozversion == 1.4 03:02:25 INFO - psutil == 3.1.1 03:02:25 INFO - requests == 1.2.3 03:02:25 INFO - wsgiref == 0.1.2 03:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:25 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:25 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:02:25 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:02:25 INFO - Using env: {'DISPLAY': ':0', 03:02:25 INFO - 'HOME': '/home/cltbld', 03:02:25 INFO - 'LANG': 'en_US.UTF-8', 03:02:25 INFO - 'LANGUAGE': 'en_US:en', 03:02:25 INFO - 'LOGNAME': 'cltbld', 03:02:25 INFO - 'MAIL': '/var/mail/cltbld', 03:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:25 INFO - 'MOZ_NO_REMOTE': '1', 03:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:25 INFO - 'NO_EM_RESTART': '1', 03:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:25 INFO - 'PWD': '/builds/slave/test', 03:02:25 INFO - 'SHELL': '/bin/bash', 03:02:25 INFO - 'SHLVL': '1', 03:02:25 INFO - 'TERM': 'linux', 03:02:25 INFO - 'TMOUT': '86400', 03:02:25 INFO - 'USER': 'cltbld', 03:02:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:25 INFO - '_': '/tools/buildbot/bin/python'} 03:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:25 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:02:25 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:02:25 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:02:25 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:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:02:26 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:02:26 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:02:26 INFO - Installing collected packages: simplejson 03:02:26 INFO - Running setup.py install for simplejson 03:02:26 INFO - building 'simplejson._speedups' extension 03:02:26 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:02:27 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:02:27 INFO - Successfully installed simplejson 03:02:27 INFO - Cleaning up... 03:02:27 INFO - Return code: 0 03:02:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02: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:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:27 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b72d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, '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': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', '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:02:27 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:02:27 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:02:27 INFO - Using env: {'DISPLAY': ':0', 03:02:27 INFO - 'HOME': '/home/cltbld', 03:02:27 INFO - 'LANG': 'en_US.UTF-8', 03:02:27 INFO - 'LANGUAGE': 'en_US:en', 03:02:27 INFO - 'LOGNAME': 'cltbld', 03:02:27 INFO - 'MAIL': '/var/mail/cltbld', 03:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:27 INFO - 'MOZ_NO_REMOTE': '1', 03:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:27 INFO - 'NO_EM_RESTART': '1', 03:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:27 INFO - 'PWD': '/builds/slave/test', 03:02:27 INFO - 'SHELL': '/bin/bash', 03:02:27 INFO - 'SHLVL': '1', 03:02:27 INFO - 'TERM': 'linux', 03:02:27 INFO - 'TMOUT': '86400', 03:02:27 INFO - 'USER': 'cltbld', 03:02:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:27 INFO - '_': '/tools/buildbot/bin/python'} 03:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:27 INFO - Cleaning up... 03:02:27 INFO - Return code: 0 03:02:27 INFO - Running post-action listener: _resource_record_post_action 03:02:27 INFO - Running post-action listener: _start_resource_monitoring 03:02:27 INFO - Starting resource monitoring. 03:02:27 INFO - [mozharness: 2017-08-02 10:02:27.997485Z] Finished create-virtualenv step (success) 03:02:27 INFO - [mozharness: 2017-08-02 10:02:27.997955Z] Running install step. 03:02:27 INFO - Running pre-action listener: _resource_record_pre_action 03:02:27 INFO - Running main action method: install 03:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:28 INFO - Reading from file tmpfile_stdout 03:02:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:28 INFO - Reading from file tmpfile_stdout 03:02:28 INFO - Output received: 03:02:28 INFO - Usage: mozinstall [options] installer 03:02:28 INFO - Options: 03:02:28 INFO - -h, --help show this help message and exit 03:02:28 INFO - -d DEST, --destination=DEST 03:02:28 INFO - Directory to install application into. [default: 03:02:28 INFO - "/builds/slave/test"] 03:02:28 INFO - --app=APP Application being installed. [default: firefox] 03:02:28 INFO - mkdir: /builds/slave/test/build/application 03:02:28 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:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:02:46 INFO - Reading from file tmpfile_stdout 03:02:46 INFO - Output received: 03:02:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:46 INFO - Running post-action listener: _resource_record_post_action 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.385498Z] Finished install step (success) 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.385758Z] Running setup-mitmproxy step. 03:02:46 INFO - Running pre-action listener: _resource_record_pre_action 03:02:46 INFO - Running main action method: setup_mitmproxy 03:02:46 INFO - Skipping: mitmproxy is not required 03:02:46 INFO - Running post-action listener: _resource_record_post_action 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.386884Z] Finished setup-mitmproxy step (success) 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.387105Z] Running run-tests step. 03:02:46 INFO - Running pre-action listener: _resource_record_pre_action 03:02:46 INFO - Running pre-action listener: _set_gcov_prefix 03:02:46 INFO - Running main action method: run_tests 03:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:46 INFO - Python 2.7.3 03:02:46 INFO - Return code: 0 03:02:46 INFO - grabbing minidump binary from tooltool 03:02:46 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:02:46 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 0x2b6feb0>, '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 0x2b70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:46 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:02:46 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:02:46 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:02:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:46 INFO - Return code: 0 03:02:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:46 INFO - ENV: RUST_BACKTRACE is now 1 03:02:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:46 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/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:02:46 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/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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:02:46 INFO - Using env: {'DISPLAY': ':0', 03:02:46 INFO - 'HOME': '/home/cltbld', 03:02:46 INFO - 'LANG': 'en_US.UTF-8', 03:02:46 INFO - 'LANGUAGE': 'en_US:en', 03:02:46 INFO - 'LOGNAME': 'cltbld', 03:02:46 INFO - 'MAIL': '/var/mail/cltbld', 03:02:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:46 INFO - 'MOZ_NO_REMOTE': '1', 03:02:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:46 INFO - 'NO_EM_RESTART': '1', 03:02:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:46 INFO - 'PWD': '/builds/slave/test', 03:02:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:46 INFO - 'RUST_BACKTRACE': '1', 03:02:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:02:46 INFO - 'SHELL': '/bin/bash', 03:02:46 INFO - 'SHLVL': '1', 03:02:46 INFO - 'STYLO_FORCE_ENABLED': '1', 03:02:46 INFO - 'TERM': 'linux', 03:02:46 INFO - 'TMOUT': '86400', 03:02:46 INFO - 'USER': 'cltbld', 03:02:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444', 03:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:46 INFO - '_': '/tools/buildbot/bin/python'} 03:02:46 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/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:02:46 INFO - mozversion application_buildid: 20170802081143 03:02:46 INFO - mozversion application_changeset: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 03:02:46 INFO - mozversion application_display_name: Nightly 03:02:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:46 INFO - mozversion application_name: Firefox 03:02:46 INFO - mozversion application_remotingname: firefox 03:02:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:02:46 INFO - mozversion application_vendor: Mozilla 03:02:46 INFO - mozversion application_version: 57.0a1 03:02:46 INFO - mozversion platform_buildid: 20170802081143 03:02:46 INFO - mozversion platform_changeset: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 03:02:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:02:46 INFO - mozversion platform_version: 57.0a1 03:02:46 INFO - using testdate: 1501668166 03:02:46 INFO - actual date: 1501668166 03:02:46 INFO - starting webserver on 'localhost:51281' 03:02:46 INFO - SUITE-START | Running 2 tests 03:02:46 INFO - TEST-START | dromaeo_css 03:02:46 INFO - Initialising browser for dromaeo_css test... 03:02:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51281/getInfo.html -profile /tmp/tmpmt3Y9n/profile 03:02:46 INFO - TEST-INFO | started process 20250 (/builds/slave/test/build/application/firefox/firefox http://localhost:51281/getInfo.html) 03:02:53 INFO - TEST-INFO | 20250: exit 0 03:02:53 INFO - Browser initialized. 03:02:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:53 INFO - TEST-INFO | started process 20476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmt3Y9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:54 INFO - PID 20476 | 03:02:54 INFO - PID 20476 | (/builds/slave/test/build/application/firefox/firefox:20531): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:02:54 INFO - PID 20476 | 03:03:05 INFO - PID 20476 | RSS: Main: 174018560 03:03:05 INFO - PID 20476 | 03:06:04 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51281/tests/dromaeo/cssquery-ext.html) 03:06:06 INFO - PID 20476 | RSS: Main: 175820800 03:06:06 INFO - PID 20476 | 03:09:08 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-ext.html (next: http://localhost:51281/tests/dromaeo/cssquery-jquery.html) 03:09:08 INFO - PID 20476 | RSS: Main: 172396544 03:09:08 INFO - PID 20476 | 03:12:10 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51281/tests/dromaeo/cssquery-mootools.html) 03:12:11 INFO - PID 20476 | RSS: Main: 175702016 03:12:11 INFO - PID 20476 | 03:15:13 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51281/tests/dromaeo/cssquery-prototype.html) 03:15:13 INFO - PID 20476 | RSS: Main: 172748800 03:15:13 INFO - PID 20476 | 03:18:17 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51281/tests/dromaeo/cssquery-yui.html) 03:18:18 INFO - PID 20476 | RSS: Main: 177299456 03:18:18 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-yui.html (next: http://localhost:51281/tests/dromaeo/cssquery-dojo.html) 03:21:20 INFO - PID 20476 | RSS: Main: 178323456 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | __start_tp_report 03:21:20 INFO - PID 20476 | _x_x_mozilla_page_load 03:21:20 INFO - PID 20476 | _x_x_mozilla_page_load_details 03:21:20 INFO - PID 20476 | |i|pagename|runs| 03:21:20 INFO - PID 20476 | |0;dojo.html;3102.1934297082753;3152.401043801676;3156.084735426726;3177.952330715039;3196.4406228909934;6076.969615151924;6146.969265153673;6189.597676151047;6209.285932117802;6215.813525594228;6185.072239164117;6187.35032821554;6211.223597050369;6216.782412615559;6236.688165591725;5701.543876489892;5711.143328500737;5734.369219385864;5769.538436925036;5841.853953651172;5761.251037365137;5805.100209467518;5824.825255242349;5838.562107841907;5843.64938103713;5650.3219613646625;5786.739596718157;5850.297964244297;5851.151583020481;5863.179154918314;5589.860253493695;5619.466150715675;5656.434356564352;5738.799142030009;5739.483446489836;5557.694326812024;5604.41153678866;5631.887362252773;5637.041702910515;5641.802536911229;6089.330173680892;6178.042403427476;6207.844803879939;6220.284667263278;6233.189685340877;6652.334766523309;6655;6702.597844129319;6726.091977583062;6740.427063699592;6565.868682626321;6694.263631000586;6724.562903411263;6749;6771.424428923548;6203.844903877439;6289.528285378615;6289.87420251597;6296.811095667045;6316.273628532732;6835.487338449636;6911.89632155518;6917.13535808024;6937.479689023243;6948.131483564554;6543.672816359163;6583.506237032242;6585.86828263432;6595.604263744191;6596.8350791230605;6670.633115178614;6691.297413771484;6718.294579069225;6719.932800672029;6735.764248251287;6514.088027676129;6602.207735071822;6612.23959244693;6616.60300381969;6628.502862285348;6581;6585.6377899216;6591.0442985766795;6604.8348791280605;6612.140421745143;5373.704446255493;5430.647007944471;5430.64700794455;5431.1853222016225;5433.782648694087;4591.977040114778;4598.8620341389815;4617.907641847211;4619.2609182531305;4625.283081122431;5744.281964754406;5795.420457954171;5812.564057695689;5881.264841894763;5895.322037965603;6655.23464801554;6685.465162786965;6810.114685091005;6816.7614133505085;6817.0796942413135;5659.660420374708;5758.971205143947;5776.942230577724;5783.421657834183;5800.303963524319;5874.383189765099;5884.205632239593;5901.8196360728025;5929.347771745104;5963.254593175853;6503.089567460464;6517.576357536745;6537.607743535403;6555.737770489127;6587.703553340111;6668.066470694203;6687;6777.390034896883;6778.525503214728;6785.5250132490255;6475.3200913903365;6481.935180648133;6555.4427873631275;6566;6575.046618240424;6443.194600674916;6533.640649764118;6546.705398256994;6562.310957349409;6562.376574225441;6606.702698378681;6694.799156025327;6729.1252137221845;6730.192376914802;6730.293319201413;6505.41451269388;6510.18622672166;6533.118029066205;6535.934640653532;6626.5030122741955;6513.185851768529;6528.314526974789;6599.7360105595235;6613.735450582115;6624.966875165786;6366.9044964326495;6452.35476452351;6453.290138084901;6462.806115816533;6465.353464653497;6447.451966582893;6513.54405191632;6557.672116394066;6637.1703537057865;6653.900191497035;6411.775587854403;6428.517861160338;6432.549721519449;6436;6442.742290308335 03:21:20 INFO - PID 20476 | |1;ext.html;825.1954344514099;873.7029410000599;904.9457032578042;906.35195834978;1163.2555164694602;32970.34059318815;33762.66237337629;33932.15169620758;43823.34264986028;45115.77442112785;45316.320255196195;45715.31427028597;45725;45831.77084114575;45865;7419.554826710388;7730.304272615477;7903.644336004893;7992.200779922019;8041.075276343207;7856.842863142734;7970.163132871052;7972.840543189132;7973.641186146609;7978.760637180894;7817.257360550739;7925.445218834684;7925.643346049442;7945.920540794576;7986.520808751465;7921.683132674686;7950.840983180362;7954.363650907913;7957.960210198969;7980.441369104136;7839.6472158752995;7869.567173805438;7872.527648341118;7874.763757087297;7902.802429939297;41288.1742365151;41462.1707565847;41593.1681366371;41673.79163104195;41696.791516042525;3663.761855479412;3671.596124426311;3698.9630103698887;3706.5366829146355;3739.7943113128767;33363.66636333654;33405.83297083523;33479.83260083684;33497.83251083729;33562;4870.707757534559;4957.925631115536;4966.15575352191;4997.300377947054;5028.84913452597;196678;197334;197832;198230.99999999854;198234;49791.25313120306;50134.49865501371;50621.240681389805;50644;50818.491815081376;53679.19481207785;53821.730891345294;53899.73050134724;54086.45913540893;54092.72953635207;13541.39063742134;13811;13831.585052448443;13841.723165536632;13858.930705346409;10465.790684186273;10551.577936882592;10589.311694739818;10599.84100238497;12158.209716368408;14807.555773326601;14908.403663853542;14922.179280139697;14936.178510181828;15064;5881.558883083786;5903.557233207526;5962.135490353874;6000.549958753111;6005.249343832021;1010.8483727440796;1033.6382266206917;1039.6465201831413;1047.69093117529;1051.5761170501914;23122.76877231206;23405.297841064796;23800.166994155123;23842.40393990164;31022.534661980088;1131.1007748839693;1139.5043156227068;1143.3711458697683;1147.0708725932022;1147.1912301827358;12717.427715752814;13209.933950330187;13271.800922986164;13309.267990260434;13447.731045379038;249301;251395.74302128374;251532;251535;252498;58190;58289;58347.70826145842;58580.70709646425;58640;1497.2962707527445;1505.6085417791235;1549.7520396736468;1557.0735412429585;1559.8050243719536;24347.634785477876;24615.261542153763;29833.701662983094;30328.696713032587;30649.233769155948;55532;55633.72183139058;55639.72180139073;55737;55868;219331;219371;220317;220997;221430;38443.42334864923;38668.2266354677;39321.60678393179;40389.79805101073;40437.393439099025;50172;51645;51718.48281517137;52240;52458;36134.819325903205;36468.45297320595;36643.45034824427;37072.258554828215;37107.44338834973;36233.45649815202;36311.636883630825;36611.63388366082;36641.633583663825;36775.816120919226;39867.40198897077;40435;40534.797326013184;40541;40677.1864562713;34771.304573908885;34999.4750078744;35161.29677406489;35163.29673406569;35387.82306088453;25420;25529.87235063813;26169.60745588856;26486;26602.866985664947 03:21:20 INFO - PID 20476 | |2;jquery.html;589.4459208344156;592.5467017731434;593.2613895699855;596.594315865212;611.9326874043854;22712;22846.88576557119;23569.175078872242;23711.881440592817;23714.88142559285;25312;26911.73088269117;26959.86520067402;26971.86514067432;27059.323516912085;6304.085907543415;6470.773522926698;6474.255460622018;6491.156149700556;6511;6195.2565692117005;6484.221893372778;6489.578177418476;6493.188351456068;6583;6426.935730642704;6432.614043157426;6457.580257283285;6459.289478157399;6468.159139311882;6386.10594516768;6445.452136568374;6455.289918109028;6463.93536064638;6470.805875823709;6017.187679663233;6018.4583387494895;6022.939770602282;6027.216461859974;6036.849078773066;29685.703142968727;30250;30849.691503084905;31030.844845775628;31197.220069498217;1937.457511896657;2007.7992200779952;2008.7187793708893;2009.768876579183;2010.447127040061;18835.340763073364;19482.902585487125;19503.609927801364;19585;19602.803971960384;2041.7039529268322;2090.6132365512276;2095.287602215239;2095.423758466419;2325.860448373103;140226;143210.56789432076;143578.28210858983;143804;147088.2645586776;14575.344109515097;15280.847191527942;15429.691406171814;15481.303341349667;16001.919990399974;22837.543249134924;24117.276481705576;24282.757172428403;24341.14805981782;24368.878155609462;9551.952240238754;9634.421934683942;9760;9765.511724413893;9807.117359437685;8744.256738177326;8779;8823.073577274294;8841.292696584258;8852.690155844515;9394.812103757886;9423.811523769486;9762.707118786448;9769.853452198222;9775.120239178508;2777.6250206221903;2788.33080060788;2815.3806162644187;2835.617191679138;2860.2134413036165;934.2525979216599;945.6926498887889;978.5889926231;1002.2683441087901;1002.6791426743372;19807.4057778264;19861.31178849814;19906.303279385153;19927.501812454804;20305.187792488432;1038.5689938675516;1042.1506472225112;1054.5781687325132;1059.4490864750287;1062.2458054781036;11028;11400.714982125513;13317.600471985856;14178.361973711208;14703.779443308358;508923;522254;522330;583954;589637;124734;126479;127781;129739;130855;1258.13817534987;1264.121435602266;1272.0396100943913;1284.0882973089024;1292.8170723787816;21438.356849294545;21719.891400542896;21822.454438638524;22072.33782986513;22140.889295553417;46707.76646116748;58761.70619147048;58826;62091;62775;70803;71068.28931710617;72276.63861680658;76395.61802190954;77490.6125469369;21095.789042109995;21321;21547.892260538596;21845.890770546044;22115.889420552794;23085.769142309033;23134.537309254058;23873.283801485984;24028.63957040681;24234.636480452456;18276.086195689895;18790.53023674419;18947.90526047361;19235.1344189509;19237.807621923603;17063.91468042652;17427.738583920996;17461.563460913578;18014.068966894054;18110.18504167342;18688.626227475645;18708.06459677038;19093.522661933563;19582.510437239183;19585.804141958397;20708.171673132907;20820.791792081884;20946.47633809167;21077.894610526848;21109.788902110784;18143.455696329132;18664.44006679802;19532.707009395155;19589;19593.608127837648 03:21:20 INFO - PID 20476 | |3;mootools.html;1304.895608351332;1372.0669944437777;1377.3319939829182;1381.9930900345496;1388.6875453023072;13300.401481933312;13918.1649101054;13938.790918136223;13977.580672579814;13984.790228146561;13130.343482825845;13608.795868061987;14132.152070875729;14143.363548640311;14157.504487342945;2695.555233386489;2741.0954385052883;2745.6156138140677;2747.738964798351;2748.1068652687854;2611.5429799785056;2679.102500662271;2734.53512902806;2735.1110888961066;2735.726427357258;2602.4664943686594;2651.8408895466237;2679.1426743442107;2733.316670832292;2733.5489644208683;2639.986800065997;2644.6694163229595;2669.853158076305;2673.2648521656506;2673.5454972654597;2623.22614828626;2631.776299014567;2645.166772466686;2648.2717252755456;2648.9205323840124;13110.934445327712;13363.398647060905;13386.129901556367;13429.798553021712;13473.528426505123;7506.437017223676;7816.49192802466;7826.726064587712;7828.647710853025;7836.804079897991;5081.297765248646;5129.384473863161;5135.460776618439;5215.400228973679;5255.553277971377;1815.428140135853;1825.078335440594;1830.560665440298;1832.4594244697846;1880.2479008396615;21265.468363290885;21551;21557.137714491244;21571.784282157292;21576.568468630696;6280.434760871452;6467.611943283418;6485.1245081914285;6681.365270299314;6692.966535167293;15250.694986100216;15290.464833730766;15302.770458443132;15329.693406132037;15334.463293784664;7242.3843973262865;7624.847503049908;7637.579933103621;7643.7324693635455;7645.044369453818;6148.047052706837;6375.075614035939;7005.334493223136;7240.5149254475755;7279.818004549823;5060;5128.205128205134;5208.114620514521;5231.869203269949;5258.106121959276;1495.0730547060891;1509.532045066033;1510.5770384292416;1514.2655811931204;1543.8378970208191;897.4929165021741;926.4672813132476;928.5032507608397;937.9531023448936;943.0192599696239;7454.813629659302;7460.962695186598;7538.698452061966;7548.7357942472845;7626.275503827128;705.6401235369896;737.3032484302283;750.1036261667364;758.4198088462331;771.5949126708523;4688.320193571913;5702.885942281131;5733.254676891977;5858.47273745365;5876.500497457679;19198.616027679367;19241;19564.902175489315;19572.70640940387;19575.314863979693;17913.641727165385;18918.14868330901;18926.716099258523;18942;18991.43025709231;10493.842592361121;10656.89343106559;10720.249582529148;10728.141748660088;10743.194260430499;8364.665413383396;8755.737327880173;8772.210501054935;8832.425892316978;8873.511956842436;16302.673946520767;16468.917655411646;16794.412195573095;16963.491095267163;17148.828511715223;16175.43385981485;16452.259648315616;16608.916955415145;17166.914165429094;17218.741718873975;11097.33415995043;11325.71685707864;11336.149788765711;11346.94326528362;11359.54561817518;12518.874811251771;12704.555340563036;12780.744385112432;12811.359432028175;12826.486940522274;10223.028812262823;10318.535665895202;10368.740781480523;10411.895881041395;10541.73645658834;10242;10376;10465.110465610509;10536.947315263375;10680.786384272427;9217.953910230674;9414;9433.198178154933;9434.716958491255;9437.292203084933;6931.618760968196;6933.653317334012;7003.404710599452;7027;7105.360517553445;7210.206877243394;7253.347198751927;7256.673449694671;7279.672414741243;7288.453365997678 03:21:20 INFO - PID 20476 | |4;prototype.html;496.85342823866955;500.8647665130415;531.1342511705918;533.2853975672599;543.1228565866128;6146.66193359365;6211.254649442062;6277.937220627798;6293.748250069997;6317.336679648634;5973.22348094747;6055.878882422349;6089.391060893909;6090.23872015998;6113.51091912647;4884.29177769225;4904.4114706235305;4947.752612369385;4956.677815941952;4976.278439626261;4896.828610998616;4971.577415919651;4973.378327709036;4986.276989836471;5007.7496125193775;4674.345591617176;4869.9773047659855;4876.853694389174;4892.437369702477;4920.163572192736;4888;4906.239532872411;4918;4931.26031095335;4953.405591329064;4395.856962271959;4409.757463339515;4415.558444155591;4422.823087076546;4476.306172543261;5989.850253743648;5998.97000514999;6072;6134.9079763803575;6145.262568491765;5647.712676366037;5664.490195882349;5682.687452190128;5720.8283751487525;5769.509591684712;6471.214339611333;6490.156279683611;6492.350764923517;6509.772157974496;6521.739130434777;4819.770958405619;4829.2997515360075;4831.855044348676;4834.371531700892;4853.563179313844;6944.51388402812;6954.79135625932;6960.677471280491;6997.650117494105;7026.9648651756415;4933.136701077369;4950.257461380822;4958.487776123782;4975.427825800007;5005.174146265826;4995.500449955048;5046.318746969112;5047.671901326402;5055.620828437808;5090.618203634742;5698.943010569924;5713.600047996601;5719.5138413235345;5721.828345149652;5723.112917497794;6670.266270710218;6670.633115178712;6715.3620406061345;6726.529142959946;6744.42672372844;1640.860526855207;1682.9747553786704;1687.0974028894482;1754.4298103116282;1763.5238485608813;1198.2091819399154;1212.0545974140184;1213.538855235005;1233.3586535001928;1248.4506817000672;5713.971430142906;5728.656280623176;5787.913181302284;5790.160426738099;5794.971025144931;6597.769078082244;6641.435477984329;6644.700988455531;6653.6340501271925;6660.766873159416;5803.100519419497;5805.82582522525;5838.7080645967535;5860.8534786629825;5915.1718759373725;3509.5613048368955;3553.289342131584;3616.987243571804;3633.2006958469096;3652.086978255436;6617.8014659560295;6630.9668451657435;6651.201855777338;6670.799876003728;6679.499037572202;6946.895796563055;6973.267806880306;6977.232504424509;7024.648767561602;7033.8944915826305;6580.5064620154635;6584.967075164594;6595.967020164964;6611.966940165365;6640.734370625218;6648.7340506379205;6701.798946031627;6778;6790.388865002174;6845.349691779273;6690.698918548775;6691.063251144941;6714.630695311805;6765.560238584476;6793.864122717617;6530.608163510205;6596.80209593713;6648.800535983928;6676.9666151668935;6683.231428385798;5436.755346009518;5494.478024587658;5507.972460137834;5511.724413779375;5542.9168562472405;6742.561733487308;6783.830404239933;6808.693608787517;6842.760503382557;6866.34769696878;6462.192225971754;6517.718798420705;6540.8880490317715;6562;6588.571742836701;6551.344865513411;6572.737090516326;6593.868122637425;6608.184797378276;6613.437857782143;6220.968895155676;6361.491080713625;6440.516961227833;6449.7420103195345;6497.707603157774;6507.967460162668;6547.508936829661;6583.341665833378;6596.60420374779;6633.204015517976;6232.8130156095385;6410.45511131559;6423.325550817097;6430.807075787734;6454.5159113065765 03:21:20 INFO - PID 20476 | |5;yui.html;894.3605322194629;904.317240483435;910.1308250620656;911.0479548871429;914.6387177065063;17775.466735997907;18696.626067478643;18715.3449629263;18725.90637046816;20816.583668326624;20396.184152633876;21213;21225.893870530665;21301.360959171212;21585.56828863422;1033.3593172233227;1059.697986073969;1066.408143480372;1068.8610480637506;1071.9249652524327;1044.5247412427327;1048.3290693955873;1049.6536143072767;1051;1051.5846240734904;998.6604554451485;1082.9079528240109;1098.5715570927346;1099.120703437251;1116.1907616977708;1049.5801679328254;1064.2284343850724;1064.2550214849637;1065.057424179599;1071.807074726549;789.1201310538765;793.1632128104847;793.3098204562068;793.714262865368;794.1145622630783;18136.093195340312;18431.262749490004;18645.25418983239;18700.438986830417;18889.527761805926;20098;20165.193392264293;20614.27850025257;20659.380218593316;20810.791892081037;14632.268386580736;15595.610109747233;15699.68600627981;15753.842461575467;15757.60605984848;3546.627604101584;3550.9644903550893;3576.8926932192076;3579.87470438536;3581.606023337431;126472.36763816122;128617;130832.691673083;131281;132389;14721.19033453149;15279.236038198045;15290.400631892606;15363.769543456858;15495.535133946;30340.393192136034;30891.22771930675;31069.68930310668;31163;31376.529352059737;8502.617382217815;8551.444156129832;8578.78553036179;8592.828143437097;8593.097724738938;4250.596193361625;4355.1289742051085;4360.324149756792;4360.629346505582;4364.759938203366;4855.514448555116;5084.0340335336905;5128.897422051538;5144.459831717691;5149.613778966593;982.9606815727434;997.3118548201718;1013.2248829645328;1015.5277795824977;1017.5115944346755;652.7486917536687;665.0257372948654;671.8555510565252;687.8693048320803;691.7855464805926;11320;11378.431078446045;11481.425928703531;11486;11518.251313664585;650.733199388258;653.8136631060125;660.5970358081566;660.9768658096943;664.0172544633872;4804.111239420718;4826.907612468809;4913.70517768935;4975;5067.594592432597;106057;107252.46373768081;107592;109626;112048;92062;92817.53591232136;93460;95406;100741.49629251807;79705.60147199343;83138;84797;87167;87669;11927.343996079951;12150.453229604513;12360.196587221802;12370.44333004999;12374.195677280948;28286;36588.634113658525;36979.81510092432;38627;39923.40114898221;68589;68821;69017;70080.64959675373;71534;18447.16987735582;18516.166772495002;18525.814741852948;18680.7197892029;18835.434936951915;19905.900470497556;20755.273565425137;20818.79181208229;20994;21050.368488945354;17932;17947.910260448614;18056.819431806038;18342;19009.90495047516;18678.53303667365;18805.24779008879;19262.7110593344;19423.8057619422;19872.304469343504;17086.145692715065;17500.074991750644;17603.471895843144;17824.287028519233;17890.91054544771;13589.52436664712;13729.382177801823;13863.86136138666;13982.300884955508;14339.426422943383;13396.933015335251;13831.79252311196;13889.861101388857;13936.721265574835;14054.929725351309 03:21:20 INFO - PID 20476 | __end_tp_report 03:21:20 INFO - PID 20476 | __start_cc_report 03:21:20 INFO - PID 20476 | _x_x_mozilla_cycle_collect,396 03:21:20 INFO - PID 20476 | __end_cc_report 03:21:20 INFO - PID 20476 | __startTimestamp1501669280443__endTimestamp 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | ------- Summary: start ------- 03:21:20 INFO - PID 20476 | Number of tests: 6 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#0] dojo.html Cycles:165 Average:6160.61 Median:6447.45 stddev:727.74 (11.3%) stddev-sans-first:689.28 03:21:20 INFO - PID 20476 | Values: 3102.2 3152.4 3156.1 3178.0 3196.4 6077.0 6147.0 6189.6 6209.3 6215.8 6185.1 6187.4 6211.2 6216.8 6236.7 5701.5 5711.1 5734.4 5769.5 5841.9 5761.3 5805.1 5824.8 5838.6 5843.6 5650.3 5786.7 5850.3 5851.2 5863.2 5589.9 5619.5 5656.4 5738.8 5739.5 5557.7 5604.4 5631.9 5637.0 5641.8 6089.3 6178.0 6207.8 6220.3 6233.2 6652.3 6655.0 6702.6 6726.1 6740.4 6565.9 6694.3 6724.6 6749.0 6771.4 6203.8 6289.5 6289.9 6296.8 6316.3 6835.5 6911.9 6917.1 6937.5 6948.1 6543.7 6583.5 6585.9 6595.6 6596.8 6670.6 6691.3 6718.3 6719.9 6735.8 6514.1 6602.2 6612.2 6616.6 6628.5 6581.0 6585.6 6591.0 6604.8 6612.1 5373.7 5430.6 5430.6 5431.2 5433.8 4592.0 4598.9 4617.9 4619.3 4625.3 5744.3 5795.4 5812.6 5881.3 5895.3 6655.2 6685.5 6810.1 6816.8 6817.1 5659.7 5759.0 5776.9 5783.4 5800.3 5874.4 5884.2 5901.8 5929.3 5963.3 6503.1 6517.6 6537.6 6555.7 6587.7 6668.1 6687.0 6777.4 6778.5 6785.5 6475.3 6481.9 6555.4 6566.0 6575.0 6443.2 6533.6 6546.7 6562.3 6562.4 6606.7 6694.8 6729.1 6730.2 6730.3 6505.4 6510.2 6533.1 6535.9 6626.5 6513.2 6528.3 6599.7 6613.7 6625.0 6366.9 6452.4 6453.3 6462.8 6465.4 6447.5 6513.5 6557.7 6637.2 6653.9 6411.8 6428.5 6432.5 6436.0 6442.7 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#1] ext.html Cycles:180 Average:41016.95 Median:20389.40 stddev:58254.77 (285.7%) stddev-sans-first:58340.02 03:21:20 INFO - PID 20476 | Values: 825.2 873.7 904.9 906.4 1163.3 32970.3 33762.7 33932.2 43823.3 45115.8 45316.3 45715.3 45725.0 45831.8 45865.0 7419.6 7730.3 7903.6 7992.2 8041.1 7856.8 7970.2 7972.8 7973.6 7978.8 7817.3 7925.4 7925.6 7945.9 7986.5 7921.7 7950.8 7954.4 7958.0 7980.4 7839.6 7869.6 7872.5 7874.8 7902.8 41288.2 41462.2 41593.2 41673.8 41696.8 3663.8 3671.6 3699.0 3706.5 3739.8 33363.7 33405.8 33479.8 33497.8 33562.0 4870.7 4957.9 4966.2 4997.3 5028.8 196678.0 197334.0 197832.0 198231.0 198234.0 49791.3 50134.5 50621.2 50644.0 50818.5 53679.2 53821.7 53899.7 54086.5 54092.7 13541.4 13811.0 13831.6 13841.7 13858.9 10465.8 10551.6 10589.3 10599.8 12158.2 14807.6 14908.4 14922.2 14936.2 15064.0 5881.6 5903.6 5962.1 6000.5 6005.2 1010.8 1033.6 1039.6 1047.7 1051.6 23122.8 23405.3 23800.2 23842.4 31022.5 1131.1 1139.5 1143.4 1147.1 1147.2 12717.4 13209.9 13271.8 13309.3 13447.7 249301.0 251395.7 251532.0 251535.0 252498.0 58190.0 58289.0 58347.7 58580.7 58640.0 1497.3 1505.6 1549.8 1557.1 1559.8 24347.6 24615.3 29833.7 30328.7 30649.2 55532.0 55633.7 55639.7 55737.0 55868.0 219331.0 219371.0 220317.0 220997.0 221430.0 38443.4 38668.2 39321.6 40389.8 40437.4 50172.0 51645.0 51718.5 52240.0 52458.0 36134.8 36468.5 36643.5 37072.3 37107.4 36233.5 36311.6 36611.6 36641.6 36775.8 39867.4 40435.0 40534.8 40541.0 40677.2 34771.3 34999.5 35161.3 35163.3 35387.8 25420.0 25529.9 26169.6 26486.0 26602.9 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#2] jquery.html Cycles:180 Average:37614.27 Median:12730.20 stddev:91737.47 (720.6%) stddev-sans-first:91952.70 03:21:20 INFO - PID 20476 | Values: 589.4 592.5 593.3 596.6 611.9 22712.0 22846.9 23569.2 23711.9 23714.9 25312.0 26911.7 26959.9 26971.9 27059.3 6304.1 6470.8 6474.3 6491.2 6511.0 6195.3 6484.2 6489.6 6493.2 6583.0 6426.9 6432.6 6457.6 6459.3 6468.2 6386.1 6445.5 6455.3 6463.9 6470.8 6017.2 6018.5 6022.9 6027.2 6036.8 29685.7 30250.0 30849.7 31030.8 31197.2 1937.5 2007.8 2008.7 2009.8 2010.4 18835.3 19482.9 19503.6 19585.0 19602.8 2041.7 2090.6 2095.3 2095.4 2325.9 140226.0 143210.6 143578.3 143804.0 147088.3 14575.3 15280.8 15429.7 15481.3 16001.9 22837.5 24117.3 24282.8 24341.1 24368.9 9552.0 9634.4 9760.0 9765.5 9807.1 8744.3 8779.0 8823.1 8841.3 8852.7 9394.8 9423.8 9762.7 9769.9 9775.1 2777.6 2788.3 2815.4 2835.6 2860.2 934.3 945.7 978.6 1002.3 1002.7 19807.4 19861.3 19906.3 19927.5 20305.2 1038.6 1042.2 1054.6 1059.4 1062.2 11028.0 11400.7 13317.6 14178.4 14703.8 508923.0 522254.0 522330.0 583954.0 589637.0 124734.0 126479.0 127781.0 129739.0 130855.0 1258.1 1264.1 1272.0 1284.1 1292.8 21438.4 21719.9 21822.5 22072.3 22140.9 46707.8 58761.7 58826.0 62091.0 62775.0 70803.0 71068.3 72276.6 76395.6 77490.6 21095.8 21321.0 21547.9 21845.9 22115.9 23085.8 23134.5 23873.3 24028.6 24234.6 18276.1 18790.5 18947.9 19235.1 19237.8 17063.9 17427.7 17461.6 18014.1 18110.2 18688.6 18708.1 19093.5 19582.5 19585.8 20708.2 20820.8 20946.5 21077.9 21109.8 18143.5 18664.4 19532.7 19589.0 19593.6 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#3] mootools.html Cycles:180 Average:8589.66 Median:2644.92 stddev:5715.81 (216.1%) stddev-sans-first:5705.63 03:21:20 INFO - PID 20476 | Values: 1304.9 1372.1 1377.3 1382.0 1388.7 13300.4 13918.2 13938.8 13977.6 13984.8 13130.3 13608.8 14132.2 14143.4 14157.5 2695.6 2741.1 2745.6 2747.7 2748.1 2611.5 2679.1 2734.5 2735.1 2735.7 2602.5 2651.8 2679.1 2733.3 2733.5 2640.0 2644.7 2669.9 2673.3 2673.5 2623.2 2631.8 2645.2 2648.3 2648.9 13110.9 13363.4 13386.1 13429.8 13473.5 7506.4 7816.5 7826.7 7828.6 7836.8 5081.3 5129.4 5135.5 5215.4 5255.6 1815.4 1825.1 1830.6 1832.5 1880.2 21265.5 21551.0 21557.1 21571.8 21576.6 6280.4 6467.6 6485.1 6681.4 6693.0 15250.7 15290.5 15302.8 15329.7 15334.5 7242.4 7624.8 7637.6 7643.7 7645.0 6148.0 6375.1 7005.3 7240.5 7279.8 5060.0 5128.2 5208.1 5231.9 5258.1 1495.1 1509.5 1510.6 1514.3 1543.8 897.5 926.5 928.5 938.0 943.0 7454.8 7461.0 7538.7 7548.7 7626.3 705.6 737.3 750.1 758.4 771.6 4688.3 5702.9 5733.3 5858.5 5876.5 19198.6 19241.0 19564.9 19572.7 19575.3 17913.6 18918.1 18926.7 18942.0 18991.4 10493.8 10656.9 10720.2 10728.1 10743.2 8364.7 8755.7 8772.2 8832.4 8873.5 16302.7 16468.9 16794.4 16963.5 17148.8 16175.4 16452.3 16608.9 17166.9 17218.7 11097.3 11325.7 11336.1 11346.9 11359.5 12518.9 12704.6 12780.7 12811.4 12826.5 10223.0 10318.5 10368.7 10411.9 10541.7 10242.0 10376.0 10465.1 10536.9 10680.8 9218.0 9414.0 9433.2 9434.7 9437.3 6931.6 6933.7 7003.4 7027.0 7105.4 7210.2 7253.3 7256.7 7279.7 7288.5 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#4] prototype.html Cycles:180 Average:5537.29 Median:6089.81 stddev:1566.48 (25.7%) stddev-sans-first:1524.51 03:21:20 INFO - PID 20476 | Values: 496.9 500.9 531.1 533.3 543.1 6146.7 6211.3 6277.9 6293.7 6317.3 5973.2 6055.9 6089.4 6090.2 6113.5 4884.3 4904.4 4947.8 4956.7 4976.3 4896.8 4971.6 4973.4 4986.3 5007.7 4674.3 4870.0 4876.9 4892.4 4920.2 4888.0 4906.2 4918.0 4931.3 4953.4 4395.9 4409.8 4415.6 4422.8 4476.3 5989.9 5999.0 6072.0 6134.9 6145.3 5647.7 5664.5 5682.7 5720.8 5769.5 6471.2 6490.2 6492.4 6509.8 6521.7 4819.8 4829.3 4831.9 4834.4 4853.6 6944.5 6954.8 6960.7 6997.7 7027.0 4933.1 4950.3 4958.5 4975.4 5005.2 4995.5 5046.3 5047.7 5055.6 5090.6 5698.9 5713.6 5719.5 5721.8 5723.1 6670.3 6670.6 6715.4 6726.5 6744.4 1640.9 1683.0 1687.1 1754.4 1763.5 1198.2 1212.1 1213.5 1233.4 1248.5 5714.0 5728.7 5787.9 5790.2 5795.0 6597.8 6641.4 6644.7 6653.6 6660.8 5803.1 5805.8 5838.7 5860.9 5915.2 3509.6 3553.3 3617.0 3633.2 3652.1 6617.8 6631.0 6651.2 6670.8 6679.5 6946.9 6973.3 6977.2 7024.6 7033.9 6580.5 6585.0 6596.0 6612.0 6640.7 6648.7 6701.8 6778.0 6790.4 6845.3 6690.7 6691.1 6714.6 6765.6 6793.9 6530.6 6596.8 6648.8 6677.0 6683.2 5436.8 5494.5 5508.0 5511.7 5542.9 6742.6 6783.8 6808.7 6842.8 6866.3 6462.2 6517.7 6540.9 6562.0 6588.6 6551.3 6572.7 6593.9 6608.2 6613.4 6221.0 6361.5 6440.5 6449.7 6497.7 6508.0 6547.5 6583.3 6596.6 6633.2 6232.8 6410.5 6423.3 6430.8 6454.5 03:21:20 INFO - PID 20476 | 03:21:20 INFO - PID 20476 | [#5] yui.html Cycles:180 Average:23467.18 Median:19648.06 stddev:32053.68 (163.1%) stddev-sans-first:32098.79 03:21:20 INFO - PID 20476 | Values: 894.4 904.3 910.1 911.0 914.6 17775.5 18696.6 18715.3 18725.9 20816.6 20396.2 21213.0 21225.9 21301.4 21585.6 1033.4 1059.7 1066.4 1068.9 1071.9 1044.5 1048.3 1049.7 1051.0 1051.6 998.7 1082.9 1098.6 1099.1 1116.2 1049.6 1064.2 1064.3 1065.1 1071.8 789.1 793.2 793.3 793.7 794.1 18136.1 18431.3 18645.3 18700.4 18889.5 20098.0 20165.2 20614.3 20659.4 20810.8 14632.3 15595.6 15699.7 15753.8 15757.6 3546.6 3551.0 3576.9 3579.9 3581.6 126472.4 128617.0 130832.7 131281.0 132389.0 14721.2 15279.2 15290.4 15363.8 15495.5 30340.4 30891.2 31069.7 31163.0 31376.5 8502.6 8551.4 8578.8 8592.8 8593.1 4250.6 4355.1 4360.3 4360.6 4364.8 4855.5 5084.0 5128.9 5144.5 5149.6 983.0 997.3 1013.2 1015.5 1017.5 652.7 665.0 671.9 687.9 691.8 11320.0 11378.4 11481.4 11486.0 11518.3 650.7 653.8 660.6 661.0 664.0 4804.1 4826.9 4913.7 4975.0 5067.6 106057.0 107252.5 107592.0 109626.0 112048.0 92062.0 92817.5 93460.0 95406.0 100741.5 79705.6 83138.0 84797.0 87167.0 87669.0 11927.3 12150.5 12360.2 12370.4 12374.2 28286.0 36588.6 36979.8 38627.0 39923.4 68589.0 68821.0 69017.0 70080.6 71534.0 18447.2 18516.2 18525.8 18680.7 18835.4 19905.9 20755.3 20818.8 20994.0 21050.4 17932.0 17947.9 18056.8 18342.0 19009.9 18678.5 18805.2 19262.7 19423.8 19872.3 17086.1 17500.1 17603.5 17824.3 17890.9 13589.5 13729.4 13863.9 13982.3 14339.4 13396.9 13831.8 13889.9 13936.7 14054.9 03:21:20 INFO - PID 20476 | -------- Summary: end -------- 03:21:20 INFO - PID 20476 | 03:21:21 INFO - TEST-INFO | 20476: exit 0 03:21:21 INFO - TEST-OK | dromaeo_css | took 1114591ms 03:21:21 INFO - TEST-START | kraken 03:21:21 INFO - Initialising browser for kraken test... 03:21:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51281/getInfo.html -profile /tmp/tmp0ocpXq/profile 03:21:21 INFO - TEST-INFO | started process 20847 (/builds/slave/test/build/application/firefox/firefox http://localhost:51281/getInfo.html) 03:21:28 INFO - TEST-INFO | 20847: exit 0 03:21:28 INFO - Browser initialized. 03:21:28 INFO - Running cycle 1/1 for kraken test... 03:21:28 INFO - TEST-INFO | started process 21072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ocpXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:29 INFO - PID 21072 | 03:21:29 INFO - PID 21072 | (/builds/slave/test/build/application/firefox/firefox:21126): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:29 INFO - PID 21072 | 03:21:39 INFO - PID 21072 | RSS: Main: 174702592 03:21:39 INFO - PID 21072 | 03:21:42 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:43 INFO - PID 21072 | RSS: Main: 179527680 03:21:43 INFO - PID 21072 | 03:21:45 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-dft) 03:21:46 INFO - PID 21072 | RSS: Main: 180273152 03:21:46 INFO - PID 21072 | 03:21:49 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-fft) 03:21:50 INFO - PID 21072 | RSS: Main: 174690304 03:21:50 INFO - PID 21072 | 03:21:52 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-oscillator) 03:21:53 INFO - PID 21072 | RSS: Main: 175251456 03:21:53 INFO - PID 21072 | 03:21:55 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:56 INFO - PID 21072 | RSS: Main: 175489024 03:21:56 INFO - PID 21072 | 03:21:59 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:59 INFO - PID 21072 | RSS: Main: 177938432 03:21:59 INFO - PID 21072 | 03:22:03 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:04 INFO - PID 21072 | RSS: Main: 177303552 03:22:04 INFO - PID 21072 | 03:22:06 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51281/tests/kraken/driver.html?testName=json-parse-financial) 03:22:07 INFO - PID 21072 | RSS: Main: 178409472 03:22:07 INFO - PID 21072 | 03:22:09 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:09 INFO - PID 21072 | RSS: Main: 178671616 03:22:09 INFO - PID 21072 | 03:22:11 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:22:12 INFO - PID 21072 | RSS: Main: 175738880 03:22:12 INFO - PID 21072 | 03:22:14 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:15 INFO - PID 21072 | RSS: Main: 176173056 03:22:15 INFO - PID 21072 | 03:22:18 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:18 INFO - PID 21072 | RSS: Main: 176128000 03:22:18 INFO - PID 21072 | 03:22:22 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:22 INFO - PID 21072 | RSS: Main: 176369664 03:22:22 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51281/tests/kraken/driver.html?testName=ai-astar) 03:22:24 INFO - PID 21072 | RSS: Main: 178024448 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | __start_tp_report 03:22:24 INFO - PID 21072 | _x_x_mozilla_page_load 03:22:24 INFO - PID 21072 | _x_x_mozilla_page_load_details 03:22:24 INFO - PID 21072 | |i|pagename|runs| 03:22:24 INFO - PID 21072 | |0;ai-astar;99;111;100;112;109;121;112;107;114;111 03:22:24 INFO - PID 21072 | |1;audio-beat-detection;142;116;141;170;124;142;144;122;172;121 03:22:24 INFO - PID 21072 | |2;audio-dft;164;167;163;166;173;170;174;164;165;166 03:22:24 INFO - PID 21072 | |3;audio-fft;78;76;75;179;76;78;75;76;158;80 03:22:24 INFO - PID 21072 | |4;audio-oscillator;79;78;127;80;80;79;126;79;80;123 03:22:24 INFO - PID 21072 | |5;imaging-gaussian-blur;115;114;113;114;114;115;114;118;114;119 03:22:24 INFO - PID 21072 | |6;imaging-darkroom;154;154;153;153;154;153;160;153;152;153 03:22:24 INFO - PID 21072 | |7;imaging-desaturate;94;94;94;93;95;95;94;97;94;96 03:22:24 INFO - PID 21072 | |8;json-parse-financial;59;57;63;56;56;54;64;55;56;57 03:22:24 INFO - PID 21072 | |9;json-stringify-tinderbox;62;53;54;59;62;53;54;54;54;61 03:22:24 INFO - PID 21072 | |10;stanford-crypto-aes;80;78;79;97;80;88;83;84;78;87 03:22:24 INFO - PID 21072 | |11;stanford-crypto-ccm;142;142;144;143;130;129;133;144;147;181 03:22:24 INFO - PID 21072 | |12;stanford-crypto-pbkdf2;180;180;176;178;177;180;178;178;192;173 03:22:24 INFO - PID 21072 | |13;stanford-crypto-sha256-iterative;67;65;66;70;72;71;65;67;69;65 03:22:24 INFO - PID 21072 | __end_tp_report 03:22:24 INFO - PID 21072 | __start_cc_report 03:22:24 INFO - PID 21072 | _x_x_mozilla_cycle_collect,990 03:22:24 INFO - PID 21072 | __end_cc_report 03:22:24 INFO - PID 21072 | __startTimestamp1501669344747__endTimestamp 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | ------- Summary: start ------- 03:22:24 INFO - PID 21072 | Number of tests: 14 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:6.47 (5.8%) stddev-sans-first:5.61 03:22:24 INFO - PID 21072 | Values: 99.0 111.0 100.0 112.0 109.0 121.0 112.0 107.0 114.0 111.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:142.00 stddev:19.61 (13.8%) stddev-sans-first:20.78 03:22:24 INFO - PID 21072 | Values: 142.0 116.0 141.0 170.0 124.0 142.0 144.0 122.0 172.0 121.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#2] audio-dft Cycles:10 Average:167.20 Median:166.50 stddev:3.85 (2.3%) stddev-sans-first:3.91 03:22:24 INFO - PID 21072 | Values: 164.0 167.0 163.0 166.0 173.0 170.0 174.0 164.0 165.0 166.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.03 (51.4%) stddev-sans-first:40.91 03:22:24 INFO - PID 21072 | Values: 78.0 76.0 75.0 179.0 76.0 78.0 75.0 76.0 158.0 80.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:79.00 stddev:22.27 (28.2%) stddev-sans-first:23.03 03:22:24 INFO - PID 21072 | Values: 79.0 78.0 127.0 80.0 80.0 79.0 126.0 79.0 80.0 123.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:114.50 stddev:1.94 (1.7%) stddev-sans-first:2.06 03:22:24 INFO - PID 21072 | Values: 115.0 114.0 113.0 114.0 114.0 115.0 114.0 118.0 114.0 119.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#6] imaging-darkroom Cycles:10 Average:153.90 Median:153.50 stddev:2.23 (1.5%) stddev-sans-first:2.37 03:22:24 INFO - PID 21072 | Values: 154.0 154.0 153.0 153.0 154.0 153.0 160.0 153.0 152.0 153.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:1.17 (1.2%) stddev-sans-first:1.22 03:22:24 INFO - PID 21072 | Values: 94.0 94.0 94.0 93.0 95.0 95.0 94.0 97.0 94.0 96.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.33 (5.9%) stddev-sans-first:3.50 03:22:24 INFO - PID 21072 | Values: 59.0 57.0 63.0 56.0 56.0 54.0 64.0 55.0 56.0 57.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.50 stddev:3.89 (6.9%) stddev-sans-first:3.61 03:22:24 INFO - PID 21072 | Values: 62.0 53.0 54.0 59.0 62.0 53.0 54.0 54.0 54.0 61.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:5.97 (7.1%) stddev-sans-first:6.20 03:22:24 INFO - PID 21072 | Values: 80.0 78.0 79.0 97.0 80.0 88.0 83.0 84.0 78.0 87.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:143.50 stddev:14.63 (10.2%) stddev-sans-first:15.51 03:22:24 INFO - PID 21072 | Values: 142.0 142.0 144.0 143.0 130.0 129.0 133.0 144.0 147.0 181.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:179.00 stddev:4.98 (2.8%) stddev-sans-first:5.28 03:22:24 INFO - PID 21072 | Values: 180.0 180.0 176.0 178.0 177.0 180.0 178.0 178.0 192.0 173.0 03:22:24 INFO - PID 21072 | 03:22:24 INFO - PID 21072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:2.63 (3.9%) stddev-sans-first:2.77 03:22:24 INFO - PID 21072 | Values: 67.0 65.0 66.0 70.0 72.0 71.0 65.0 67.0 69.0 65.0 03:22:24 INFO - PID 21072 | -------- Summary: end -------- 03:22:24 INFO - PID 21072 | 03:22:25 INFO - PID 21072 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:22:25 INFO - TEST-INFO | 21072: exit 0 03:22:25 INFO - TEST-OK | kraken | took 64180ms 03:22:25 INFO - SUITE-END | took 1178s 03:22:25 INFO - Completed test suite (00:19:39) 03:22:25 INFO - javascript benchmark 03:22:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8604.367841792266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.1934297082753, 3152.401043801676, 3156.084735426726, 3177.952330715039, 3196.4406228909934, 6076.969615151924, 6146.969265153673, 6189.597676151047, 6209.285932117802, 6215.813525594228, 6185.072239164117, 6187.35032821554, 6211.223597050369, 6216.782412615559, 6236.688165591725, 5701.543876489892, 5711.143328500737, 5734.369219385864, 5769.538436925036, 5841.853953651172, 5761.251037365137, 5805.100209467518, 5824.825255242349, 5838.562107841907, 5843.64938103713, 5650.3219613646625, 5786.739596718157, 5850.297964244297, 5851.151583020481, 5863.179154918314, 5589.860253493695, 5619.466150715675, 5656.434356564352, 5738.799142030009, 5739.483446489836, 5557.694326812024, 5604.41153678866, 5631.887362252773, 5637.041702910515, 5641.802536911229, 6089.330173680892, 6178.042403427476, 6207.844803879939, 6220.284667263278, 6233.189685340877, 6652.334766523309, 6655.0, 6702.597844129319, 6726.091977583062, 6740.427063699592, 6565.868682626321, 6694.263631000586, 6724.562903411263, 6749.0, 6771.424428923548, 6203.844903877439, 6289.528285378615, 6289.87420251597, 6296.811095667045, 6316.273628532732, 6835.487338449636, 6911.89632155518, 6917.13535808024, 6937.479689023243, 6948.131483564554, 6543.672816359163, 6583.506237032242, 6585.86828263432, 6595.604263744191, 6596.8350791230605, 6670.633115178614, 6691.297413771484, 6718.294579069225, 6719.932800672029, 6735.764248251287, 6514.088027676129, 6602.207735071822, 6612.23959244693, 6616.60300381969, 6628.502862285348, 6581.0, 6585.6377899216, 6591.0442985766795, 6604.8348791280605, 6612.140421745143, 5373.704446255493, 5430.647007944471, 5430.64700794455, 5431.1853222016225, 5433.782648694087, 4591.977040114778, 4598.8620341389815, 4617.907641847211, 4619.2609182531305, 4625.283081122431, 5744.281964754406, 5795.420457954171, 5812.564057695689, 5881.264841894763, 5895.322037965603, 6655.23464801554, 6685.465162786965, 6810.114685091005, 6816.7614133505085, 6817.0796942413135, 5659.660420374708, 5758.971205143947, 5776.942230577724, 5783.421657834183, 5800.303963524319, 5874.383189765099, 5884.205632239593, 5901.8196360728025, 5929.347771745104, 5963.254593175853, 6503.089567460464, 6517.576357536745, 6537.607743535403, 6555.737770489127, 6587.703553340111, 6668.066470694203, 6687.0, 6777.390034896883, 6778.525503214728, 6785.5250132490255, 6475.3200913903365, 6481.935180648133, 6555.4427873631275, 6566.0, 6575.046618240424, 6443.194600674916, 6533.640649764118, 6546.705398256994, 6562.310957349409, 6562.376574225441, 6606.702698378681, 6694.799156025327, 6729.1252137221845, 6730.192376914802, 6730.293319201413, 6505.41451269388, 6510.18622672166, 6533.118029066205, 6535.934640653532, 6626.5030122741955, 6513.185851768529, 6528.314526974789, 6599.7360105595235, 6613.735450582115, 6624.966875165786, 6366.9044964326495, 6452.35476452351, 6453.290138084901, 6462.806115816533, 6465.353464653497, 6447.451966582893, 6513.54405191632, 6557.672116394066, 6637.1703537057865, 6653.900191497035, 6411.775587854403, 6428.517861160338, 6432.549721519449, 6436.0, 6442.742290308335], "value": 6105.730581789401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.1954344514099, 873.7029410000599, 904.9457032578042, 906.35195834978, 1163.2555164694602, 32970.34059318815, 33762.66237337629, 33932.15169620758, 43823.34264986028, 45115.77442112785, 45316.320255196195, 45715.31427028597, 45725.0, 45831.77084114575, 45865.0, 7419.554826710388, 7730.304272615477, 7903.644336004893, 7992.200779922019, 8041.075276343207, 7856.842863142734, 7970.163132871052, 7972.840543189132, 7973.641186146609, 7978.760637180894, 7817.257360550739, 7925.445218834684, 7925.643346049442, 7945.920540794576, 7986.520808751465, 7921.683132674686, 7950.840983180362, 7954.363650907913, 7957.960210198969, 7980.441369104136, 7839.6472158752995, 7869.567173805438, 7872.527648341118, 7874.763757087297, 7902.802429939297, 41288.1742365151, 41462.1707565847, 41593.1681366371, 41673.79163104195, 41696.791516042525, 3663.761855479412, 3671.596124426311, 3698.9630103698887, 3706.5366829146355, 3739.7943113128767, 33363.66636333654, 33405.83297083523, 33479.83260083684, 33497.83251083729, 33562.0, 4870.707757534559, 4957.925631115536, 4966.15575352191, 4997.300377947054, 5028.84913452597, 196678.0, 197334.0, 197832.0, 198230.99999999854, 198234.0, 49791.25313120306, 50134.49865501371, 50621.240681389805, 50644.0, 50818.491815081376, 53679.19481207785, 53821.730891345294, 53899.73050134724, 54086.45913540893, 54092.72953635207, 13541.39063742134, 13811.0, 13831.585052448443, 13841.723165536632, 13858.930705346409, 10465.790684186273, 10551.577936882592, 10589.311694739818, 10599.84100238497, 12158.209716368408, 14807.555773326601, 14908.403663853542, 14922.179280139697, 14936.178510181828, 15064.0, 5881.558883083786, 5903.557233207526, 5962.135490353874, 6000.549958753111, 6005.249343832021, 1010.8483727440796, 1033.6382266206917, 1039.6465201831413, 1047.69093117529, 1051.5761170501914, 23122.76877231206, 23405.297841064796, 23800.166994155123, 23842.40393990164, 31022.534661980088, 1131.1007748839693, 1139.5043156227068, 1143.3711458697683, 1147.0708725932022, 1147.1912301827358, 12717.427715752814, 13209.933950330187, 13271.800922986164, 13309.267990260434, 13447.731045379038, 249301.0, 251395.74302128374, 251532.0, 251535.0, 252498.0, 58190.0, 58289.0, 58347.70826145842, 58580.70709646425, 58640.0, 1497.2962707527445, 1505.6085417791235, 1549.7520396736468, 1557.0735412429585, 1559.8050243719536, 24347.634785477876, 24615.261542153763, 29833.701662983094, 30328.696713032587, 30649.233769155948, 55532.0, 55633.72183139058, 55639.72180139073, 55737.0, 55868.0, 219331.0, 219371.0, 220317.0, 220997.0, 221430.0, 38443.42334864923, 38668.2266354677, 39321.60678393179, 40389.79805101073, 40437.393439099025, 50172.0, 51645.0, 51718.48281517137, 52240.0, 52458.0, 36134.819325903205, 36468.45297320595, 36643.45034824427, 37072.258554828215, 37107.44338834973, 36233.45649815202, 36311.636883630825, 36611.63388366082, 36641.633583663825, 36775.816120919226, 39867.40198897077, 40435.0, 40534.797326013184, 40541.0, 40677.1864562713, 34771.304573908885, 34999.4750078744, 35161.29677406489, 35163.29673406569, 35387.82306088453, 25420.0, 25529.87235063813, 26169.60745588856, 26486.0, 26602.866985664947], "value": 18294.650640958684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4459208344156, 592.5467017731434, 593.2613895699855, 596.594315865212, 611.9326874043854, 22712.0, 22846.88576557119, 23569.175078872242, 23711.881440592817, 23714.88142559285, 25312.0, 26911.73088269117, 26959.86520067402, 26971.86514067432, 27059.323516912085, 6304.085907543415, 6470.773522926698, 6474.255460622018, 6491.156149700556, 6511.0, 6195.2565692117005, 6484.221893372778, 6489.578177418476, 6493.188351456068, 6583.0, 6426.935730642704, 6432.614043157426, 6457.580257283285, 6459.289478157399, 6468.159139311882, 6386.10594516768, 6445.452136568374, 6455.289918109028, 6463.93536064638, 6470.805875823709, 6017.187679663233, 6018.4583387494895, 6022.939770602282, 6027.216461859974, 6036.849078773066, 29685.703142968727, 30250.0, 30849.691503084905, 31030.844845775628, 31197.220069498217, 1937.457511896657, 2007.7992200779952, 2008.7187793708893, 2009.768876579183, 2010.447127040061, 18835.340763073364, 19482.902585487125, 19503.609927801364, 19585.0, 19602.803971960384, 2041.7039529268322, 2090.6132365512276, 2095.287602215239, 2095.423758466419, 2325.860448373103, 140226.0, 143210.56789432076, 143578.28210858983, 143804.0, 147088.2645586776, 14575.344109515097, 15280.847191527942, 15429.691406171814, 15481.303341349667, 16001.919990399974, 22837.543249134924, 24117.276481705576, 24282.757172428403, 24341.14805981782, 24368.878155609462, 9551.952240238754, 9634.421934683942, 9760.0, 9765.511724413893, 9807.117359437685, 8744.256738177326, 8779.0, 8823.073577274294, 8841.292696584258, 8852.690155844515, 9394.812103757886, 9423.811523769486, 9762.707118786448, 9769.853452198222, 9775.120239178508, 2777.6250206221903, 2788.33080060788, 2815.3806162644187, 2835.617191679138, 2860.2134413036165, 934.2525979216599, 945.6926498887889, 978.5889926231, 1002.2683441087901, 1002.6791426743372, 19807.4057778264, 19861.31178849814, 19906.303279385153, 19927.501812454804, 20305.187792488432, 1038.5689938675516, 1042.1506472225112, 1054.5781687325132, 1059.4490864750287, 1062.2458054781036, 11028.0, 11400.714982125513, 13317.600471985856, 14178.361973711208, 14703.779443308358, 508923.0, 522254.0, 522330.0, 583954.0, 589637.0, 124734.0, 126479.0, 127781.0, 129739.0, 130855.0, 1258.13817534987, 1264.121435602266, 1272.0396100943913, 1284.0882973089024, 1292.8170723787816, 21438.356849294545, 21719.891400542896, 21822.454438638524, 22072.33782986513, 22140.889295553417, 46707.76646116748, 58761.70619147048, 58826.0, 62091.0, 62775.0, 70803.0, 71068.28931710617, 72276.63861680658, 76395.61802190954, 77490.6125469369, 21095.789042109995, 21321.0, 21547.892260538596, 21845.890770546044, 22115.889420552794, 23085.769142309033, 23134.537309254058, 23873.283801485984, 24028.63957040681, 24234.636480452456, 18276.086195689895, 18790.53023674419, 18947.90526047361, 19235.1344189509, 19237.807621923603, 17063.91468042652, 17427.738583920996, 17461.563460913578, 18014.068966894054, 18110.18504167342, 18688.626227475645, 18708.06459677038, 19093.522661933563, 19582.510437239183, 19585.804141958397, 20708.171673132907, 20820.791792081884, 20946.47633809167, 21077.894610526848, 21109.788902110784, 18143.455696329132, 18664.44006679802, 19532.707009395155, 19589.0, 19593.608127837648], "value": 12534.363956790768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.895608351332, 1372.0669944437777, 1377.3319939829182, 1381.9930900345496, 1388.6875453023072, 13300.401481933312, 13918.1649101054, 13938.790918136223, 13977.580672579814, 13984.790228146561, 13130.343482825845, 13608.795868061987, 14132.152070875729, 14143.363548640311, 14157.504487342945, 2695.555233386489, 2741.0954385052883, 2745.6156138140677, 2747.738964798351, 2748.1068652687854, 2611.5429799785056, 2679.102500662271, 2734.53512902806, 2735.1110888961066, 2735.726427357258, 2602.4664943686594, 2651.8408895466237, 2679.1426743442107, 2733.316670832292, 2733.5489644208683, 2639.986800065997, 2644.6694163229595, 2669.853158076305, 2673.2648521656506, 2673.5454972654597, 2623.22614828626, 2631.776299014567, 2645.166772466686, 2648.2717252755456, 2648.9205323840124, 13110.934445327712, 13363.398647060905, 13386.129901556367, 13429.798553021712, 13473.528426505123, 7506.437017223676, 7816.49192802466, 7826.726064587712, 7828.647710853025, 7836.804079897991, 5081.297765248646, 5129.384473863161, 5135.460776618439, 5215.400228973679, 5255.553277971377, 1815.428140135853, 1825.078335440594, 1830.560665440298, 1832.4594244697846, 1880.2479008396615, 21265.468363290885, 21551.0, 21557.137714491244, 21571.784282157292, 21576.568468630696, 6280.434760871452, 6467.611943283418, 6485.1245081914285, 6681.365270299314, 6692.966535167293, 15250.694986100216, 15290.464833730766, 15302.770458443132, 15329.693406132037, 15334.463293784664, 7242.3843973262865, 7624.847503049908, 7637.579933103621, 7643.7324693635455, 7645.044369453818, 6148.047052706837, 6375.075614035939, 7005.334493223136, 7240.5149254475755, 7279.818004549823, 5060.0, 5128.205128205134, 5208.114620514521, 5231.869203269949, 5258.106121959276, 1495.0730547060891, 1509.532045066033, 1510.5770384292416, 1514.2655811931204, 1543.8378970208191, 897.4929165021741, 926.4672813132476, 928.5032507608397, 937.9531023448936, 943.0192599696239, 7454.813629659302, 7460.962695186598, 7538.698452061966, 7548.7357942472845, 7626.275503827128, 705.6401235369896, 737.3032484302283, 750.1036261667364, 758.4198088462331, 771.5949126708523, 4688.320193571913, 5702.885942281131, 5733.254676891977, 5858.47273745365, 5876.500497457679, 19198.616027679367, 19241.0, 19564.902175489315, 19572.70640940387, 19575.314863979693, 17913.641727165385, 18918.14868330901, 18926.716099258523, 18942.0, 18991.43025709231, 10493.842592361121, 10656.89343106559, 10720.249582529148, 10728.141748660088, 10743.194260430499, 8364.665413383396, 8755.737327880173, 8772.210501054935, 8832.425892316978, 8873.511956842436, 16302.673946520767, 16468.917655411646, 16794.412195573095, 16963.491095267163, 17148.828511715223, 16175.43385981485, 16452.259648315616, 16608.916955415145, 17166.914165429094, 17218.741718873975, 11097.33415995043, 11325.71685707864, 11336.149788765711, 11346.94326528362, 11359.54561817518, 12518.874811251771, 12704.555340563036, 12780.744385112432, 12811.359432028175, 12826.486940522274, 10223.028812262823, 10318.535665895202, 10368.740781480523, 10411.895881041395, 10541.73645658834, 10242.0, 10376.0, 10465.110465610509, 10536.947315263375, 10680.786384272427, 9217.953910230674, 9414.0, 9433.198178154933, 9434.716958491255, 9437.292203084933, 6931.618760968196, 6933.653317334012, 7003.404710599452, 7027.0, 7105.360517553445, 7210.206877243394, 7253.347198751927, 7256.673449694671, 7279.672414741243, 7288.453365997678], "value": 6309.954359070004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.85342823866955, 500.8647665130415, 531.1342511705918, 533.2853975672599, 543.1228565866128, 6146.66193359365, 6211.254649442062, 6277.937220627798, 6293.748250069997, 6317.336679648634, 5973.22348094747, 6055.878882422349, 6089.391060893909, 6090.23872015998, 6113.51091912647, 4884.29177769225, 4904.4114706235305, 4947.752612369385, 4956.677815941952, 4976.278439626261, 4896.828610998616, 4971.577415919651, 4973.378327709036, 4986.276989836471, 5007.7496125193775, 4674.345591617176, 4869.9773047659855, 4876.853694389174, 4892.437369702477, 4920.163572192736, 4888.0, 4906.239532872411, 4918.0, 4931.26031095335, 4953.405591329064, 4395.856962271959, 4409.757463339515, 4415.558444155591, 4422.823087076546, 4476.306172543261, 5989.850253743648, 5998.97000514999, 6072.0, 6134.9079763803575, 6145.262568491765, 5647.712676366037, 5664.490195882349, 5682.687452190128, 5720.8283751487525, 5769.509591684712, 6471.214339611333, 6490.156279683611, 6492.350764923517, 6509.772157974496, 6521.739130434777, 4819.770958405619, 4829.2997515360075, 4831.855044348676, 4834.371531700892, 4853.563179313844, 6944.51388402812, 6954.79135625932, 6960.677471280491, 6997.650117494105, 7026.9648651756415, 4933.136701077369, 4950.257461380822, 4958.487776123782, 4975.427825800007, 5005.174146265826, 4995.500449955048, 5046.318746969112, 5047.671901326402, 5055.620828437808, 5090.618203634742, 5698.943010569924, 5713.600047996601, 5719.5138413235345, 5721.828345149652, 5723.112917497794, 6670.266270710218, 6670.633115178712, 6715.3620406061345, 6726.529142959946, 6744.42672372844, 1640.860526855207, 1682.9747553786704, 1687.0974028894482, 1754.4298103116282, 1763.5238485608813, 1198.2091819399154, 1212.0545974140184, 1213.538855235005, 1233.3586535001928, 1248.4506817000672, 5713.971430142906, 5728.656280623176, 5787.913181302284, 5790.160426738099, 5794.971025144931, 6597.769078082244, 6641.435477984329, 6644.700988455531, 6653.6340501271925, 6660.766873159416, 5803.100519419497, 5805.82582522525, 5838.7080645967535, 5860.8534786629825, 5915.1718759373725, 3509.5613048368955, 3553.289342131584, 3616.987243571804, 3633.2006958469096, 3652.086978255436, 6617.8014659560295, 6630.9668451657435, 6651.201855777338, 6670.799876003728, 6679.499037572202, 6946.895796563055, 6973.267806880306, 6977.232504424509, 7024.648767561602, 7033.8944915826305, 6580.5064620154635, 6584.967075164594, 6595.967020164964, 6611.966940165365, 6640.734370625218, 6648.7340506379205, 6701.798946031627, 6778.0, 6790.388865002174, 6845.349691779273, 6690.698918548775, 6691.063251144941, 6714.630695311805, 6765.560238584476, 6793.864122717617, 6530.608163510205, 6596.80209593713, 6648.800535983928, 6676.9666151668935, 6683.231428385798, 5436.755346009518, 5494.478024587658, 5507.972460137834, 5511.724413779375, 5542.9168562472405, 6742.561733487308, 6783.830404239933, 6808.693608787517, 6842.760503382557, 6866.34769696878, 6462.192225971754, 6517.718798420705, 6540.8880490317715, 6562.0, 6588.571742836701, 6551.344865513411, 6572.737090516326, 6593.868122637425, 6608.184797378276, 6613.437857782143, 6220.968895155676, 6361.491080713625, 6440.516961227833, 6449.7420103195345, 6497.707603157774, 6507.967460162668, 6547.508936829661, 6583.341665833378, 6596.60420374779, 6633.204015517976, 6232.8130156095385, 6410.45511131559, 6423.325550817097, 6430.807075787734, 6454.5159113065765], "value": 5075.334363322396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.3605322194629, 904.317240483435, 910.1308250620656, 911.0479548871429, 914.6387177065063, 17775.466735997907, 18696.626067478643, 18715.3449629263, 18725.90637046816, 20816.583668326624, 20396.184152633876, 21213.0, 21225.893870530665, 21301.360959171212, 21585.56828863422, 1033.3593172233227, 1059.697986073969, 1066.408143480372, 1068.8610480637506, 1071.9249652524327, 1044.5247412427327, 1048.3290693955873, 1049.6536143072767, 1051.0, 1051.5846240734904, 998.6604554451485, 1082.9079528240109, 1098.5715570927346, 1099.120703437251, 1116.1907616977708, 1049.5801679328254, 1064.2284343850724, 1064.2550214849637, 1065.057424179599, 1071.807074726549, 789.1201310538765, 793.1632128104847, 793.3098204562068, 793.714262865368, 794.1145622630783, 18136.093195340312, 18431.262749490004, 18645.25418983239, 18700.438986830417, 18889.527761805926, 20098.0, 20165.193392264293, 20614.27850025257, 20659.380218593316, 20810.791892081037, 14632.268386580736, 15595.610109747233, 15699.68600627981, 15753.842461575467, 15757.60605984848, 3546.627604101584, 3550.9644903550893, 3576.8926932192076, 3579.87470438536, 3581.606023337431, 126472.36763816122, 128617.0, 130832.691673083, 131281.0, 132389.0, 14721.19033453149, 15279.236038198045, 15290.400631892606, 15363.769543456858, 15495.535133946, 30340.393192136034, 30891.22771930675, 31069.68930310668, 31163.0, 31376.529352059737, 8502.617382217815, 8551.444156129832, 8578.78553036179, 8592.828143437097, 8593.097724738938, 4250.596193361625, 4355.1289742051085, 4360.324149756792, 4360.629346505582, 4364.759938203366, 4855.514448555116, 5084.0340335336905, 5128.897422051538, 5144.459831717691, 5149.613778966593, 982.9606815727434, 997.3118548201718, 1013.2248829645328, 1015.5277795824977, 1017.5115944346755, 652.7486917536687, 665.0257372948654, 671.8555510565252, 687.8693048320803, 691.7855464805926, 11320.0, 11378.431078446045, 11481.425928703531, 11486.0, 11518.251313664585, 650.733199388258, 653.8136631060125, 660.5970358081566, 660.9768658096943, 664.0172544633872, 4804.111239420718, 4826.907612468809, 4913.70517768935, 4975.0, 5067.594592432597, 106057.0, 107252.46373768081, 107592.0, 109626.0, 112048.0, 92062.0, 92817.53591232136, 93460.0, 95406.0, 100741.49629251807, 79705.60147199343, 83138.0, 84797.0, 87167.0, 87669.0, 11927.343996079951, 12150.453229604513, 12360.196587221802, 12370.44333004999, 12374.195677280948, 28286.0, 36588.634113658525, 36979.81510092432, 38627.0, 39923.40114898221, 68589.0, 68821.0, 69017.0, 70080.64959675373, 71534.0, 18447.16987735582, 18516.166772495002, 18525.814741852948, 18680.7197892029, 18835.434936951915, 19905.900470497556, 20755.273565425137, 20818.79181208229, 20994.0, 21050.368488945354, 17932.0, 17947.910260448614, 18056.819431806038, 18342.0, 19009.90495047516, 18678.53303667365, 18805.24779008879, 19262.7110593344, 19423.8057619422, 19872.304469343504, 17086.145692715065, 17500.074991750644, 17603.471895843144, 17824.287028519233, 17890.91054544771, 13589.52436664712, 13729.382177801823, 13863.86136138666, 13982.300884955508, 14339.426422943383, 13396.933015335251, 13831.79252311196, 13889.861101388857, 13936.721265574835, 14054.929725351309], "value": 9049.609127590014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 100.0, 112.0, 109.0, 121.0, 112.0, 107.0, 114.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 141.0, 170.0, 124.0, 142.0, 144.0, 122.0, 172.0, 121.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 163.0, 166.0, 173.0, 170.0, 174.0, 164.0, 165.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 179.0, 76.0, 78.0, 75.0, 76.0, 158.0, 80.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 127.0, 80.0, 80.0, 79.0, 126.0, 79.0, 80.0, 123.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 118.0, 114.0, 119.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 153.0, 153.0, 154.0, 153.0, 160.0, 153.0, 152.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 95.0, 95.0, 94.0, 97.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 63.0, 56.0, 56.0, 54.0, 64.0, 55.0, 56.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 53.0, 54.0, 59.0, 62.0, 53.0, 54.0, 54.0, 54.0, 61.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 97.0, 80.0, 88.0, 83.0, 84.0, 78.0, 87.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 144.0, 143.0, 130.0, 129.0, 133.0, 144.0, 147.0, 181.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 176.0, 178.0, 177.0, 180.0, 178.0, 178.0, 192.0, 173.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 70.0, 72.0, 71.0, 65.0, 67.0, 69.0, 65.0], "value": 67.7, "unit": "score"}]}]} 03:22:25 INFO - Return code: 0 03:22:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:26 INFO - # TBPL SUCCESS # 03:22:26 INFO - Running post-action listener: _package_coverage_data 03:22:26 INFO - Running post-action listener: _resource_record_post_action 03:22:26 INFO - [mozharness: 2017-08-02 10:22:26.027268Z] Finished run-tests step (success) 03:22:26 INFO - Running post-run listener: _resource_record_post_run 03:22:26 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 430743552; Read time: 44; Write time: 735200 03:22:26 INFO - TinderboxPrint: CPU usage
13.2% 03:22:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 03:22:26 INFO - TinderboxPrint: I/O write bytes / time
430,743,552 / 735,200 03:22:26 INFO - TinderboxPrint: CPU idle
8,282.3 (86.8%) 03:22:26 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 03:22:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:22:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106811392; Read time: 0; Write time: 166308 03:22:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:22:26 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 320770048; Read time: 0; Write time: 568500 03:22:26 INFO - Running post-run listener: _upload_blobber_files 03:22:26 INFO - Blob upload gear active. 03:22:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:26 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:22:26 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:22:26 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:22:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:33 INFO - (blobuploader) - INFO - Done attempting. 03:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:34 INFO - (blobuploader) - INFO - Done attempting. 03:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:35 INFO - (blobuploader) - INFO - Done attempting. 03:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:35 INFO - (blobuploader) - INFO - Done attempting. 03:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:35 INFO - Return code: 0 03:22:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0245afc471402ef736721b544aac3e57d097bcc135e2a69edb705b434ca19f746ba3fe8cc9dc573ec493b49913e4ea394bcadbbabcc888799b8c95e06c5b37d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2955761f59cb3f45e8bf1da5057795c3e6d8302af4388f1bbe24e29d4351477c92177e76c7e4491fe44e5774dc9df6e40e7eb7a5adcc57e87f105feac0d9288a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af24195ac99a6ae7521c35ea99bad9ce943fef5a43688f7fcc2bb10ba2416573a4e1397ea9ba8fc8f2e70f40f2c1b1e1bddd5badacc8720ebc045ce10dbedc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70be93aa92938d7eb1e3065e902686035a2ef7342f05f9650d641eb029f7d57bc5f3b923889ac35377a89fe8f7657f1586c2c0f52f5a6006af622185f6e78131"} 03:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:35 INFO - Contents: 03:22:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0245afc471402ef736721b544aac3e57d097bcc135e2a69edb705b434ca19f746ba3fe8cc9dc573ec493b49913e4ea394bcadbbabcc888799b8c95e06c5b37d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2955761f59cb3f45e8bf1da5057795c3e6d8302af4388f1bbe24e29d4351477c92177e76c7e4491fe44e5774dc9df6e40e7eb7a5adcc57e87f105feac0d9288a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af24195ac99a6ae7521c35ea99bad9ce943fef5a43688f7fcc2bb10ba2416573a4e1397ea9ba8fc8f2e70f40f2c1b1e1bddd5badacc8720ebc045ce10dbedc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70be93aa92938d7eb1e3065e902686035a2ef7342f05f9650d641eb029f7d57bc5f3b923889ac35377a89fe8f7657f1586c2c0f52f5a6006af622185f6e78131"} 03:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:22:35 INFO - Copying logs to upload dir... 03:22:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.284675 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-02 03:22:35.357743) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:35.362293) ========= 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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 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/0245afc471402ef736721b544aac3e57d097bcc135e2a69edb705b434ca19f746ba3fe8cc9dc573ec493b49913e4ea394bcadbbabcc888799b8c95e06c5b37d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2955761f59cb3f45e8bf1da5057795c3e6d8302af4388f1bbe24e29d4351477c92177e76c7e4491fe44e5774dc9df6e40e7eb7a5adcc57e87f105feac0d9288a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af24195ac99a6ae7521c35ea99bad9ce943fef5a43688f7fcc2bb10ba2416573a4e1397ea9ba8fc8f2e70f40f2c1b1e1bddd5badacc8720ebc045ce10dbedc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70be93aa92938d7eb1e3065e902686035a2ef7342f05f9650d641eb029f7d57bc5f3b923889ac35377a89fe8f7657f1586c2c0f52f5a6006af622185f6e78131"} build_url:https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0245afc471402ef736721b544aac3e57d097bcc135e2a69edb705b434ca19f746ba3fe8cc9dc573ec493b49913e4ea394bcadbbabcc888799b8c95e06c5b37d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2955761f59cb3f45e8bf1da5057795c3e6d8302af4388f1bbe24e29d4351477c92177e76c7e4491fe44e5774dc9df6e40e7eb7a5adcc57e87f105feac0d9288a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af24195ac99a6ae7521c35ea99bad9ce943fef5a43688f7fcc2bb10ba2416573a4e1397ea9ba8fc8f2e70f40f2c1b1e1bddd5badacc8720ebc045ce10dbedc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70be93aa92938d7eb1e3065e902686035a2ef7342f05f9650d641eb029f7d57bc5f3b923889ac35377a89fe8f7657f1586c2c0f52f5a6006af622185f6e78131"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:35.386252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:35.386570) ========= 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=af724c981e2a0f424dbabf99000001e7-1501660530.785102-1253505444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:35.437816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 03:22:35.440163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 03:22:35.440458) ========= ========= Total master_lag: 0.21 =========