builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1501668091.1 results: success (0) revision: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.104785) ========= 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:31.105166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.105432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.208470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.208719) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 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% 53.8M=0s 2017-08-02 03:01:32 (53.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149094 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.393027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.393305) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019998 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.446332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:31.446622) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 03:01:32,214 truncating revision to first 12 chars 2017-08-02 03:01:32,214 Setting DEBUG logging. 2017-08-02 03:01:32,214 attempt 1/10 2017-08-02 03:01:32,214 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,536 unpacking tar archive at: mozilla-central-52285ea5e54c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.159893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.160185) ========= script_repo_revision: 52285ea5e54c73d3ed824544cef2ee3f195f05e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.160529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.160786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 03:01:32.170502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-02 03:01:32.170780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:33 INFO - MultiFileLogger online at 20170802 03:01:33 in /builds/slave/test 03:01:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:01:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:33 INFO - {'append_to_log': False, 03:01:33 INFO - 'base_work_dir': '/builds/slave/test', 03:01:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:01:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:33 INFO - 'branch': 'Firefox-Non-PGO', 03:01:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:33 INFO - 'code_coverage': False, 03:01:33 INFO - 'config_files': ('talos/linux_config.py',), 03:01:33 INFO - 'default_actions': ('clobber', 03:01:33 INFO - 'read-buildbot-config', 03:01:33 INFO - 'download-and-extract', 03:01:33 INFO - 'populate-webroot', 03:01:33 INFO - 'create-virtualenv', 03:01:33 INFO - 'install', 03:01:33 INFO - 'setup-mitmproxy', 03:01:33 INFO - 'run-tests'), 03:01:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:33 INFO - 'disable_ccov_upload': False, 03:01:33 INFO - 'download_minidump_stackwalk': True, 03:01:33 INFO - 'download_symbols': 'ondemand', 03:01:33 INFO - 'enable_stylo': False, 03:01:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:33 INFO - 'gecko_profile': False, 03:01:33 INFO - 'gecko_profile_interval': 0, 03:01:33 INFO - 'installer_path': 'installer.exe', 03:01:33 INFO - 'log_level': 'info', 03:01:33 INFO - 'log_name': 'talos', 03:01:33 INFO - 'log_to_console': True, 03:01:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:33 INFO - 'opt_config_files': (), 03:01:33 INFO - 'pip_index': False, 03:01:33 INFO - 'suite': 'dromaeojs-e10s', 03:01:33 INFO - 'system_bits': '32', 03:01:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:33 INFO - 'title': 'talos-linux64-ix-088', 03:01:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:33 INFO - 'use_talos_json': True, 03:01:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:33 INFO - 'work_dir': 'build'} 03:01:33 INFO - [mozharness: 2017-08-02 10:01:33.043678Z] Running clobber step. 03:01:33 INFO - Running pre-action listener: _resource_record_pre_action 03:01:33 INFO - Running main action method: clobber 03:01:33 INFO - rmtree: /builds/slave/test/build 03:01:33 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.579769Z] Finished clobber step (success) 03:01:34 INFO - [mozharness: 2017-08-02 10:01:34.579871Z] 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_test-dromaeojs-e10s", 03:01:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:01:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:01:34 INFO - "stage_platform": "linux64", 03:01:34 INFO - "basedir": "/builds/slave/test", 03:01:34 INFO - "buildnumber": 753, 03:01:34 INFO - "platform": "ubuntu64_hw", 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": "BJGNlML1RuKubcIuYiJyQA", 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-088", 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/BJGNlML1RuKubcIuYiJyQA'}, attempt #1 03:01:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BJGNlML1RuKubcIuYiJyQA'}, 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:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 03:01:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json 03:01:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.crashreporter-symbols.zip 03:01:36 INFO - Running post-action listener: _resource_record_post_action 03:01:36 INFO - [mozharness: 2017-08-02 10:01:36.336597Z] Finished read-buildbot-config step (success) 03:01:36 INFO - [mozharness: 2017-08-02 10:01:36.336821Z] Running download-and-extract step. 03:01:36 INFO - Running pre-action listener: _resource_record_pre_action 03:01:36 INFO - Running main action method: download_and_extract 03:01:36 INFO - mkdir: /builds/slave/test/build/tests 03:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:36 INFO - trying https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.test_packages.json 03:01:36 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:36 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:04 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:04 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:04 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.333005Z] Finished download-and-extract step (success) 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.333237Z] 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.349550Z] Finished populate-webroot step (success) 03:02:08 INFO - [mozharness: 2017-08-02 10:02:08.349642Z] 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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:13 INFO - building 'psutil._psutil_posix' extension 03:02:13 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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: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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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:18 INFO - Downloading/unpacking requests==1.2.3. (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 - 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:19 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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-tLZgQc-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-H5OhuU-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-nTkdhT-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-zE0F2D-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-08xq98-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-cXBvX7-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-PfRnA9-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-zR7gOT-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-I_96TV-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:20 INFO - Running setup.py (path:/tmp/pip-GH4_JF-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-Sn4F3U-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-LrNJrL-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-SJFc9O-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-qpbRzx-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-xPjz_n-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-Fs1Xls-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-WlIdUF-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:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:22 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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-PVGnqh-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-1ciquw-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-y51ABd-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-xbg0fQ-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-gaPtfO-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-HdQSkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:23 INFO - Running setup.py (path:/tmp/pip-NNhkYf-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-_9Ytpz-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-SJVRxP-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-epZDG1-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-GX0C8t-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-_Kd4zr-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-MUbrkO-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-QLhwth-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-DwJt6G-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-s92XF0-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-4K6tGK-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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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 0xbdd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', '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': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 03:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:27 INFO - '_': '/tools/buildbot/bin/python'} 03:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:28 INFO - Cleaning up... 03:02:28 INFO - Return code: 0 03:02:28 INFO - Running post-action listener: _resource_record_post_action 03:02:28 INFO - Running post-action listener: _start_resource_monitoring 03:02:28 INFO - Starting resource monitoring. 03:02:28 INFO - [mozharness: 2017-08-02 10:02:28.051785Z] Finished create-virtualenv step (success) 03:02:28 INFO - [mozharness: 2017-08-02 10:02:28.052304Z] Running install step. 03:02:28 INFO - Running pre-action listener: _resource_record_pre_action 03:02:28 INFO - Running main action method: install 03:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:28 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.436756Z] Finished install step (success) 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.436901Z] 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.437582Z] Finished setup-mitmproxy step (success) 03:02:46 INFO - [mozharness: 2017-08-02 10:02:46.437807Z] 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 0xf4aeb0>, '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 0xf4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4c240>, '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-Non-PGO', '--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-088', '--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-Non-PGO --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-088 --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 - 'TERM': 'linux', 03:02:46 INFO - 'TMOUT': '86400', 03:02:46 INFO - 'USER': 'cltbld', 03:02:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520', 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-Non-PGO', '--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-088', '--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:55519' 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:55519/getInfo.html -profile /tmp/tmpMaTqBQ/profile 03:02:46 INFO - TEST-INFO | started process 752 (/builds/slave/test/build/application/firefox/firefox http://localhost:55519/getInfo.html) 03:02:52 INFO - TEST-INFO | 752: exit 0 03:02:52 INFO - Browser initialized. 03:02:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:52 INFO - TEST-INFO | started process 969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMaTqBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:53 INFO - PID 969 | 03:02:53 INFO - PID 969 | (/builds/slave/test/build/application/firefox/firefox:1017): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:02:53 INFO - PID 969 | 03:03:03 INFO - PID 969 | RSS: Main: 172007424 03:03:03 INFO - PID 969 | 03:06:03 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55519/tests/dromaeo/cssquery-ext.html) 03:06:04 INFO - PID 969 | RSS: Main: 173510656 03:06:04 INFO - PID 969 | 03:09:06 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-ext.html (next: http://localhost:55519/tests/dromaeo/cssquery-jquery.html) 03:09:07 INFO - PID 969 | RSS: Main: 170991616 03:09:07 INFO - PID 969 | 03:12:09 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55519/tests/dromaeo/cssquery-mootools.html) 03:12:09 INFO - PID 969 | RSS: Main: 173182976 03:12:09 INFO - PID 969 | 03:15:11 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55519/tests/dromaeo/cssquery-prototype.html) 03:15:12 INFO - PID 969 | RSS: Main: 171151360 03:15:12 INFO - PID 969 | 03:18:15 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55519/tests/dromaeo/cssquery-yui.html) 03:18:16 INFO - PID 969 | RSS: Main: 174870528 03:18:16 INFO - PID 969 | 03:21:18 INFO - PID 969 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-yui.html (next: http://localhost:55519/tests/dromaeo/cssquery-dojo.html) 03:21:18 INFO - PID 969 | RSS: Main: 175431680 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | __start_tp_report 03:21:18 INFO - PID 969 | _x_x_mozilla_page_load 03:21:18 INFO - PID 969 | _x_x_mozilla_page_load_details 03:21:18 INFO - PID 969 | |i|pagename|runs| 03:21:18 INFO - PID 969 | |0;dojo.html;3125.7343125834304;3127.5152351385527;3146.9213269668257;3188.18701231186;3190.377876314118;6050.425209605091;6132.509399248061;6193.597416167946;6227.128202051711;6277.905831412532;6134.386561343864;6163.753449862;6214.751409943608;6221.906671399933;6223.377662233775;5635.21107045014;5687.17535957287;5688.260526131618;5691.601587888828;5707.086866101425;5731.570132240078;5732.656040637554;5733.770649174028;5745.310562732478;5760.596758226926;5723.112917497794;5725.6278341907855;5745.017968800778;5750.884982300372;5753.079507278836;5722.37053924068;5750.539956803445;5784.421557844203;5793.044147715622;5826.126081087828;5578;5612.719364031782;5619.522340601054;5649.180868774046;5734.025215713339;5996.340402555716;6040.395960403968;6041.818745437644;6061.030235162397;6164.630122192682;6570.5729127606555;6613.2064152301555;6618.93381066188;6659.500537459661;6705.061291419205;6639.070530125786;6641;6655.800325990228;6717.529772915897;6740.696668649923;6144.047672610753;6155.907661385038;6246.937530624681;6260.5617606768;6266.561340706106;6883.690233939485;6890.931090689029;6900.378965893094;6901.930980690129;6907;6546.24718157418;6558.573692710054;6592.373724496165;6597.274299827015;6602.10871532337;6512.088307636935;6611.20665520131;6616.966915165393;6699.229588597374;6721.092652491949;6431.292557818636;6585.934140658532;6589.83525411859;6648.933510664928;6667.933320666828;6619.801405957829;6695.296993815579;6695.330466953265;6697.966510167418;6719.529632925746;5428.511433970962;5449;5488.588355873246;5497.670139791625;5499.257600223998;4621.838235661736;4639.582437580634;4688.367070445446;4699.342092107107;4708.505606911293;5762.106873434541;5783.306003279549;5837.007708689533;5841.766329346863;5841.795537156264;6678.1318428604945;6686.83282917931;6711.429528490035;6717.294684058202;6726.562773419712;5768.048272035067;5809.302883653904;5836.06622940336;5846.093855452412;5860.267466566679;5819.679917604488;5825.941740582624;5832.270966129234;5899.616524925866;5918.112283157561;6305.306416294204;6414.615123092536;6415.775447859302;6500.804975850638;6501.837454063686;6717.026031225542;6725.092112564741;6743.022261771917;6756.425703815231;6769.729210831709;6418.358164183544;6436.485081193587;6446.355364463516;6523.086767852409;6527.3472652734345;6430.453411460078;6531.131001935892;6533.281339052795;6624.072629831731;6633.635150066792;6651.933480665131;6673.099131617169;6676.365745254193;6689.732410703517;6697.430718388991;6340.270868850142;6425.164728585254;6427.164468619049;6434.517411194086;6456.354364563506;6436.452901503425;6440.2915679276175;6453.967730161319;6500.772472963424;6526.869462610816;6465.3857883501;6470.255920569195;6490.058941453557;6506.316836732075;6517.087607734826;6512.185976752906;6518.282988871126;6559.0817285581015;6604.14146160996;6616.603003819786;6215.533834962305;6298.653574053471;6318.115463834974;6386.489080873612;6398.968005160131 03:21:18 INFO - PID 969 | |1;ext.html;795.8726603743398;866.4627930682976;890.5191196753754;1146.346582448005;1170.7424366639336;29922.700772992263;30478.847605761996;40610.59389406105;41486;41503;42354.7882260589;42726.99999999992;42776.57223427765;42786.57213427865;42817.35773963393;7142.500024998252;7536;7690;7691.038620172479;7712.884306735404;7476.177620461772;7585.544867307979;7588.886166707503;7591.848163036736;7593.468457207998;7554.848903021936;7602.809929751746;7606.201348858373;7624.923750762505;7636.961815190916;7560.054993125859;7589.658465369072;7592.088949326117;7594.810129746746;7597.810054748647;7528.435367347416;7545.735899243555;7598.658060387296;7599.544027358376;7605.201453847377;37520.81239593784;37679.81160094209;37870.43194352087;37922.62077379219;37985.24029519422;3481.4429691249534;3523.330567192251;3532.717382609385;3537.575490941078;3547.2018795771005;30342;30432.84783576068;30465.23836904073;30581.847090764626;30585.08244752661;4736.052789442126;4752;4770.928436073462;4799.304100905384;4814.590759785422;196563;197212;197283;197309.01345493324;197896;48580.514194858304;48613.75693121582;48629;48651.5134848647;48727.269090963666;50904;55313.44686553164;55323.89352212933;55871.72064139653;56027.719861401245;16004.119773412574;16053.197340132947;16081.517554473385;16153.757693634605;16200.59498512523;10822.621208257673;10911.34531928071;13092.803607945889;13877.930610346884;14011.509597164051;14649.633759156106;14703.117812931258;14704.926475367769;14787.560052591201;14831.77752333716;5716.1997320375185;5865.507159457214;5872.911906321408;5914.172015917775;6024.367441418675;979.6767066867917;987.3039507147444;999.3604093380243;1015.28422462164;1018.3482571154467;22643.320700379016;22851.542969140522;23365.182218622267;23374.181903633293;23453.06187752471;1091.5961094395125;1102.399192440122;1103.784761971424;1107.95568177272;1108.4070022537903;16086.919565402099;16332.510024699279;16373.590660233589;16444.424445144363;16690;247471;248186;251163;251444;251840;57101.428985710445;57147.42852571504;57147.42852571504;57280.713596432586;57490;1423.950161744334;1425.9020554173228;1465.6262653023412;1474.8451412601737;1475.5868356860096;27626.723732762413;28130.578041328987;28212.153635390972;28376.716232838233;28615;35843.64156358507;36097.458538122475;36122.819385902905;36153.27693446169;36163.81918090393;202955;203112;203877;203926;205854;34305.14237143991;36440.27119457649;38097.23805523819;38259.42610860783;38371.6162838368;46304;47534.762326188145;47697;47774.76112619415;48089.27866082082;35037;35069.47395789014;35141.29717405689;35847;35869.20653967239;34766.30467390689;35097;35336.11659708528;35489;35543.22283885847;38140;38579.228415432095;38783.22433551257;38788.41817372798;38797.41803872888;32832.50751238781;33577.66422335843;33739.662603373654;33786.3242735139;33943.32113357769;23492.882535587214;24488.75511244936;24841.25476235716;25069.87465062663;25151 03:21:18 INFO - PID 969 | |2;jquery.html;568.3946596874329;574.9885002299951;578.2569398323153;579.8463407197094;601.5368166511786;22169;22536.54926901465;23275.883620581917;23279.301620951377;23329.650055249185;25768;26086.608700869503;26250.212493625175;26303.868480657617;26325.73674263257;6347.777827776029;6420.06908998195;6478.028295755651;6507.739690412378;6517.771877984272;6150.96924515379;6280.842978925518;6437.710303036374;6446.580972236813;6450.483961283109;6385.425311721944;6402.263739669951;6414.583052101621;6417.294097649278;6417.422431981121;6356.841078973062;6402.359764023584;6403.263624683174;6405.3274406187375;6413.583117097373;5962.552808539377;5962.612430192024;5979.910301345483;5982.521398288127;5994.700264986734;28540.143795686163;29434.705652943623;29602.555961660593;29780.40439191204;30406.84796576025;1916.9424917252504;1952.6192392483472;1952.6582848001542;1952.8535359848067;1953.1796645408963;18837;19554.120064597126;19557.21771129153;19579.608407831907;19593.9020304899;2244.5510897820336;2267.138487374787;2312.3294244669028;2317.478567322356;2318.547883162784;139823;143973;144175;146413.53586464105;150118.9999999989;14424.711505769827;14528.273586320642;14868.851311486747;15039.849601504064;15121.924390377977;23007.884960575426;23059.19292824743;23238;23240.53518929612;23258.883705581702;10335.328203666737;10338.896611033944;10362.844557331646;10427.791444171075;10442.2168337375;7692.230776922375;9832.508374581243;9892;10023.097921187129;10088.445135517617;8080;11009.61466348674;11627.686109458764;11767.588134415426;11970.581029664094;3763.41667041609;3802.543694756647;4142.91714165715;4204.986868777677;4247.87256382309;954.2938225712923;981.3670182732097;984.3798407003542;987.9901200987898;992.965246216379;19660.525460590514;19703.901480492794;19998.90000549988;20278.594428111355;20547.38357849267;1034.8033873564;1041.9479026048666;1047.994760026195;1049.302214027663;1059.4543809937888;11024.614138505114;13020.609381718563;14112.22382768937;14174;14219.715605687828;512717;518870;520070;522035;525147;116319;119482.40258798824;119829;122422;124770;1265.4621785741024;1302.1210682789078;1302.5961951794975;1306.3664122900386;1321.4714114354142;21100.68348974736;21272.255471058437;21319.78680213178;21335.67996480023;21391.465213369167;59552.70223648854;59823.20673631333;61016;61743.6912815433;62449.06326405198;75537;76118.61940690261;76324;76517.23482765102;77369.61315193388;12501.499940002663;14203.857961420666;14802.851971480148;15116.168610726076;15228.162451064854;23209;23380.64929026032;23411;23428.53142937166;23651.52696946017;18555.721664174776;18962.43112706621;18967;18970;19129.713054303917;16932.915335423244;17193.57016074608;17255.482335529956;17520.123993800004;17570.38503652366;18988.43034708961;19826.306079287155;20145.194192232146;20308.898455507628;20360.18559257613;14483.78274325865;15015.624609384853;15083;15103.697926041637;15153;18478.260869565067;18485.81514184841;18531.629367412846;18565.628687426444;18587.34944276944 03:21:18 INFO - PID 969 | |3;mootools.html;1360.8435029971554;1405.4027038508643;1416.7945647881052;1426.1942002768435;1435.9784603230953;13443.798343024862;13573.2534710591;14245.715085698279;14254.643633909158;14270;13874.098183618058;14195.71608567828;14200.289985500734;14208.715825683506;14209.00536962413;2682.6244325794405;2725.74105459981;2749.4913441013377;2750.5324094903913;2752.779777617796;2648.682158141026;2776.3059235191204;2777.319556708609;2780.3466185446405;2781.3602871339504;2684.6107314439396;2708.404151086768;2716.0629582793904;2744.4922689302443;2747.3269049083;2696.36635390683;2698.541247987847;2704.5537486314834;2709;2756.021612327635;2638.0503018913178;2640.5511063119316;2663.760261576448;2664.3205982474537;2664.773494252991;12885.098043136984;13076.215427074407;13086.86913130866;13098.279594622387;13119.47522099115;7458.70165193397;7649.349805266559;7725.8454830903065;7739.806504837367;7747.186545412706;4976.353074100344;5095.464976177485;5161.329027226437;5180.171172612364;5195.896082078375;1811.212122726605;1851.2502436513098;1896.0709252466331;1915.9329423470112;1937.5640480891686;22267.109315627356;22444.326670199756;22451.43871403228;22480.550388992127;22495;6416.326285740023;7014.649267536603;7174.210836807947;7182.2458641842895;7235.131784185826;15180.620484487756;15261.542153735405;15302.617434564225;15314.846851531565;15319.157446340558;6925.307469253135;7450.739224127129;7451.888221676679;7902.091259505116;7930.1276859545405;6867.244603093655;7101.89347159793;7108.111486064242;7112.928870711226;7118.60847653384;5035.345405097314;5169.06956747789;5211.609129315317;5262.7631756571045;5278.894422111536;1532.3257766582667;1535.3167840310955;1544.9691006179814;1548.2645743271855;1575.708493928627;889.479654402182;924.9398789078689;929.818685356349;940.2431043010306;941.9293552983416;7278.745243916437;7375.078115235596;7377.520461170114;7424.925750742424;7427.18300986891;710.3642240194996;738.7155944961121;739.3272122368619;746.9103707555129;755.743047363888;5559.935727901528;5710.457506536873;5711.742971566289;5758;5804.894381505874;17808.46574602764;18477.445676629723;18790.906045469685;18850.905745471184;18852.34016809405;18429.354972575897;18474.076296185136;18565.907170464332;18579;18584.907075464806;9835.508224588742;10491.68524944253;10632.574697012033;10690.518926648165;10759.408232547285;7934.960325198337;7999.560024198725;8389.706360277361;8429.831403371776;8442.451240669337;15749.842501575296;15924.8407515928;16232.837671623132;16494.83505164933;16548.586285342964;16501.83498165003;16695.16524173762;16825.91587042057;16899.66200676004;17079.743803842703;10193.184545236216;10478.94760526223;10992.615258465916;11206.439678015904;11377.08983281352;13007.869921300666;13105.803412948622;13116;13121.409536570687;13176.802347964596;10635.574577016832;10640.467976601294;10773.353598784099;10888.564457421615;10982.835257470984;9954.203663706741;10084.445355505517;10091.44497052669;10411.94794026025;10634.09610183143;9467.810643786948;9491.288153388385;9522.190613797628;9554.235661146953;9608.567614457506;7189.820254493679;7272.636368181464;7290.416766658761;7311.634418279171;7327.487075904849;7145.892811607726;7195.568265904062;7239.095113110861;7311.67097480604;7338.816529586803 03:21:18 INFO - PID 969 | |4;prototype.html;491.21443552685986;502.44228905914406;531.351750863946;533.5731414868104;539.3420027566373;6151.4463698267145;6257.124002639628;6291.716872740738;6292.8741425171465;6294.811155665332;5948.583599148062;6081.11485439514;6122.785702500413;6126.652136529956;6159.81520554384;4889.828855990041;4898.583620392271;4938.555530002299;4948.38145231846;4980.427250866161;4767.547083027107;4910.747759321368;4931.950680493185;4963.6277279204205;5037.4710655381205;4880.219164933611;4888.388951381077;4892.951070489303;4899.534544218312;4966.056449274626;4856.781444834991;4899.608031357483;4907.6073914086965;4929.285253638238;4938.827141050046;4445.244308467568;4501.122281155176;4504.121696269229;4505.617022553054;4515.774211289455;6005.279366476051;6037.366076561985;6039.4564489195745;6107.4808641265545;6111.816645500642;5623.690697011662;5627.746751396197;5691.886162276731;5711.200431939532;5715.599678078897;6509.28397876238;6526.771562995273;6540.710751237077;6544.181977252843;6557.5081868860025;4905.460399356068;4914.311996320518;4928.310036594879;4951.282064100686;4956.2565615157655;6858.251145957848;6895.379415852597;6898.793036208922;6906;6932;4955.702657840469;4964.652474326763;4975.910117750554;4982.526659967298;4997.100521906019;5013.348264725562;5059.838964256438;5084.745762711849;5092.694438333712;5097.235414687826;5616.297962754656;5664.150377443417;5684.886302274014;5689.829305120853;5715.799947001835;6239.625622462667;6325.525585581007;6520.543561950618;6536.673166341664;6552.475801935833;1666.125284225767;1693.8058668638826;1727.5594723345466;1740.443058221357;1749.7550342951997;1204.379744431601;1212.1393810394543;1220.9633710988685;1243.7263801963554;1255.7362953779625;5687.374388817227;5691.174779656926;5714.828460165656;5757.913631295534;5777.544543568966;6522.380373864476;6575.145231120019;6619.966900165468;6700.396964273142;6706.015822958737;5665.5184309333345;5667.234923285304;5718.228039214736;5781.19063331134;5789.3921138279875;3538.9469157962653;3557.4130268505405;3608.224231790178;3614.204874927512;3618.5838628557526;6455.064015717695;6561.967190164019;6564.835879102965;6566.409023187936;6570.342965703391;6686.866262674816;6792.558483698544;6878.8624227516175;6896;6913.965430172817;6384.360914278909;6404.583702059351;6448.742050317935;6454.612723236621;6503.837404064841;6578.605283682994;6649.734010639714;6703.631300278532;6724.798256052326;6727.596344219362;6585.5719378240265;6618.338166183343;6668.399844014062;6668.865962891828;6675.933240667531;6396.680165991775;6420.143036348967;6485.383888530582;6504.447121994684;6544.345565443417;4993.5755460784785;5015.3480047593575;5025.39695236574;5072.239164125411;5073.8731531712;6504.869902602016;6675.332466753286;6741.157355330583;6745.325467453215;6810.761623343159;6279.529035322278;6366.872662546631;6432.517561183024;6468.191476065492;6471.967640161769;6401.8399540010005;6467.450266727193;6490.513211509061;6496.252930912817;6505.60966342021;6128.417800309142;6361.045843123568;6404.519661025349;6431.260405053292;6480.25477070143;6412.839679008062;6538.705758240795;6552.901706474311;6588.637624930675;6606.669666516559;6248.500119990299;6329.208848893888;6384.552341735411;6396.616203027833;6401.263854656588 03:21:18 INFO - PID 969 | |5;yui.html;899.3075331994362;901.5086777706149;922.3912217936163;923.5705396990401;929.419113054341;16980.405685801;18429.354972575962;18582.163802628882;18585.256589736393;20544.691829622567;20643.277485288017;21059.68410473844;21079.47301317468;21311.25410610629;21355.35933921985;955.1546881010304;991.8760154980628;996.7856910764184;1002.2282842211492;1002.6240159940022;965.5220665770454;1064.0636240108693;1071.8928107189258;1075.070064394297;1075.67192006438;1113.8050841102774;1113.8774734779167;1114.186643750063;1114.2534501883717;1114.9442527873614;1098.8132017557034;1103.7020004598753;1105.0441368216434;1105.4417519152776;1107.2858006585748;805.2310043908112;806.6128258435925;807.8263173417744;808.3290868579065;808.5957021489255;19340;19450.513737156685;19884.60230795376;19912.70130948037;20337.796622033737;20566.69149962752;20590;20971.790282097136;21124.894375528176;21141.365759027252;15084.24578771068;15096.5471035868;15206.391744330214;15286.923565382212;15289.159096249701;3467.271872906693;3497.0732755819727;3498.247876706495;3500;3500.7899526028264;123103.38448307701;124486.37756811248;125921;126181;126987;15027.549173524812;15116.470923517623;15309.464168754263;15356.385744570092;15370.846291537166;29762.255943601584;30229.697703022688;30694.693053069182;30807.537886931714;30858;7993.560354180576;8121.634526446324;8141.063777665526;8173.713920012771;8177.591120443954;4022.939655905164;4074.694397920168;4082.6733861291027;4107.178564287155;4127.711060225755;5233.4243233244315;5273.34083239595;5349.812756553502;5382.381026182039;5396.91904621431;934.6775362499926;953.7997020625608;967.2020583019038;972.2805124208035;976.838821594429;672.1564436631995;685.9588424694534;688.4733179117978;695.1484431571386;703.057902410772;11779.587714430125;11782.528698852122;11984.280943143265;12611.243325400323;13015.349232538336;664.9700763465655;675.3719041291646;676.5196710335618;677.1231255524108;690.1304356510732;4799.400074990626;5548.5838562108;5714.542836573064;5757.65454072757;5893.233879595625;92179;93433;94654;101724.49137754412;102379;87944;90327.54836225777;90617.54691226633;90758.54620726986;91431.54284228536;72911;79067.60466197632;80011;81175.59412203019;82978.58510707528;11703.180777345504;11844.230125041844;11967.700807479883;12840.871591283967;12915.870841291468;36312.818435907655;36904.07739806527;37218.13909304578;37395.42596283063;38663.61336386712;65260.67369663122;67070;67402.32597673961;69201;70369.29630703627;17513.47459576215;17893.284268629628;17905.19426625831;18496.167672454503;18850;20962.685559716312;21044;21298.148074076864;21574;21851.89074054683;18341.816581834544;18564.164612592194;18887.90556047211;19619.901900490408;19810.90094549518;18705.25178992825;18759.155837987597;19489.70765438548;19577.70633440471;19675.31136410219;17930.91034544819;18248.817511824713;18495.63008739791;18738.25046998105;18918.054097295357;13740.862591374358;13788.862111378758;13826.239556824472;13949.651258718613;14122.364493598017;14062.156270623795;14354.712905741619;14419.279036048365;14813.25933703289;14983.775243371576 03:21:18 INFO - PID 969 | __end_tp_report 03:21:18 INFO - PID 969 | __start_cc_report 03:21:18 INFO - PID 969 | _x_x_mozilla_cycle_collect,378 03:21:18 INFO - PID 969 | __end_cc_report 03:21:18 INFO - PID 969 | __startTimestamp1501669278390__endTimestamp 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | ------- Summary: start ------- 03:21:18 INFO - PID 969 | Number of tests: 6 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#0] dojo.html Cycles:165 Average:6137.67 Median:6414.62 stddev:713.07 (11.1%) stddev-sans-first:674.97 03:21:18 INFO - PID 969 | Values: 3125.7 3127.5 3146.9 3188.2 3190.4 6050.4 6132.5 6193.6 6227.1 6277.9 6134.4 6163.8 6214.8 6221.9 6223.4 5635.2 5687.2 5688.3 5691.6 5707.1 5731.6 5732.7 5733.8 5745.3 5760.6 5723.1 5725.6 5745.0 5750.9 5753.1 5722.4 5750.5 5784.4 5793.0 5826.1 5578.0 5612.7 5619.5 5649.2 5734.0 5996.3 6040.4 6041.8 6061.0 6164.6 6570.6 6613.2 6618.9 6659.5 6705.1 6639.1 6641.0 6655.8 6717.5 6740.7 6144.0 6155.9 6246.9 6260.6 6266.6 6883.7 6890.9 6900.4 6901.9 6907.0 6546.2 6558.6 6592.4 6597.3 6602.1 6512.1 6611.2 6617.0 6699.2 6721.1 6431.3 6585.9 6589.8 6648.9 6667.9 6619.8 6695.3 6695.3 6698.0 6719.5 5428.5 5449.0 5488.6 5497.7 5499.3 4621.8 4639.6 4688.4 4699.3 4708.5 5762.1 5783.3 5837.0 5841.8 5841.8 6678.1 6686.8 6711.4 6717.3 6726.6 5768.0 5809.3 5836.1 5846.1 5860.3 5819.7 5825.9 5832.3 5899.6 5918.1 6305.3 6414.6 6415.8 6500.8 6501.8 6717.0 6725.1 6743.0 6756.4 6769.7 6418.4 6436.5 6446.4 6523.1 6527.3 6430.5 6531.1 6533.3 6624.1 6633.6 6651.9 6673.1 6676.4 6689.7 6697.4 6340.3 6425.2 6427.2 6434.5 6456.4 6436.5 6440.3 6454.0 6500.8 6526.9 6465.4 6470.3 6490.1 6506.3 6517.1 6512.2 6518.3 6559.1 6604.1 6616.6 6215.5 6298.7 6318.1 6386.5 6399.0 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#1] ext.html Cycles:180 Average:39314.77 Median:35845.32 stddev:56633.89 (158.0%) stddev-sans-first:56718.91 03:21:18 INFO - PID 969 | Values: 795.9 866.5 890.5 1146.3 1170.7 29922.7 30478.8 40610.6 41486.0 41503.0 42354.8 42727.0 42776.6 42786.6 42817.4 7142.5 7536.0 7690.0 7691.0 7712.9 7476.2 7585.5 7588.9 7591.8 7593.5 7554.8 7602.8 7606.2 7624.9 7637.0 7560.1 7589.7 7592.1 7594.8 7597.8 7528.4 7545.7 7598.7 7599.5 7605.2 37520.8 37679.8 37870.4 37922.6 37985.2 3481.4 3523.3 3532.7 3537.6 3547.2 30342.0 30432.8 30465.2 30581.8 30585.1 4736.1 4752.0 4770.9 4799.3 4814.6 196563.0 197212.0 197283.0 197309.0 197896.0 48580.5 48613.8 48629.0 48651.5 48727.3 50904.0 55313.4 55323.9 55871.7 56027.7 16004.1 16053.2 16081.5 16153.8 16200.6 10822.6 10911.3 13092.8 13877.9 14011.5 14649.6 14703.1 14704.9 14787.6 14831.8 5716.2 5865.5 5872.9 5914.2 6024.4 979.7 987.3 999.4 1015.3 1018.3 22643.3 22851.5 23365.2 23374.2 23453.1 1091.6 1102.4 1103.8 1108.0 1108.4 16086.9 16332.5 16373.6 16444.4 16690.0 247471.0 248186.0 251163.0 251444.0 251840.0 57101.4 57147.4 57147.4 57280.7 57490.0 1424.0 1425.9 1465.6 1474.8 1475.6 27626.7 28130.6 28212.2 28376.7 28615.0 35843.6 36097.5 36122.8 36153.3 36163.8 202955.0 203112.0 203877.0 203926.0 205854.0 34305.1 36440.3 38097.2 38259.4 38371.6 46304.0 47534.8 47697.0 47774.8 48089.3 35037.0 35069.5 35141.3 35847.0 35869.2 34766.3 35097.0 35336.1 35489.0 35543.2 38140.0 38579.2 38783.2 38788.4 38797.4 32832.5 33577.7 33739.7 33786.3 33943.3 23492.9 24488.8 24841.3 25069.9 25151.0 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#2] jquery.html Cycles:180 Average:36531.10 Median:21780.23 stddev:87549.68 (402.0%) stddev-sans-first:87753.64 03:21:18 INFO - PID 969 | Values: 568.4 575.0 578.3 579.8 601.5 22169.0 22536.5 23275.9 23279.3 23329.7 25768.0 26086.6 26250.2 26303.9 26325.7 6347.8 6420.1 6478.0 6507.7 6517.8 6151.0 6280.8 6437.7 6446.6 6450.5 6385.4 6402.3 6414.6 6417.3 6417.4 6356.8 6402.4 6403.3 6405.3 6413.6 5962.6 5962.6 5979.9 5982.5 5994.7 28540.1 29434.7 29602.6 29780.4 30406.8 1916.9 1952.6 1952.7 1952.9 1953.2 18837.0 19554.1 19557.2 19579.6 19593.9 2244.6 2267.1 2312.3 2317.5 2318.5 139823.0 143973.0 144175.0 146413.5 150119.0 14424.7 14528.3 14868.9 15039.8 15121.9 23007.9 23059.2 23238.0 23240.5 23258.9 10335.3 10338.9 10362.8 10427.8 10442.2 7692.2 9832.5 9892.0 10023.1 10088.4 8080.0 11009.6 11627.7 11767.6 11970.6 3763.4 3802.5 4142.9 4205.0 4247.9 954.3 981.4 984.4 988.0 993.0 19660.5 19703.9 19998.9 20278.6 20547.4 1034.8 1041.9 1048.0 1049.3 1059.5 11024.6 13020.6 14112.2 14174.0 14219.7 512717.0 518870.0 520070.0 522035.0 525147.0 116319.0 119482.4 119829.0 122422.0 124770.0 1265.5 1302.1 1302.6 1306.4 1321.5 21100.7 21272.3 21319.8 21335.7 21391.5 59552.7 59823.2 61016.0 61743.7 62449.1 75537.0 76118.6 76324.0 76517.2 77369.6 12501.5 14203.9 14802.9 15116.2 15228.2 23209.0 23380.6 23411.0 23428.5 23651.5 18555.7 18962.4 18967.0 18970.0 19129.7 16932.9 17193.6 17255.5 17520.1 17570.4 18988.4 19826.3 20145.2 20308.9 20360.2 14483.8 15015.6 15083.0 15103.7 15153.0 18478.3 18485.8 18531.6 18565.6 18587.3 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#3] mootools.html Cycles:180 Average:8594.74 Median:2690.49 stddev:5693.76 (211.6%) stddev-sans-first:5683.78 03:21:18 INFO - PID 969 | Values: 1360.8 1405.4 1416.8 1426.2 1436.0 13443.8 13573.3 14245.7 14254.6 14270.0 13874.1 14195.7 14200.3 14208.7 14209.0 2682.6 2725.7 2749.5 2750.5 2752.8 2648.7 2776.3 2777.3 2780.3 2781.4 2684.6 2708.4 2716.1 2744.5 2747.3 2696.4 2698.5 2704.6 2709.0 2756.0 2638.1 2640.6 2663.8 2664.3 2664.8 12885.1 13076.2 13086.9 13098.3 13119.5 7458.7 7649.3 7725.8 7739.8 7747.2 4976.4 5095.5 5161.3 5180.2 5195.9 1811.2 1851.3 1896.1 1915.9 1937.6 22267.1 22444.3 22451.4 22480.6 22495.0 6416.3 7014.6 7174.2 7182.2 7235.1 15180.6 15261.5 15302.6 15314.8 15319.2 6925.3 7450.7 7451.9 7902.1 7930.1 6867.2 7101.9 7108.1 7112.9 7118.6 5035.3 5169.1 5211.6 5262.8 5278.9 1532.3 1535.3 1545.0 1548.3 1575.7 889.5 924.9 929.8 940.2 941.9 7278.7 7375.1 7377.5 7424.9 7427.2 710.4 738.7 739.3 746.9 755.7 5559.9 5710.5 5711.7 5758.0 5804.9 17808.5 18477.4 18790.9 18850.9 18852.3 18429.4 18474.1 18565.9 18579.0 18584.9 9835.5 10491.7 10632.6 10690.5 10759.4 7935.0 7999.6 8389.7 8429.8 8442.5 15749.8 15924.8 16232.8 16494.8 16548.6 16501.8 16695.2 16825.9 16899.7 17079.7 10193.2 10478.9 10992.6 11206.4 11377.1 13007.9 13105.8 13116.0 13121.4 13176.8 10635.6 10640.5 10773.4 10888.6 10982.8 9954.2 10084.4 10091.4 10411.9 10634.1 9467.8 9491.3 9522.2 9554.2 9608.6 7189.8 7272.6 7290.4 7311.6 7327.5 7145.9 7195.6 7239.1 7311.7 7338.8 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#4] prototype.html Cycles:180 Average:5481.97 Median:6109.65 stddev:1533.64 (25.1%) stddev-sans-first:1491.49 03:21:18 INFO - PID 969 | Values: 491.2 502.4 531.4 533.6 539.3 6151.4 6257.1 6291.7 6292.9 6294.8 5948.6 6081.1 6122.8 6126.7 6159.8 4889.8 4898.6 4938.6 4948.4 4980.4 4767.5 4910.7 4932.0 4963.6 5037.5 4880.2 4888.4 4893.0 4899.5 4966.1 4856.8 4899.6 4907.6 4929.3 4938.8 4445.2 4501.1 4504.1 4505.6 4515.8 6005.3 6037.4 6039.5 6107.5 6111.8 5623.7 5627.7 5691.9 5711.2 5715.6 6509.3 6526.8 6540.7 6544.2 6557.5 4905.5 4914.3 4928.3 4951.3 4956.3 6858.3 6895.4 6898.8 6906.0 6932.0 4955.7 4964.7 4975.9 4982.5 4997.1 5013.3 5059.8 5084.7 5092.7 5097.2 5616.3 5664.2 5684.9 5689.8 5715.8 6239.6 6325.5 6520.5 6536.7 6552.5 1666.1 1693.8 1727.6 1740.4 1749.8 1204.4 1212.1 1221.0 1243.7 1255.7 5687.4 5691.2 5714.8 5757.9 5777.5 6522.4 6575.1 6620.0 6700.4 6706.0 5665.5 5667.2 5718.2 5781.2 5789.4 3538.9 3557.4 3608.2 3614.2 3618.6 6455.1 6562.0 6564.8 6566.4 6570.3 6686.9 6792.6 6878.9 6896.0 6914.0 6384.4 6404.6 6448.7 6454.6 6503.8 6578.6 6649.7 6703.6 6724.8 6727.6 6585.6 6618.3 6668.4 6668.9 6675.9 6396.7 6420.1 6485.4 6504.4 6544.3 4993.6 5015.3 5025.4 5072.2 5073.9 6504.9 6675.3 6741.2 6745.3 6810.8 6279.5 6366.9 6432.5 6468.2 6472.0 6401.8 6467.5 6490.5 6496.3 6505.6 6128.4 6361.0 6404.5 6431.3 6480.3 6412.8 6538.7 6552.9 6588.6 6606.7 6248.5 6329.2 6384.6 6396.6 6401.3 03:21:18 INFO - PID 969 | 03:21:18 INFO - PID 969 | [#5] yui.html Cycles:180 Average:22836.05 Median:21102.18 stddev:30133.59 (142.8%) stddev-sans-first:30173.10 03:21:18 INFO - PID 969 | Values: 899.3 901.5 922.4 923.6 929.4 16980.4 18429.4 18582.2 18585.3 20544.7 20643.3 21059.7 21079.5 21311.3 21355.4 955.2 991.9 996.8 1002.2 1002.6 965.5 1064.1 1071.9 1075.1 1075.7 1113.8 1113.9 1114.2 1114.3 1114.9 1098.8 1103.7 1105.0 1105.4 1107.3 805.2 806.6 807.8 808.3 808.6 19340.0 19450.5 19884.6 19912.7 20337.8 20566.7 20590.0 20971.8 21124.9 21141.4 15084.2 15096.5 15206.4 15286.9 15289.2 3467.3 3497.1 3498.2 3500.0 3500.8 123103.4 124486.4 125921.0 126181.0 126987.0 15027.5 15116.5 15309.5 15356.4 15370.8 29762.3 30229.7 30694.7 30807.5 30858.0 7993.6 8121.6 8141.1 8173.7 8177.6 4022.9 4074.7 4082.7 4107.2 4127.7 5233.4 5273.3 5349.8 5382.4 5396.9 934.7 953.8 967.2 972.3 976.8 672.2 686.0 688.5 695.1 703.1 11779.6 11782.5 11984.3 12611.2 13015.3 665.0 675.4 676.5 677.1 690.1 4799.4 5548.6 5714.5 5757.7 5893.2 92179.0 93433.0 94654.0 101724.5 102379.0 87944.0 90327.5 90617.5 90758.5 91431.5 72911.0 79067.6 80011.0 81175.6 82978.6 11703.2 11844.2 11967.7 12840.9 12915.9 36312.8 36904.1 37218.1 37395.4 38663.6 65260.7 67070.0 67402.3 69201.0 70369.3 17513.5 17893.3 17905.2 18496.2 18850.0 20962.7 21044.0 21298.1 21574.0 21851.9 18341.8 18564.2 18887.9 19619.9 19810.9 18705.3 18759.2 19489.7 19577.7 19675.3 17930.9 18248.8 18495.6 18738.3 18918.1 13740.9 13788.9 13826.2 13949.7 14122.4 14062.2 14354.7 14419.3 14813.3 14983.8 03:21:18 INFO - PID 969 | -------- Summary: end -------- 03:21:18 INFO - PID 969 | 03:21:19 INFO - TEST-INFO | 969: exit 0 03:21:19 INFO - TEST-OK | dromaeo_css | took 1112384ms 03:21:19 INFO - TEST-START | kraken 03:21:19 INFO - Initialising browser for kraken test... 03:21:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55519/getInfo.html -profile /tmp/tmp17v6hj/profile 03:21:19 INFO - TEST-INFO | started process 1358 (/builds/slave/test/build/application/firefox/firefox http://localhost:55519/getInfo.html) 03:21:24 INFO - TEST-INFO | 1358: exit 0 03:21:24 INFO - Browser initialized. 03:21:24 INFO - Running cycle 1/1 for kraken test... 03:21:24 INFO - TEST-INFO | started process 1569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17v6hj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:25 INFO - PID 1569 | 03:21:25 INFO - PID 1569 | (/builds/slave/test/build/application/firefox/firefox:1618): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:25 INFO - PID 1569 | 03:21:36 INFO - PID 1569 | RSS: Main: 171765760 03:21:36 INFO - PID 1569 | 03:21:38 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:39 INFO - PID 1569 | RSS: Main: 177647616 03:21:39 INFO - PID 1569 | 03:21:42 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-dft) 03:21:43 INFO - PID 1569 | RSS: Main: 178126848 03:21:43 INFO - PID 1569 | 03:21:46 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-fft) 03:21:46 INFO - PID 1569 | RSS: Main: 171945984 03:21:46 INFO - PID 1569 | 03:21:48 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-oscillator) 03:21:49 INFO - PID 1569 | RSS: Main: 172707840 03:21:49 INFO - PID 1569 | 03:21:51 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:52 INFO - PID 1569 | RSS: Main: 173006848 03:21:52 INFO - PID 1569 | 03:21:55 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:55 INFO - PID 1569 | RSS: Main: 175026176 03:21:55 INFO - PID 1569 | 03:21:59 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:00 INFO - PID 1569 | RSS: Main: 175583232 03:22:00 INFO - PID 1569 | 03:22:02 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55519/tests/kraken/driver.html?testName=json-parse-financial) 03:22:03 INFO - PID 1569 | RSS: Main: 175788032 03:22:03 INFO - PID 1569 | 03:22:05 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:05 INFO - PID 1569 | RSS: Main: 175362048 03:22:05 INFO - PID 1569 | 03:22:07 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:22:08 INFO - PID 1569 | RSS: Main: 173273088 03:22:08 INFO - PID 1569 | 03:22:10 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:10 INFO - PID 1569 | RSS: Main: 173256704 03:22:10 INFO - PID 1569 | 03:22:13 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:14 INFO - PID 1569 | RSS: Main: 173711360 03:22:14 INFO - PID 1569 | 03:22:17 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:18 INFO - PID 1569 | RSS: Main: 173809664 03:22:18 INFO - PID 1569 | 03:22:19 INFO - PID 1569 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55519/tests/kraken/driver.html?testName=ai-astar) 03:22:20 INFO - PID 1569 | RSS: Main: 175419392 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | __start_tp_report 03:22:20 INFO - PID 1569 | _x_x_mozilla_page_load 03:22:20 INFO - PID 1569 | _x_x_mozilla_page_load_details 03:22:20 INFO - PID 1569 | |i|pagename|runs| 03:22:20 INFO - PID 1569 | |0;ai-astar;99;109;101;107;115;109;112;100;108;106 03:22:20 INFO - PID 1569 | |1;audio-beat-detection;142;117;152;180;126;151;149;118;165;125 03:22:20 INFO - PID 1569 | |2;audio-dft;166;165;163;161;165;163;168;172;168;164 03:22:20 INFO - PID 1569 | |3;audio-fft;75;74;74;181;76;84;74;91;98;75 03:22:20 INFO - PID 1569 | |4;audio-oscillator;79;79;132;78;79;79;125;80;78;132 03:22:20 INFO - PID 1569 | |5;imaging-gaussian-blur;114;114;116;114;114;115;114;113;114;114 03:22:20 INFO - PID 1569 | |6;imaging-darkroom;151;152;151;151;150;149;152;151;152;150 03:22:20 INFO - PID 1569 | |7;imaging-desaturate;94;94;94;94;94;94;95;95;94;93 03:22:20 INFO - PID 1569 | |8;json-parse-financial;58;55;55;55;54;55;55;55;55;55 03:22:20 INFO - PID 1569 | |9;json-stringify-tinderbox;53;53;53;54;54;55;58;54;53;53 03:22:20 INFO - PID 1569 | |10;stanford-crypto-aes;83;78;80;88;79;77;76;77;79;78 03:22:20 INFO - PID 1569 | |11;stanford-crypto-ccm;138;131;132;142;137;122;128;126;149;173 03:22:20 INFO - PID 1569 | |12;stanford-crypto-pbkdf2;172;186;179;178;186;173;174;175;184;173 03:22:20 INFO - PID 1569 | |13;stanford-crypto-sha256-iterative;68;66;68;75;65;66;68;64;67;67 03:22:20 INFO - PID 1569 | __end_tp_report 03:22:20 INFO - PID 1569 | __start_cc_report 03:22:20 INFO - PID 1569 | _x_x_mozilla_cycle_collect,980 03:22:20 INFO - PID 1569 | __end_cc_report 03:22:20 INFO - PID 1569 | __startTimestamp1501669340231__endTimestamp 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | ------- Summary: start ------- 03:22:20 INFO - PID 1569 | Number of tests: 14 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:5.23 (4.8%) stddev-sans-first:4.77 03:22:20 INFO - PID 1569 | Values: 99.0 109.0 101.0 107.0 115.0 109.0 112.0 100.0 108.0 106.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:150.00 stddev:20.94 (14.0%) stddev-sans-first:22.21 03:22:20 INFO - PID 1569 | Values: 142.0 117.0 152.0 180.0 126.0 151.0 149.0 118.0 165.0 125.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.17 (1.9%) stddev-sans-first:3.36 03:22:20 INFO - PID 1569 | Values: 166.0 165.0 163.0 161.0 165.0 163.0 168.0 172.0 168.0 164.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#3] audio-fft Cycles:10 Average:90.20 Median:75.50 stddev:32.99 (43.7%) stddev-sans-first:34.53 03:22:20 INFO - PID 1569 | Values: 75.0 74.0 74.0 181.0 76.0 84.0 74.0 91.0 98.0 75.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:24.62 (31.2%) stddev-sans-first:25.50 03:22:20 INFO - PID 1569 | Values: 79.0 79.0 132.0 78.0 79.0 79.0 125.0 80.0 78.0 132.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 03:22:20 INFO - PID 1569 | Values: 114.0 114.0 116.0 114.0 114.0 115.0 114.0 113.0 114.0 114.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 03:22:20 INFO - PID 1569 | Values: 151.0 152.0 151.0 151.0 150.0 149.0 152.0 151.0 152.0 150.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:22:20 INFO - PID 1569 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 93.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:0.33 03:22:20 INFO - PID 1569 | Values: 58.0 55.0 55.0 55.0 54.0 55.0 55.0 55.0 55.0 55.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:1.56 (2.9%) stddev-sans-first:1.62 03:22:20 INFO - PID 1569 | Values: 53.0 53.0 53.0 54.0 54.0 55.0 58.0 54.0 53.0 53.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:3.57 (4.5%) stddev-sans-first:3.55 03:22:20 INFO - PID 1569 | Values: 83.0 78.0 80.0 88.0 79.0 77.0 76.0 77.0 79.0 78.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:14.71 (10.7%) stddev-sans-first:15.60 03:22:20 INFO - PID 1569 | Values: 138.0 131.0 132.0 142.0 137.0 122.0 128.0 126.0 149.0 173.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:178.50 stddev:5.54 (3.1%) stddev-sans-first:5.43 03:22:20 INFO - PID 1569 | Values: 172.0 186.0 179.0 178.0 186.0 173.0 174.0 175.0 184.0 173.0 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.99 (4.4%) stddev-sans-first:3.16 03:22:20 INFO - PID 1569 | Values: 68.0 66.0 68.0 75.0 65.0 66.0 68.0 64.0 67.0 67.0 03:22:20 INFO - PID 1569 | -------- Summary: end -------- 03:22:20 INFO - PID 1569 | 03:22:20 INFO - PID 1569 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:22:20 INFO - TEST-INFO | 1569: exit 0 03:22:20 INFO - TEST-OK | kraken | took 61750ms 03:22:20 INFO - SUITE-END | took 1174s 03:22:21 INFO - Completed test suite (00:19:34) 03:22:21 INFO - javascript benchmark 03:22:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.960407764287, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.7343125834304, 3127.5152351385527, 3146.9213269668257, 3188.18701231186, 3190.377876314118, 6050.425209605091, 6132.509399248061, 6193.597416167946, 6227.128202051711, 6277.905831412532, 6134.386561343864, 6163.753449862, 6214.751409943608, 6221.906671399933, 6223.377662233775, 5635.21107045014, 5687.17535957287, 5688.260526131618, 5691.601587888828, 5707.086866101425, 5731.570132240078, 5732.656040637554, 5733.770649174028, 5745.310562732478, 5760.596758226926, 5723.112917497794, 5725.6278341907855, 5745.017968800778, 5750.884982300372, 5753.079507278836, 5722.37053924068, 5750.539956803445, 5784.421557844203, 5793.044147715622, 5826.126081087828, 5578.0, 5612.719364031782, 5619.522340601054, 5649.180868774046, 5734.025215713339, 5996.340402555716, 6040.395960403968, 6041.818745437644, 6061.030235162397, 6164.630122192682, 6570.5729127606555, 6613.2064152301555, 6618.93381066188, 6659.500537459661, 6705.061291419205, 6639.070530125786, 6641.0, 6655.800325990228, 6717.529772915897, 6740.696668649923, 6144.047672610753, 6155.907661385038, 6246.937530624681, 6260.5617606768, 6266.561340706106, 6883.690233939485, 6890.931090689029, 6900.378965893094, 6901.930980690129, 6907.0, 6546.24718157418, 6558.573692710054, 6592.373724496165, 6597.274299827015, 6602.10871532337, 6512.088307636935, 6611.20665520131, 6616.966915165393, 6699.229588597374, 6721.092652491949, 6431.292557818636, 6585.934140658532, 6589.83525411859, 6648.933510664928, 6667.933320666828, 6619.801405957829, 6695.296993815579, 6695.330466953265, 6697.966510167418, 6719.529632925746, 5428.511433970962, 5449.0, 5488.588355873246, 5497.670139791625, 5499.257600223998, 4621.838235661736, 4639.582437580634, 4688.367070445446, 4699.342092107107, 4708.505606911293, 5762.106873434541, 5783.306003279549, 5837.007708689533, 5841.766329346863, 5841.795537156264, 6678.1318428604945, 6686.83282917931, 6711.429528490035, 6717.294684058202, 6726.562773419712, 5768.048272035067, 5809.302883653904, 5836.06622940336, 5846.093855452412, 5860.267466566679, 5819.679917604488, 5825.941740582624, 5832.270966129234, 5899.616524925866, 5918.112283157561, 6305.306416294204, 6414.615123092536, 6415.775447859302, 6500.804975850638, 6501.837454063686, 6717.026031225542, 6725.092112564741, 6743.022261771917, 6756.425703815231, 6769.729210831709, 6418.358164183544, 6436.485081193587, 6446.355364463516, 6523.086767852409, 6527.3472652734345, 6430.453411460078, 6531.131001935892, 6533.281339052795, 6624.072629831731, 6633.635150066792, 6651.933480665131, 6673.099131617169, 6676.365745254193, 6689.732410703517, 6697.430718388991, 6340.270868850142, 6425.164728585254, 6427.164468619049, 6434.517411194086, 6456.354364563506, 6436.452901503425, 6440.2915679276175, 6453.967730161319, 6500.772472963424, 6526.869462610816, 6465.3857883501, 6470.255920569195, 6490.058941453557, 6506.316836732075, 6517.087607734826, 6512.185976752906, 6518.282988871126, 6559.0817285581015, 6604.14146160996, 6616.603003819786, 6215.533834962305, 6298.653574053471, 6318.115463834974, 6386.489080873612, 6398.968005160131], "value": 6084.75548634567, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.8726603743398, 866.4627930682976, 890.5191196753754, 1146.346582448005, 1170.7424366639336, 29922.700772992263, 30478.847605761996, 40610.59389406105, 41486.0, 41503.0, 42354.7882260589, 42726.99999999992, 42776.57223427765, 42786.57213427865, 42817.35773963393, 7142.500024998252, 7536.0, 7690.0, 7691.038620172479, 7712.884306735404, 7476.177620461772, 7585.544867307979, 7588.886166707503, 7591.848163036736, 7593.468457207998, 7554.848903021936, 7602.809929751746, 7606.201348858373, 7624.923750762505, 7636.961815190916, 7560.054993125859, 7589.658465369072, 7592.088949326117, 7594.810129746746, 7597.810054748647, 7528.435367347416, 7545.735899243555, 7598.658060387296, 7599.544027358376, 7605.201453847377, 37520.81239593784, 37679.81160094209, 37870.43194352087, 37922.62077379219, 37985.24029519422, 3481.4429691249534, 3523.330567192251, 3532.717382609385, 3537.575490941078, 3547.2018795771005, 30342.0, 30432.84783576068, 30465.23836904073, 30581.847090764626, 30585.08244752661, 4736.052789442126, 4752.0, 4770.928436073462, 4799.304100905384, 4814.590759785422, 196563.0, 197212.0, 197283.0, 197309.01345493324, 197896.0, 48580.514194858304, 48613.75693121582, 48629.0, 48651.5134848647, 48727.269090963666, 50904.0, 55313.44686553164, 55323.89352212933, 55871.72064139653, 56027.719861401245, 16004.119773412574, 16053.197340132947, 16081.517554473385, 16153.757693634605, 16200.59498512523, 10822.621208257673, 10911.34531928071, 13092.803607945889, 13877.930610346884, 14011.509597164051, 14649.633759156106, 14703.117812931258, 14704.926475367769, 14787.560052591201, 14831.77752333716, 5716.1997320375185, 5865.507159457214, 5872.911906321408, 5914.172015917775, 6024.367441418675, 979.6767066867917, 987.3039507147444, 999.3604093380243, 1015.28422462164, 1018.3482571154467, 22643.320700379016, 22851.542969140522, 23365.182218622267, 23374.181903633293, 23453.06187752471, 1091.5961094395125, 1102.399192440122, 1103.784761971424, 1107.95568177272, 1108.4070022537903, 16086.919565402099, 16332.510024699279, 16373.590660233589, 16444.424445144363, 16690.0, 247471.0, 248186.0, 251163.0, 251444.0, 251840.0, 57101.428985710445, 57147.42852571504, 57147.42852571504, 57280.713596432586, 57490.0, 1423.950161744334, 1425.9020554173228, 1465.6262653023412, 1474.8451412601737, 1475.5868356860096, 27626.723732762413, 28130.578041328987, 28212.153635390972, 28376.716232838233, 28615.0, 35843.64156358507, 36097.458538122475, 36122.819385902905, 36153.27693446169, 36163.81918090393, 202955.0, 203112.0, 203877.0, 203926.0, 205854.0, 34305.14237143991, 36440.27119457649, 38097.23805523819, 38259.42610860783, 38371.6162838368, 46304.0, 47534.762326188145, 47697.0, 47774.76112619415, 48089.27866082082, 35037.0, 35069.47395789014, 35141.29717405689, 35847.0, 35869.20653967239, 34766.30467390689, 35097.0, 35336.11659708528, 35489.0, 35543.22283885847, 38140.0, 38579.228415432095, 38783.22433551257, 38788.41817372798, 38797.41803872888, 32832.50751238781, 33577.66422335843, 33739.662603373654, 33786.3242735139, 33943.32113357769, 23492.882535587214, 24488.75511244936, 24841.25476235716, 25069.87465062663, 25151.0], "value": 17710.342642023523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3946596874329, 574.9885002299951, 578.2569398323153, 579.8463407197094, 601.5368166511786, 22169.0, 22536.54926901465, 23275.883620581917, 23279.301620951377, 23329.650055249185, 25768.0, 26086.608700869503, 26250.212493625175, 26303.868480657617, 26325.73674263257, 6347.777827776029, 6420.06908998195, 6478.028295755651, 6507.739690412378, 6517.771877984272, 6150.96924515379, 6280.842978925518, 6437.710303036374, 6446.580972236813, 6450.483961283109, 6385.425311721944, 6402.263739669951, 6414.583052101621, 6417.294097649278, 6417.422431981121, 6356.841078973062, 6402.359764023584, 6403.263624683174, 6405.3274406187375, 6413.583117097373, 5962.552808539377, 5962.612430192024, 5979.910301345483, 5982.521398288127, 5994.700264986734, 28540.143795686163, 29434.705652943623, 29602.555961660593, 29780.40439191204, 30406.84796576025, 1916.9424917252504, 1952.6192392483472, 1952.6582848001542, 1952.8535359848067, 1953.1796645408963, 18837.0, 19554.120064597126, 19557.21771129153, 19579.608407831907, 19593.9020304899, 2244.5510897820336, 2267.138487374787, 2312.3294244669028, 2317.478567322356, 2318.547883162784, 139823.0, 143973.0, 144175.0, 146413.53586464105, 150118.9999999989, 14424.711505769827, 14528.273586320642, 14868.851311486747, 15039.849601504064, 15121.924390377977, 23007.884960575426, 23059.19292824743, 23238.0, 23240.53518929612, 23258.883705581702, 10335.328203666737, 10338.896611033944, 10362.844557331646, 10427.791444171075, 10442.2168337375, 7692.230776922375, 9832.508374581243, 9892.0, 10023.097921187129, 10088.445135517617, 8080.0, 11009.61466348674, 11627.686109458764, 11767.588134415426, 11970.581029664094, 3763.41667041609, 3802.543694756647, 4142.91714165715, 4204.986868777677, 4247.87256382309, 954.2938225712923, 981.3670182732097, 984.3798407003542, 987.9901200987898, 992.965246216379, 19660.525460590514, 19703.901480492794, 19998.90000549988, 20278.594428111355, 20547.38357849267, 1034.8033873564, 1041.9479026048666, 1047.994760026195, 1049.302214027663, 1059.4543809937888, 11024.614138505114, 13020.609381718563, 14112.22382768937, 14174.0, 14219.715605687828, 512717.0, 518870.0, 520070.0, 522035.0, 525147.0, 116319.0, 119482.40258798824, 119829.0, 122422.0, 124770.0, 1265.4621785741024, 1302.1210682789078, 1302.5961951794975, 1306.3664122900386, 1321.4714114354142, 21100.68348974736, 21272.255471058437, 21319.78680213178, 21335.67996480023, 21391.465213369167, 59552.70223648854, 59823.20673631333, 61016.0, 61743.6912815433, 62449.06326405198, 75537.0, 76118.61940690261, 76324.0, 76517.23482765102, 77369.61315193388, 12501.499940002663, 14203.857961420666, 14802.851971480148, 15116.168610726076, 15228.162451064854, 23209.0, 23380.64929026032, 23411.0, 23428.53142937166, 23651.52696946017, 18555.721664174776, 18962.43112706621, 18967.0, 18970.0, 19129.713054303917, 16932.915335423244, 17193.57016074608, 17255.482335529956, 17520.123993800004, 17570.38503652366, 18988.43034708961, 19826.306079287155, 20145.194192232146, 20308.898455507628, 20360.18559257613, 14483.78274325865, 15015.624609384853, 15083.0, 15103.697926041637, 15153.0, 18478.260869565067, 18485.81514184841, 18531.629367412846, 18565.628687426444, 18587.34944276944], "value": 12440.740964287896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.8435029971554, 1405.4027038508643, 1416.7945647881052, 1426.1942002768435, 1435.9784603230953, 13443.798343024862, 13573.2534710591, 14245.715085698279, 14254.643633909158, 14270.0, 13874.098183618058, 14195.71608567828, 14200.289985500734, 14208.715825683506, 14209.00536962413, 2682.6244325794405, 2725.74105459981, 2749.4913441013377, 2750.5324094903913, 2752.779777617796, 2648.682158141026, 2776.3059235191204, 2777.319556708609, 2780.3466185446405, 2781.3602871339504, 2684.6107314439396, 2708.404151086768, 2716.0629582793904, 2744.4922689302443, 2747.3269049083, 2696.36635390683, 2698.541247987847, 2704.5537486314834, 2709.0, 2756.021612327635, 2638.0503018913178, 2640.5511063119316, 2663.760261576448, 2664.3205982474537, 2664.773494252991, 12885.098043136984, 13076.215427074407, 13086.86913130866, 13098.279594622387, 13119.47522099115, 7458.70165193397, 7649.349805266559, 7725.8454830903065, 7739.806504837367, 7747.186545412706, 4976.353074100344, 5095.464976177485, 5161.329027226437, 5180.171172612364, 5195.896082078375, 1811.212122726605, 1851.2502436513098, 1896.0709252466331, 1915.9329423470112, 1937.5640480891686, 22267.109315627356, 22444.326670199756, 22451.43871403228, 22480.550388992127, 22495.0, 6416.326285740023, 7014.649267536603, 7174.210836807947, 7182.2458641842895, 7235.131784185826, 15180.620484487756, 15261.542153735405, 15302.617434564225, 15314.846851531565, 15319.157446340558, 6925.307469253135, 7450.739224127129, 7451.888221676679, 7902.091259505116, 7930.1276859545405, 6867.244603093655, 7101.89347159793, 7108.111486064242, 7112.928870711226, 7118.60847653384, 5035.345405097314, 5169.06956747789, 5211.609129315317, 5262.7631756571045, 5278.894422111536, 1532.3257766582667, 1535.3167840310955, 1544.9691006179814, 1548.2645743271855, 1575.708493928627, 889.479654402182, 924.9398789078689, 929.818685356349, 940.2431043010306, 941.9293552983416, 7278.745243916437, 7375.078115235596, 7377.520461170114, 7424.925750742424, 7427.18300986891, 710.3642240194996, 738.7155944961121, 739.3272122368619, 746.9103707555129, 755.743047363888, 5559.935727901528, 5710.457506536873, 5711.742971566289, 5758.0, 5804.894381505874, 17808.46574602764, 18477.445676629723, 18790.906045469685, 18850.905745471184, 18852.34016809405, 18429.354972575897, 18474.076296185136, 18565.907170464332, 18579.0, 18584.907075464806, 9835.508224588742, 10491.68524944253, 10632.574697012033, 10690.518926648165, 10759.408232547285, 7934.960325198337, 7999.560024198725, 8389.706360277361, 8429.831403371776, 8442.451240669337, 15749.842501575296, 15924.8407515928, 16232.837671623132, 16494.83505164933, 16548.586285342964, 16501.83498165003, 16695.16524173762, 16825.91587042057, 16899.66200676004, 17079.743803842703, 10193.184545236216, 10478.94760526223, 10992.615258465916, 11206.439678015904, 11377.08983281352, 13007.869921300666, 13105.803412948622, 13116.0, 13121.409536570687, 13176.802347964596, 10635.574577016832, 10640.467976601294, 10773.353598784099, 10888.564457421615, 10982.835257470984, 9954.203663706741, 10084.445355505517, 10091.44497052669, 10411.94794026025, 10634.09610183143, 9467.810643786948, 9491.288153388385, 9522.190613797628, 9554.235661146953, 9608.567614457506, 7189.820254493679, 7272.636368181464, 7290.416766658761, 7311.634418279171, 7327.487075904849, 7145.892811607726, 7195.568265904062, 7239.095113110861, 7311.67097480604, 7338.816529586803], "value": 6338.688842488442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.21443552685986, 502.44228905914406, 531.351750863946, 533.5731414868104, 539.3420027566373, 6151.4463698267145, 6257.124002639628, 6291.716872740738, 6292.8741425171465, 6294.811155665332, 5948.583599148062, 6081.11485439514, 6122.785702500413, 6126.652136529956, 6159.81520554384, 4889.828855990041, 4898.583620392271, 4938.555530002299, 4948.38145231846, 4980.427250866161, 4767.547083027107, 4910.747759321368, 4931.950680493185, 4963.6277279204205, 5037.4710655381205, 4880.219164933611, 4888.388951381077, 4892.951070489303, 4899.534544218312, 4966.056449274626, 4856.781444834991, 4899.608031357483, 4907.6073914086965, 4929.285253638238, 4938.827141050046, 4445.244308467568, 4501.122281155176, 4504.121696269229, 4505.617022553054, 4515.774211289455, 6005.279366476051, 6037.366076561985, 6039.4564489195745, 6107.4808641265545, 6111.816645500642, 5623.690697011662, 5627.746751396197, 5691.886162276731, 5711.200431939532, 5715.599678078897, 6509.28397876238, 6526.771562995273, 6540.710751237077, 6544.181977252843, 6557.5081868860025, 4905.460399356068, 4914.311996320518, 4928.310036594879, 4951.282064100686, 4956.2565615157655, 6858.251145957848, 6895.379415852597, 6898.793036208922, 6906.0, 6932.0, 4955.702657840469, 4964.652474326763, 4975.910117750554, 4982.526659967298, 4997.100521906019, 5013.348264725562, 5059.838964256438, 5084.745762711849, 5092.694438333712, 5097.235414687826, 5616.297962754656, 5664.150377443417, 5684.886302274014, 5689.829305120853, 5715.799947001835, 6239.625622462667, 6325.525585581007, 6520.543561950618, 6536.673166341664, 6552.475801935833, 1666.125284225767, 1693.8058668638826, 1727.5594723345466, 1740.443058221357, 1749.7550342951997, 1204.379744431601, 1212.1393810394543, 1220.9633710988685, 1243.7263801963554, 1255.7362953779625, 5687.374388817227, 5691.174779656926, 5714.828460165656, 5757.913631295534, 5777.544543568966, 6522.380373864476, 6575.145231120019, 6619.966900165468, 6700.396964273142, 6706.015822958737, 5665.5184309333345, 5667.234923285304, 5718.228039214736, 5781.19063331134, 5789.3921138279875, 3538.9469157962653, 3557.4130268505405, 3608.224231790178, 3614.204874927512, 3618.5838628557526, 6455.064015717695, 6561.967190164019, 6564.835879102965, 6566.409023187936, 6570.342965703391, 6686.866262674816, 6792.558483698544, 6878.8624227516175, 6896.0, 6913.965430172817, 6384.360914278909, 6404.583702059351, 6448.742050317935, 6454.612723236621, 6503.837404064841, 6578.605283682994, 6649.734010639714, 6703.631300278532, 6724.798256052326, 6727.596344219362, 6585.5719378240265, 6618.338166183343, 6668.399844014062, 6668.865962891828, 6675.933240667531, 6396.680165991775, 6420.143036348967, 6485.383888530582, 6504.447121994684, 6544.345565443417, 4993.5755460784785, 5015.3480047593575, 5025.39695236574, 5072.239164125411, 5073.8731531712, 6504.869902602016, 6675.332466753286, 6741.157355330583, 6745.325467453215, 6810.761623343159, 6279.529035322278, 6366.872662546631, 6432.517561183024, 6468.191476065492, 6471.967640161769, 6401.8399540010005, 6467.450266727193, 6490.513211509061, 6496.252930912817, 6505.60966342021, 6128.417800309142, 6361.045843123568, 6404.519661025349, 6431.260405053292, 6480.25477070143, 6412.839679008062, 6538.705758240795, 6552.901706474311, 6588.637624930675, 6606.669666516559, 6248.500119990299, 6329.208848893888, 6384.552341735411, 6396.616203027833, 6401.263854656588], "value": 5032.3172466852275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.3075331994362, 901.5086777706149, 922.3912217936163, 923.5705396990401, 929.419113054341, 16980.405685801, 18429.354972575962, 18582.163802628882, 18585.256589736393, 20544.691829622567, 20643.277485288017, 21059.68410473844, 21079.47301317468, 21311.25410610629, 21355.35933921985, 955.1546881010304, 991.8760154980628, 996.7856910764184, 1002.2282842211492, 1002.6240159940022, 965.5220665770454, 1064.0636240108693, 1071.8928107189258, 1075.070064394297, 1075.67192006438, 1113.8050841102774, 1113.8774734779167, 1114.186643750063, 1114.2534501883717, 1114.9442527873614, 1098.8132017557034, 1103.7020004598753, 1105.0441368216434, 1105.4417519152776, 1107.2858006585748, 805.2310043908112, 806.6128258435925, 807.8263173417744, 808.3290868579065, 808.5957021489255, 19340.0, 19450.513737156685, 19884.60230795376, 19912.70130948037, 20337.796622033737, 20566.69149962752, 20590.0, 20971.790282097136, 21124.894375528176, 21141.365759027252, 15084.24578771068, 15096.5471035868, 15206.391744330214, 15286.923565382212, 15289.159096249701, 3467.271872906693, 3497.0732755819727, 3498.247876706495, 3500.0, 3500.7899526028264, 123103.38448307701, 124486.37756811248, 125921.0, 126181.0, 126987.0, 15027.549173524812, 15116.470923517623, 15309.464168754263, 15356.385744570092, 15370.846291537166, 29762.255943601584, 30229.697703022688, 30694.693053069182, 30807.537886931714, 30858.0, 7993.560354180576, 8121.634526446324, 8141.063777665526, 8173.713920012771, 8177.591120443954, 4022.939655905164, 4074.694397920168, 4082.6733861291027, 4107.178564287155, 4127.711060225755, 5233.4243233244315, 5273.34083239595, 5349.812756553502, 5382.381026182039, 5396.91904621431, 934.6775362499926, 953.7997020625608, 967.2020583019038, 972.2805124208035, 976.838821594429, 672.1564436631995, 685.9588424694534, 688.4733179117978, 695.1484431571386, 703.057902410772, 11779.587714430125, 11782.528698852122, 11984.280943143265, 12611.243325400323, 13015.349232538336, 664.9700763465655, 675.3719041291646, 676.5196710335618, 677.1231255524108, 690.1304356510732, 4799.400074990626, 5548.5838562108, 5714.542836573064, 5757.65454072757, 5893.233879595625, 92179.0, 93433.0, 94654.0, 101724.49137754412, 102379.0, 87944.0, 90327.54836225777, 90617.54691226633, 90758.54620726986, 91431.54284228536, 72911.0, 79067.60466197632, 80011.0, 81175.59412203019, 82978.58510707528, 11703.180777345504, 11844.230125041844, 11967.700807479883, 12840.871591283967, 12915.870841291468, 36312.818435907655, 36904.07739806527, 37218.13909304578, 37395.42596283063, 38663.61336386712, 65260.67369663122, 67070.0, 67402.32597673961, 69201.0, 70369.29630703627, 17513.47459576215, 17893.284268629628, 17905.19426625831, 18496.167672454503, 18850.0, 20962.685559716312, 21044.0, 21298.148074076864, 21574.0, 21851.89074054683, 18341.816581834544, 18564.164612592194, 18887.90556047211, 19619.901900490408, 19810.90094549518, 18705.25178992825, 18759.155837987597, 19489.70765438548, 19577.70633440471, 19675.31136410219, 17930.91034544819, 18248.817511824713, 18495.63008739791, 18738.25046998105, 18918.054097295357, 13740.862591374358, 13788.862111378758, 13826.239556824472, 13949.651258718613, 14122.364493598017, 14062.156270623795, 14354.712905741619, 14419.279036048365, 14813.25933703289, 14983.775243371576], "value": 9063.957175530795, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 101.0, 107.0, 115.0, 109.0, 112.0, 100.0, 108.0, 106.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 152.0, 180.0, 126.0, 151.0, 149.0, 118.0, 165.0, 125.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 163.0, 161.0, 165.0, 163.0, 168.0, 172.0, 168.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 181.0, 76.0, 84.0, 74.0, 91.0, 98.0, 75.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 132.0, 78.0, 79.0, 79.0, 125.0, 80.0, 78.0, 132.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 151.0, 150.0, 149.0, 152.0, 151.0, 152.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 58.0, 54.0, 53.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 80.0, 88.0, 79.0, 77.0, 76.0, 77.0, 79.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 132.0, 142.0, 137.0, 122.0, 128.0, 126.0, 149.0, 173.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 186.0, 179.0, 178.0, 186.0, 173.0, 174.0, 175.0, 184.0, 173.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 75.0, 65.0, 66.0, 68.0, 64.0, 67.0, 67.0], "value": 67.4, "unit": "score"}]}]} 03:22:21 INFO - Return code: 0 03:22:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:21 INFO - # TBPL SUCCESS # 03:22:21 INFO - Running post-action listener: _package_coverage_data 03:22:21 INFO - Running post-action listener: _resource_record_post_action 03:22:21 INFO - [mozharness: 2017-08-02 10:22:21.528679Z] Finished run-tests step (success) 03:22:21 INFO - Running post-run listener: _resource_record_post_run 03:22:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431357952; Read time: 16; Write time: 405760 03:22:21 INFO - TinderboxPrint: CPU usage
13.1% 03:22:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:22:21 INFO - TinderboxPrint: I/O write bytes / time
431,357,952 / 405,760 03:22:21 INFO - TinderboxPrint: CPU idle
8,260.4 (86.8%) 03:22:21 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 03:22:21 INFO - TinderboxPrint: Swap in / out
0 / 0 03:22:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106782720; Read time: 0; Write time: 92728 03:22:21 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:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 321138688; Read time: 0; Write time: 312368 03:22:22 INFO - Running post-run listener: _upload_blobber_files 03:22:22 INFO - Blob upload gear active. 03:22:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:22 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:22 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:22:22 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:22:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:23 INFO - (blobuploader) - INFO - Done attempting. 03:22:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:22:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:30 INFO - (blobuploader) - INFO - Done attempting. 03:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:31 INFO - (blobuploader) - INFO - Done attempting. 03:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:31 INFO - (blobuploader) - INFO - Done attempting. 03:22:31 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:31 INFO - Return code: 0 03:22:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d78bd429f91f62a3d0e45f217c08e290cf1a843754b8a13ec6570015cc8532e3adc3f0951e76c1ff0f115047b086aa3b7169371ebab6d31aef5bb87cd7384a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55237854d2ea44e92b5feb712e89e546850d67c61284788390fa651b8d5de58f1dc9e4822af19d848e09758f836255d2c2d42d4b1f0bfaf51a3c6c567fe051a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/663e5c53f88b6a23b437bde260424a8673c8e438f44fb0e6873ce738df26dc8eb14882cbc91ddb6045ddddc4849cef4d53521ec7ab9762eedc6b85f738aa972b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/605e328e08ff6507a7e9421613ea8e3c1a0157ed09a0b13fb0da4c9b764bb374a747ec4a94c4c5f480ea600d7f3249a7b1a0ed1e2932d66489b393601b38149b"} 03:22:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:31 INFO - Contents: 03:22:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d78bd429f91f62a3d0e45f217c08e290cf1a843754b8a13ec6570015cc8532e3adc3f0951e76c1ff0f115047b086aa3b7169371ebab6d31aef5bb87cd7384a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55237854d2ea44e92b5feb712e89e546850d67c61284788390fa651b8d5de58f1dc9e4822af19d848e09758f836255d2c2d42d4b1f0bfaf51a3c6c567fe051a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/663e5c53f88b6a23b437bde260424a8673c8e438f44fb0e6873ce738df26dc8eb14882cbc91ddb6045ddddc4849cef4d53521ec7ab9762eedc6b85f738aa972b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/605e328e08ff6507a7e9421613ea8e3c1a0157ed09a0b13fb0da4c9b764bb374a747ec4a94c4c5f480ea600d7f3249a7b1a0ed1e2932d66489b393601b38149b"} 03:22:31 INFO - Running post-run listener: copy_logs_to_upload_dir 03:22:31 INFO - Copying logs to upload dir... 03:22:31 INFO - mkdir: /builds/slave/test/build/upload/logs 03:22:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.844186 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-02 03:22:31.058322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:31.062353) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 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-Non-PGO/sha512/d78bd429f91f62a3d0e45f217c08e290cf1a843754b8a13ec6570015cc8532e3adc3f0951e76c1ff0f115047b086aa3b7169371ebab6d31aef5bb87cd7384a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55237854d2ea44e92b5feb712e89e546850d67c61284788390fa651b8d5de58f1dc9e4822af19d848e09758f836255d2c2d42d4b1f0bfaf51a3c6c567fe051a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/663e5c53f88b6a23b437bde260424a8673c8e438f44fb0e6873ce738df26dc8eb14882cbc91ddb6045ddddc4849cef4d53521ec7ab9762eedc6b85f738aa972b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/605e328e08ff6507a7e9421613ea8e3c1a0157ed09a0b13fb0da4c9b764bb374a747ec4a94c4c5f480ea600d7f3249a7b1a0ed1e2932d66489b393601b38149b"} build_url:https://queue.taskcluster.net/v1/task/WPqz2tNLSqS-HHWkbIu55g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 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-Non-PGO/sha512/d78bd429f91f62a3d0e45f217c08e290cf1a843754b8a13ec6570015cc8532e3adc3f0951e76c1ff0f115047b086aa3b7169371ebab6d31aef5bb87cd7384a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55237854d2ea44e92b5feb712e89e546850d67c61284788390fa651b8d5de58f1dc9e4822af19d848e09758f836255d2c2d42d4b1f0bfaf51a3c6c567fe051a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/663e5c53f88b6a23b437bde260424a8673c8e438f44fb0e6873ce738df26dc8eb14882cbc91ddb6045ddddc4849cef4d53521ec7ab9762eedc6b85f738aa972b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/605e328e08ff6507a7e9421613ea8e3c1a0157ed09a0b13fb0da4c9b764bb374a747ec4a94c4c5f480ea600d7f3249a7b1a0ed1e2932d66489b393601b38149b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:31.086544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:31.090887) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501659329.977719-1592369520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 03:22:31.169770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 03:22:31.174105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 03:22:31.174425) ========= ========= Total master_lag: 0.22 =========