builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1501280063.59 results: success (0) revision: e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.589867) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.590318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.590622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.606605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.606870) ========= 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=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 15:14:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-28 15:14:23 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.775651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.775997) ========= 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=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014241 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:23.827029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-28 15:14:23.827453) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 --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 e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 --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=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 15:14:23,924 truncating revision to first 12 chars 2017-07-28 15:14:23,924 Setting DEBUG logging. 2017-07-28 15:14:23,924 attempt 1/10 2017-07-28 15:14:23,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e91b2c85aacd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 15:14:25,282 unpacking tar archive at: mozilla-central-e91b2c85aacd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-28 15:14:25.518135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:25.518415) ========= script_repo_revision: e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:25.518777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:25.519067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 15:14:25.526084) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-28 15:14:25.526364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:25 INFO - MultiFileLogger online at 20170728 15:14:25 in /builds/slave/test 15:14:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:14:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:25 INFO - {'append_to_log': False, 15:14:25 INFO - 'base_work_dir': '/builds/slave/test', 15:14:25 INFO - 'blob_upload_branch': 'Firefox', 15:14:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:25 INFO - 'branch': 'Firefox', 15:14:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:25 INFO - 'code_coverage': False, 15:14:25 INFO - 'config_files': ('talos/linux_config.py',), 15:14:25 INFO - 'default_actions': ('clobber', 15:14:25 INFO - 'read-buildbot-config', 15:14:25 INFO - 'download-and-extract', 15:14:25 INFO - 'populate-webroot', 15:14:25 INFO - 'create-virtualenv', 15:14:25 INFO - 'install', 15:14:25 INFO - 'setup-mitmproxy', 15:14:25 INFO - 'run-tests'), 15:14:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:25 INFO - 'disable_ccov_upload': False, 15:14:25 INFO - 'download_minidump_stackwalk': True, 15:14:25 INFO - 'download_symbols': 'ondemand', 15:14:25 INFO - 'enable_stylo': False, 15:14:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:25 INFO - 'gecko_profile': False, 15:14:25 INFO - 'gecko_profile_interval': 0, 15:14:25 INFO - 'installer_path': 'installer.exe', 15:14:25 INFO - 'log_level': 'info', 15:14:25 INFO - 'log_name': 'talos', 15:14:25 INFO - 'log_to_console': True, 15:14:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:25 INFO - 'opt_config_files': (), 15:14:25 INFO - 'pip_index': False, 15:14:25 INFO - 'suite': 'dromaeojs-e10s', 15:14:25 INFO - 'system_bits': '32', 15:14:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:25 INFO - 'title': 'talos-linux64-ix-045', 15:14:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:25 INFO - 'use_talos_json': True, 15:14:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:25 INFO - 'work_dir': 'build'} 15:14:25 INFO - [mozharness: 2017-07-28 22:14:25.727029Z] Running clobber step. 15:14:25 INFO - Running pre-action listener: _resource_record_pre_action 15:14:25 INFO - Running main action method: clobber 15:14:25 INFO - rmtree: /builds/slave/test/build 15:14:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:26 INFO - Running post-action listener: _resource_record_post_action 15:14:26 INFO - [mozharness: 2017-07-28 22:14:26.745546Z] Finished clobber step (success) 15:14:26 INFO - [mozharness: 2017-07-28 22:14:26.745648Z] Running read-buildbot-config step. 15:14:26 INFO - Running pre-action listener: _resource_record_pre_action 15:14:26 INFO - Running main action method: read_buildbot_config 15:14:26 INFO - Using buildbot properties: 15:14:26 INFO - { 15:14:26 INFO - "project": "", 15:14:26 INFO - "product": "firefox", 15:14:26 INFO - "who": "kwierso@gmail.com", 15:14:26 INFO - "installer_path": "public/build/target.tar.bz2", 15:14:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:14:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:14:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:14:26 INFO - "stage_platform": "linux64-stylo", 15:14:26 INFO - "basedir": "/builds/slave/test", 15:14:26 INFO - "buildnumber": 244, 15:14:26 INFO - "platform": "ubuntu64_hw_stylo", 15:14:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:14:26 INFO - "slavebuilddir": "test", 15:14:26 INFO - "taskId": "ZPCfglbaQWeamB43Peg6MQ", 15:14:26 INFO - "branch": "mozilla-central", 15:14:26 INFO - "script_repo_revision": "production", 15:14:26 INFO - "revision": "e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2", 15:14:26 INFO - "slavename": "talos-linux64-ix-045", 15:14:26 INFO - "repo_path": "mozilla-central" 15:14:26 INFO - } 15:14:26 INFO - Finding installer, test and symbols from parent task. 15:14:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPCfglbaQWeamB43Peg6MQ'}, attempt #1 15:14:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPCfglbaQWeamB43Peg6MQ'}, attempt #1 15:14:27 INFO - Task dependencies: OPaDeIT_QLCjtpwAEkMAGw 15:14:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw'}, attempt #1 15:14:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 15:14:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/test_packages.json 15:14:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.crashreporter-symbols.zip 15:14:28 INFO - Running post-action listener: _resource_record_post_action 15:14:28 INFO - [mozharness: 2017-07-28 22:14:28.194576Z] Finished read-buildbot-config step (success) 15:14:28 INFO - [mozharness: 2017-07-28 22:14:28.194797Z] Running download-and-extract step. 15:14:28 INFO - Running pre-action listener: _resource_record_pre_action 15:14:28 INFO - Running main action method: download_and_extract 15:14:28 INFO - mkdir: /builds/slave/test/build/tests 15:14:28 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')]} 15:14:28 INFO - trying https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.test_packages.json 15:14:28 INFO - Downloading https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:14:28 INFO - Downloaded 989 bytes. 15:14:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:14:28 INFO - Using the following test package requirements: 15:14:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:14:28 INFO - u'common': [u'target.common.tests.zip'], 15:14:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:14:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:14:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:14:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:14:28 INFO - u'mozbase': [u'target.common.tests.zip'], 15:14:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:14:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:14:28 INFO - u'web-platform': [u'target.common.tests.zip', 15:14:28 INFO - u'target.web-platform.tests.tar.gz'], 15:14:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:14:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:14:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip 15:14:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:14:28 INFO - Fetch https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip into memory 15:14:33 INFO - Content-Length response header: 72564844 15:14:33 INFO - Bytes received: 72564844 15:14:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:14:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip 15:14:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:14:44 INFO - Fetch https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.common.tests.zip into memory 15:14:46 INFO - Content-Length response header: 72564844 15:14:46 INFO - Bytes received: 72564844 15:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.talos.tests.zip 15:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.talos.tests.zip into memory 15:15:00 INFO - Content-Length response header: 14496686 15:15:00 INFO - Bytes received: 14496686 15:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:01 INFO - trying https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 15:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:15:02 INFO - Downloaded 62174935 bytes. 15:15:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 15:15:02 INFO - mkdir: /builds/slave/test/properties 15:15:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:02 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:02 INFO - Contents: 15:15:02 INFO - build_url:https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 15:15:02 INFO - Running post-action listener: _resource_record_post_action 15:15:02 INFO - Running post-action listener: set_extra_try_arguments 15:15:02 INFO - [mozharness: 2017-07-28 22:15:02.346536Z] Finished download-and-extract step (success) 15:15:02 INFO - [mozharness: 2017-07-28 22:15:02.346633Z] Running populate-webroot step. 15:15:02 INFO - Running pre-action listener: _resource_record_pre_action 15:15:02 INFO - Running main action method: populate_webroot 15:15:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:15:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:15:02 INFO - 'tests': ['damp', 'tps']}, 15:15:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:15:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:15:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:15:02 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:02 INFO - 'ts_paint', 15:15:02 INFO - 'tpaint', 15:15:02 INFO - 'sessionrestore', 15:15:02 INFO - 'sessionrestore_many_windows', 15:15:02 INFO - 'sessionrestore_no_auto_restore', 15:15:02 INFO - 'tabpaint']}, 15:15:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:15:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:15:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:02 INFO - 'talos_options': ['--mitmproxy', 15:15:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:02 INFO - '--firstNonBlankPaint'], 15:15:02 INFO - 'tests': ['quantum_pageload_google', 15:15:02 INFO - 'quantum_pageload_youtube', 15:15:02 INFO - 'quantum_pageload_amazon', 15:15:02 INFO - 'quantum_pageload_facebook']}, 15:15:02 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:02 INFO - 'talos_options': ['--stylo', 15:15:02 INFO - '--mitmproxy', 15:15:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:02 INFO - '--firstNonBlankPaint'], 15:15:02 INFO - 'tests': ['quantum_pageload_google', 15:15:02 INFO - 'quantum_pageload_youtube', 15:15:02 INFO - 'quantum_pageload_amazon', 15:15:02 INFO - 'quantum_pageload_facebook']}, 15:15:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:02 INFO - 'tsvgr_opacity', 15:15:02 INFO - 'tart', 15:15:02 INFO - 'tscrollx', 15:15:02 INFO - 'cart', 15:15:02 INFO - 'tsvg_static']}, 15:15:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:15:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:02 INFO - 'talos_options': ['--stylo', 15:15:02 INFO - '--stylo-threads=1', 15:15:02 INFO - '--mitmproxy', 15:15:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:02 INFO - '--firstNonBlankPaint'], 15:15:02 INFO - 'tests': ['tp6_google', 15:15:02 INFO - 'tp6_youtube', 15:15:02 INFO - 'tp6_amazon', 15:15:02 INFO - 'tp6_facebook']}, 15:15:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:15:02 INFO - 'talos_options': ['--xperf_path', 15:15:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:02 INFO - 'tests': ['tp5n']}}} 15:15:02 INFO - Running post-action listener: _resource_record_post_action 15:15:02 INFO - [mozharness: 2017-07-28 22:15:02.355206Z] Finished populate-webroot step (success) 15:15:02 INFO - [mozharness: 2017-07-28 22:15:02.355296Z] Running create-virtualenv step. 15:15:02 INFO - Running pre-action listener: _resource_record_pre_action 15:15:02 INFO - Running main action method: create_virtualenv 15:15:02 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:02 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 15:15:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:15:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:02 INFO - Using real prefix '/usr' 15:15:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:04 INFO - Installing pip.................done. 15:15:04 INFO - Return code: 0 15:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:15:05 INFO - Reading from file tmpfile_stdout 15:15:05 INFO - Output received: 15:15:05 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) 15:15:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:05 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:05 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 15:15:05 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 15:15:05 INFO - Using env: {'DISPLAY': ':0', 15:15:05 INFO - 'HOME': '/home/cltbld', 15:15:05 INFO - 'LANG': 'en_US.UTF-8', 15:15:05 INFO - 'LANGUAGE': 'en_US:en', 15:15:05 INFO - 'LOGNAME': 'cltbld', 15:15:05 INFO - 'MAIL': '/var/mail/cltbld', 15:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:05 INFO - 'MOZ_NO_REMOTE': '1', 15:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:05 INFO - 'NO_EM_RESTART': '1', 15:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:05 INFO - 'PWD': '/builds/slave/test', 15:15:05 INFO - 'SHELL': '/bin/bash', 15:15:05 INFO - 'SHLVL': '1', 15:15:05 INFO - 'TERM': 'linux', 15:15:05 INFO - 'TMOUT': '86400', 15:15:05 INFO - 'USER': 'cltbld', 15:15:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:05 INFO - '_': '/tools/buildbot/bin/python'} 15:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:05 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 15:15:05 INFO - Cleaning up... 15:15:05 INFO - Return code: 0 15:15:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:05 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:05 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 15:15:05 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 15:15:05 INFO - Using env: {'DISPLAY': ':0', 15:15:05 INFO - 'HOME': '/home/cltbld', 15:15:05 INFO - 'LANG': 'en_US.UTF-8', 15:15:05 INFO - 'LANGUAGE': 'en_US:en', 15:15:05 INFO - 'LOGNAME': 'cltbld', 15:15:05 INFO - 'MAIL': '/var/mail/cltbld', 15:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:05 INFO - 'MOZ_NO_REMOTE': '1', 15:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:05 INFO - 'NO_EM_RESTART': '1', 15:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:05 INFO - 'PWD': '/builds/slave/test', 15:15:05 INFO - 'SHELL': '/bin/bash', 15:15:05 INFO - 'SHLVL': '1', 15:15:05 INFO - 'TERM': 'linux', 15:15:05 INFO - 'TMOUT': '86400', 15:15:05 INFO - 'USER': 'cltbld', 15:15:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:05 INFO - '_': '/tools/buildbot/bin/python'} 15:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:05 INFO - Downloading/unpacking psutil>=3.1.1 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:06 INFO - Installing collected packages: psutil 15:15:06 INFO - Running setup.py install for psutil 15:15:06 INFO - building 'psutil._psutil_linux' extension 15:15:06 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 15:15:06 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 15:15:07 INFO - building 'psutil._psutil_posix' extension 15:15:07 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 15:15:07 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 15:15:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:07 INFO - Successfully installed psutil 15:15:07 INFO - Cleaning up... 15:15:07 INFO - Return code: 0 15:15:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:15:07 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')]} 15:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:07 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')]} 15:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:07 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:07 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 15:15:07 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 15:15:07 INFO - Using env: {'DISPLAY': ':0', 15:15:07 INFO - 'HOME': '/home/cltbld', 15:15:07 INFO - 'LANG': 'en_US.UTF-8', 15:15:07 INFO - 'LANGUAGE': 'en_US:en', 15:15:07 INFO - 'LOGNAME': 'cltbld', 15:15:07 INFO - 'MAIL': '/var/mail/cltbld', 15:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:07 INFO - 'MOZ_NO_REMOTE': '1', 15:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:07 INFO - 'NO_EM_RESTART': '1', 15:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:07 INFO - 'PWD': '/builds/slave/test', 15:15:07 INFO - 'SHELL': '/bin/bash', 15:15:07 INFO - 'SHLVL': '1', 15:15:07 INFO - 'TERM': 'linux', 15:15:07 INFO - 'TMOUT': '86400', 15:15:07 INFO - 'USER': 'cltbld', 15:15:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:07 INFO - '_': '/tools/buildbot/bin/python'} 15:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:15:08 INFO - Installing collected packages: mozsystemmonitor 15:15:08 INFO - Running setup.py install for mozsystemmonitor 15:15:08 INFO - Successfully installed mozsystemmonitor 15:15:08 INFO - Cleaning up... 15:15:08 INFO - Return code: 0 15:15:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:15:08 INFO - Using env: {'DISPLAY': ':0', 15:15:08 INFO - 'HOME': '/home/cltbld', 15:15:08 INFO - 'LANG': 'en_US.UTF-8', 15:15:08 INFO - 'LANGUAGE': 'en_US:en', 15:15:08 INFO - 'LOGNAME': 'cltbld', 15:15:08 INFO - 'MAIL': '/var/mail/cltbld', 15:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:08 INFO - 'MOZ_NO_REMOTE': '1', 15:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:08 INFO - 'NO_EM_RESTART': '1', 15:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:08 INFO - 'PWD': '/builds/slave/test', 15:15:08 INFO - 'SHELL': '/bin/bash', 15:15:08 INFO - 'SHLVL': '1', 15:15:08 INFO - 'TERM': 'linux', 15:15:08 INFO - 'TMOUT': '86400', 15:15:08 INFO - 'USER': 'cltbld', 15:15:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:08 INFO - '_': '/tools/buildbot/bin/python'} 15:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:15:08 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 15:15:08 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 15:15:08 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 15:15:08 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 15:15:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:10 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:10 INFO - warning: no files found matching '*.txt' 15:15:10 INFO - no previously-included directories found matching 'build' 15:15:10 INFO - no previously-included directories found matching 'dist' 15:15:10 INFO - no previously-included directories found matching '.git*' 15:15:10 INFO - Installing collected packages: jsonschema, functools32 15:15:10 INFO - Running setup.py install for functools32 15:15:10 INFO - warning: no files found matching '*.txt' 15:15:10 INFO - no previously-included directories found matching 'build' 15:15:10 INFO - no previously-included directories found matching 'dist' 15:15:10 INFO - no previously-included directories found matching '.git*' 15:15:10 INFO - Successfully installed jsonschema functools32 15:15:10 INFO - Cleaning up... 15:15:10 INFO - Return code: 0 15:15:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:15:10 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')]} 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:10 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')]} 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:10 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:10 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 15:15:10 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 15:15:10 INFO - Using env: {'DISPLAY': ':0', 15:15:10 INFO - 'HOME': '/home/cltbld', 15:15:10 INFO - 'LANG': 'en_US.UTF-8', 15:15:10 INFO - 'LANGUAGE': 'en_US:en', 15:15:10 INFO - 'LOGNAME': 'cltbld', 15:15:10 INFO - 'MAIL': '/var/mail/cltbld', 15:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:10 INFO - 'MOZ_NO_REMOTE': '1', 15:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:10 INFO - 'NO_EM_RESTART': '1', 15:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:10 INFO - 'PWD': '/builds/slave/test', 15:15:10 INFO - 'SHELL': '/bin/bash', 15:15:10 INFO - 'SHLVL': '1', 15:15:10 INFO - 'TERM': 'linux', 15:15:10 INFO - 'TMOUT': '86400', 15:15:10 INFO - 'USER': 'cltbld', 15:15:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:10 INFO - '_': '/tools/buildbot/bin/python'} 15:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:15:10 INFO - Cleaning up... 15:15:10 INFO - Return code: 0 15:15:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:10 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')]} 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:10 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')]} 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:10 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:10 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 15:15:10 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 15:15:10 INFO - Using env: {'DISPLAY': ':0', 15:15:10 INFO - 'HOME': '/home/cltbld', 15:15:10 INFO - 'LANG': 'en_US.UTF-8', 15:15:10 INFO - 'LANGUAGE': 'en_US:en', 15:15:10 INFO - 'LOGNAME': 'cltbld', 15:15:10 INFO - 'MAIL': '/var/mail/cltbld', 15:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:10 INFO - 'MOZ_NO_REMOTE': '1', 15:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:10 INFO - 'NO_EM_RESTART': '1', 15:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:10 INFO - 'PWD': '/builds/slave/test', 15:15:10 INFO - 'SHELL': '/bin/bash', 15:15:10 INFO - 'SHLVL': '1', 15:15:10 INFO - 'TERM': 'linux', 15:15:10 INFO - 'TMOUT': '86400', 15:15:10 INFO - 'USER': 'cltbld', 15:15:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:10 INFO - '_': '/tools/buildbot/bin/python'} 15:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - Downloading docopt-0.6.1.tar.gz 15:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:12 INFO - Running setup.py install for blobuploader 15:15:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:12 INFO - Running setup.py install for requests 15:15:13 INFO - Running setup.py install for docopt 15:15:13 INFO - Successfully installed blobuploader requests docopt 15:15:13 INFO - Cleaning up... 15:15:13 INFO - Return code: 0 15:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:13 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:13 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 15:15:13 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 15:15:13 INFO - Using env: {'DISPLAY': ':0', 15:15:13 INFO - 'HOME': '/home/cltbld', 15:15:13 INFO - 'LANG': 'en_US.UTF-8', 15:15:13 INFO - 'LANGUAGE': 'en_US:en', 15:15:13 INFO - 'LOGNAME': 'cltbld', 15:15:13 INFO - 'MAIL': '/var/mail/cltbld', 15:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:13 INFO - 'MOZ_NO_REMOTE': '1', 15:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:13 INFO - 'NO_EM_RESTART': '1', 15:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:13 INFO - 'PWD': '/builds/slave/test', 15:15:13 INFO - 'SHELL': '/bin/bash', 15:15:13 INFO - 'SHLVL': '1', 15:15:13 INFO - 'TERM': 'linux', 15:15:13 INFO - 'TMOUT': '86400', 15:15:13 INFO - 'USER': 'cltbld', 15:15:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:13 INFO - '_': '/tools/buildbot/bin/python'} 15:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:13 INFO - Running setup.py (path:/tmp/pip-AcOi40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:13 INFO - Running setup.py (path:/tmp/pip-CqFjly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:13 INFO - Running setup.py (path:/tmp/pip-bVbYUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:13 INFO - Running setup.py (path:/tmp/pip-IhCkpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:13 INFO - Running setup.py (path:/tmp/pip-AzFFBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:13 INFO - Running setup.py (path:/tmp/pip-EEbVzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:13 INFO - Running setup.py (path:/tmp/pip-SpkrtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:13 INFO - Running setup.py (path:/tmp/pip-Nhg_Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:13 INFO - Running setup.py (path:/tmp/pip-QZZ6UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:14 INFO - Running setup.py (path:/tmp/pip-g5A1zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:14 INFO - Running setup.py (path:/tmp/pip-0mopae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:14 INFO - Running setup.py (path:/tmp/pip-ORaOgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:14 INFO - Running setup.py (path:/tmp/pip-g7mQLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:14 INFO - Running setup.py (path:/tmp/pip-kM91x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:14 INFO - Running setup.py (path:/tmp/pip-vD5Mj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:14 INFO - Running setup.py (path:/tmp/pip-2wv2n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:14 INFO - Running setup.py (path:/tmp/pip-NNAqPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:14 INFO - Running setup.py install for manifestparser 15:15:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:14 INFO - Running setup.py install for mozcrash 15:15:14 INFO - Running setup.py install for mozdebug 15:15:14 INFO - Running setup.py install for mozdevice 15:15:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozfile 15:15:15 INFO - Running setup.py install for mozhttpd 15:15:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozinfo 15:15:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozInstall 15:15:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozleak 15:15:15 INFO - Running setup.py install for mozlog 15:15:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for moznetwork 15:15:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozprocess 15:15:15 INFO - Running setup.py install for mozprofile 15:15:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:15 INFO - Running setup.py install for mozrunner 15:15:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:16 INFO - Running setup.py install for mozscreenshot 15:15:16 INFO - Running setup.py install for moztest 15:15:16 INFO - Running setup.py install for mozversion 15:15:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:16 INFO - Cleaning up... 15:15:16 INFO - Return code: 0 15:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:16 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:16 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 15:15:16 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 15:15:16 INFO - Using env: {'DISPLAY': ':0', 15:15:16 INFO - 'HOME': '/home/cltbld', 15:15:16 INFO - 'LANG': 'en_US.UTF-8', 15:15:16 INFO - 'LANGUAGE': 'en_US:en', 15:15:16 INFO - 'LOGNAME': 'cltbld', 15:15:16 INFO - 'MAIL': '/var/mail/cltbld', 15:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:16 INFO - 'MOZ_NO_REMOTE': '1', 15:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:16 INFO - 'NO_EM_RESTART': '1', 15:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:16 INFO - 'PWD': '/builds/slave/test', 15:15:16 INFO - 'SHELL': '/bin/bash', 15:15:16 INFO - 'SHLVL': '1', 15:15:16 INFO - 'TERM': 'linux', 15:15:16 INFO - 'TMOUT': '86400', 15:15:16 INFO - 'USER': 'cltbld', 15:15:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:16 INFO - '_': '/tools/buildbot/bin/python'} 15:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:16 INFO - Running setup.py (path:/tmp/pip-60VwB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:16 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)) 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:16 INFO - Running setup.py (path:/tmp/pip-h_5vyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:16 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)) 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:16 INFO - Running setup.py (path:/tmp/pip-GHkM6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:16 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)) 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:16 INFO - Running setup.py (path:/tmp/pip-Jrw3sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:16 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)) 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:16 INFO - Running setup.py (path:/tmp/pip-kVfGrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:16 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)) 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:16 INFO - Running setup.py (path:/tmp/pip-PFeidV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:17 INFO - Running setup.py (path:/tmp/pip-C5n4aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:17 INFO - Running setup.py (path:/tmp/pip-fprj5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:17 INFO - Running setup.py (path:/tmp/pip-AZL3SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:17 INFO - Running setup.py (path:/tmp/pip-GPrlQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:17 INFO - Running setup.py (path:/tmp/pip-th0WrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:17 INFO - Running setup.py (path:/tmp/pip-GUTflu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:17 INFO - Running setup.py (path:/tmp/pip-A5A7XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:17 INFO - Running setup.py (path:/tmp/pip-u1Gmt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:17 INFO - Running setup.py (path:/tmp/pip-gG1dvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:17 INFO - Running setup.py (path:/tmp/pip-BfOkSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:17 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)) 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:17 INFO - Running setup.py (path:/tmp/pip-OaVgaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:17 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)) 15:15:17 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)) 15:15:17 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)) 15:15:17 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)) 15:15:17 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)) 15:15:17 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)) 15:15:17 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)) 15:15:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:18 INFO - Downloading blessings-1.6.tar.gz 15:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:19 INFO - Installing collected packages: blessings 15:15:19 INFO - Running setup.py install for blessings 15:15:19 INFO - Successfully installed blessings 15:15:19 INFO - Cleaning up... 15:15:19 INFO - Return code: 0 15:15:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:19 INFO - Reading from file tmpfile_stdout 15:15:19 INFO - Current package versions: 15:15:19 INFO - argparse == 1.2.1 15:15:19 INFO - blessings == 1.6 15:15:19 INFO - blobuploader == 1.2.4 15:15:19 INFO - docopt == 0.6.1 15:15:19 INFO - functools32 == 3.2.3-2 15:15:19 INFO - jsonschema == 2.5.1 15:15:19 INFO - manifestparser == 1.1 15:15:19 INFO - mozInstall == 1.13 15:15:19 INFO - mozcrash == 1.0 15:15:19 INFO - mozdebug == 0.1 15:15:19 INFO - mozdevice == 0.51 15:15:19 INFO - mozfile == 1.2 15:15:19 INFO - mozhttpd == 0.7 15:15:19 INFO - mozinfo == 0.10 15:15:19 INFO - mozleak == 0.1 15:15:19 INFO - mozlog == 3.5 15:15:19 INFO - moznetwork == 0.27 15:15:19 INFO - mozprocess == 0.25 15:15:19 INFO - mozprofile == 0.28 15:15:19 INFO - mozrunner == 6.13 15:15:19 INFO - mozscreenshot == 0.1 15:15:19 INFO - mozsystemmonitor == 0.3 15:15:19 INFO - moztest == 0.8 15:15:19 INFO - mozversion == 1.4 15:15:19 INFO - psutil == 3.1.1 15:15:19 INFO - requests == 1.2.3 15:15:19 INFO - wsgiref == 0.1.2 15:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:19 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:19 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 15:15:19 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 15:15:19 INFO - Using env: {'DISPLAY': ':0', 15:15:19 INFO - 'HOME': '/home/cltbld', 15:15:19 INFO - 'LANG': 'en_US.UTF-8', 15:15:19 INFO - 'LANGUAGE': 'en_US:en', 15:15:19 INFO - 'LOGNAME': 'cltbld', 15:15:19 INFO - 'MAIL': '/var/mail/cltbld', 15:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:19 INFO - 'MOZ_NO_REMOTE': '1', 15:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:19 INFO - 'NO_EM_RESTART': '1', 15:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:19 INFO - 'PWD': '/builds/slave/test', 15:15:19 INFO - 'SHELL': '/bin/bash', 15:15:19 INFO - 'SHLVL': '1', 15:15:19 INFO - 'TERM': 'linux', 15:15:19 INFO - 'TMOUT': '86400', 15:15:19 INFO - 'USER': 'cltbld', 15:15:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:19 INFO - '_': '/tools/buildbot/bin/python'} 15:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 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)) 15:15:19 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:15:19 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 15:15:19 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 15:15:19 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 15:15:19 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 15:15:20 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:15:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:15:20 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 15:15:20 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 15:15:20 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 15:15:20 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 15:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:15:20 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)) 15:15:20 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)) 15:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:15:20 INFO - Installing collected packages: marionette-driver, simplejson 15:15:20 INFO - Running setup.py install for marionette-driver 15:15:21 INFO - Running setup.py install for simplejson 15:15:21 INFO - building 'simplejson._speedups' extension 15:15:21 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 15:15:22 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 15:15:22 INFO - Successfully installed marionette-driver simplejson 15:15:22 INFO - Cleaning up... 15:15:22 INFO - Return code: 0 15:15:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:22 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 0x20271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2396d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, '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': '4300f881736b422476174874000001bc-1501272933.887005-909370870', '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 15:15:22 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 15:15:22 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 15:15:22 INFO - Using env: {'DISPLAY': ':0', 15:15:22 INFO - 'HOME': '/home/cltbld', 15:15:22 INFO - 'LANG': 'en_US.UTF-8', 15:15:22 INFO - 'LANGUAGE': 'en_US:en', 15:15:22 INFO - 'LOGNAME': 'cltbld', 15:15:22 INFO - 'MAIL': '/var/mail/cltbld', 15:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:22 INFO - 'MOZ_NO_REMOTE': '1', 15:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:22 INFO - 'NO_EM_RESTART': '1', 15:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:22 INFO - 'PWD': '/builds/slave/test', 15:15:22 INFO - 'SHELL': '/bin/bash', 15:15:22 INFO - 'SHLVL': '1', 15:15:22 INFO - 'TERM': 'linux', 15:15:22 INFO - 'TMOUT': '86400', 15:15:22 INFO - 'USER': 'cltbld', 15:15:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:22 INFO - '_': '/tools/buildbot/bin/python'} 15:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:15:22 INFO - Cleaning up... 15:15:22 INFO - Return code: 0 15:15:22 INFO - Running post-action listener: _resource_record_post_action 15:15:22 INFO - Running post-action listener: _start_resource_monitoring 15:15:22 INFO - Starting resource monitoring. 15:15:22 INFO - [mozharness: 2017-07-28 22:15:22.428553Z] Finished create-virtualenv step (success) 15:15:22 INFO - [mozharness: 2017-07-28 22:15:22.429068Z] Running install step. 15:15:22 INFO - Running pre-action listener: _resource_record_pre_action 15:15:22 INFO - Running main action method: install 15:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:22 INFO - Reading from file tmpfile_stdout 15:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:22 INFO - Reading from file tmpfile_stdout 15:15:22 INFO - Output received: 15:15:22 INFO - Usage: mozinstall [options] installer 15:15:22 INFO - Options: 15:15:22 INFO - -h, --help show this help message and exit 15:15:22 INFO - -d DEST, --destination=DEST 15:15:22 INFO - Directory to install application into. [default: 15:15:22 INFO - "/builds/slave/test"] 15:15:22 INFO - --app=APP Application being installed. [default: firefox] 15:15:22 INFO - mkdir: /builds/slave/test/build/application 15:15:22 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'] 15:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:15:40 INFO - Reading from file tmpfile_stdout 15:15:40 INFO - Output received: 15:15:40 INFO - /builds/slave/test/build/application/firefox/firefox 15:15:40 INFO - Running post-action listener: _resource_record_post_action 15:15:40 INFO - [mozharness: 2017-07-28 22:15:40.791755Z] Finished install step (success) 15:15:40 INFO - [mozharness: 2017-07-28 22:15:40.791902Z] Running setup-mitmproxy step. 15:15:40 INFO - Running pre-action listener: _resource_record_pre_action 15:15:40 INFO - Running main action method: setup_mitmproxy 15:15:40 INFO - Skipping: mitmproxy is not required 15:15:40 INFO - Running post-action listener: _resource_record_post_action 15:15:40 INFO - [mozharness: 2017-07-28 22:15:40.792426Z] Finished setup-mitmproxy step (success) 15:15:40 INFO - [mozharness: 2017-07-28 22:15:40.792528Z] Running run-tests step. 15:15:40 INFO - Running pre-action listener: _resource_record_pre_action 15:15:40 INFO - Running pre-action listener: _set_gcov_prefix 15:15:40 INFO - Running main action method: run_tests 15:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:40 INFO - Python 2.7.3 15:15:40 INFO - Return code: 0 15:15:40 INFO - grabbing minidump binary from tooltool 15:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:40 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 0x2393eb0>, '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 0x2394db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2395240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:40 INFO - Return code: 0 15:15:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:15:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - ENV: RUST_BACKTRACE is now 1 15:15:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:15:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 15:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 15:15:40 INFO - Using env: {'DISPLAY': ':0', 15:15:40 INFO - 'HOME': '/home/cltbld', 15:15:40 INFO - 'LANG': 'en_US.UTF-8', 15:15:40 INFO - 'LANGUAGE': 'en_US:en', 15:15:40 INFO - 'LOGNAME': 'cltbld', 15:15:40 INFO - 'MAIL': '/var/mail/cltbld', 15:15:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:40 INFO - 'MOZ_NO_REMOTE': '1', 15:15:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:40 INFO - 'NO_EM_RESTART': '1', 15:15:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:40 INFO - 'PWD': '/builds/slave/test', 15:15:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:40 INFO - 'RUST_BACKTRACE': '1', 15:15:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:15:40 INFO - 'SHELL': '/bin/bash', 15:15:40 INFO - 'SHLVL': '1', 15:15:40 INFO - 'STYLO_FORCE_ENABLED': '1', 15:15:40 INFO - 'TERM': 'linux', 15:15:40 INFO - 'TMOUT': '86400', 15:15:40 INFO - 'USER': 'cltbld', 15:15:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501272933.887005-909370870', 15:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:40 INFO - '_': '/tools/buildbot/bin/python'} 15:15:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 15:15:41 INFO - mozversion application_buildid: 20170728212824 15:15:41 INFO - mozversion application_changeset: e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 15:15:41 INFO - mozversion application_display_name: Nightly 15:15:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:41 INFO - mozversion application_name: Firefox 15:15:41 INFO - mozversion application_remotingname: firefox 15:15:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:15:41 INFO - mozversion application_vendor: Mozilla 15:15:41 INFO - mozversion application_version: 56.0a1 15:15:41 INFO - mozversion platform_buildid: 20170728212824 15:15:41 INFO - mozversion platform_changeset: e91b2c85aacd9aa32fbb3a71a7fae14fc21127b2 15:15:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:15:41 INFO - mozversion platform_version: 56.0a1 15:15:41 INFO - using testdate: 1501280141 15:15:41 INFO - actual date: 1501280141 15:15:41 INFO - starting webserver on 'localhost:37886' 15:15:41 INFO - SUITE-START | Running 2 tests 15:15:41 INFO - TEST-START | dromaeo_css 15:15:41 INFO - Initialising browser for dromaeo_css test... 15:15:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37886/getInfo.html -profile /tmp/tmp_fw5vt/profile 15:15:41 INFO - TEST-INFO | started process 13728 (/builds/slave/test/build/application/firefox/firefox http://localhost:37886/getInfo.html) 15:15:47 INFO - TEST-INFO | 13728: exit 0 15:15:47 INFO - Browser initialized. 15:15:47 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:47 INFO - TEST-INFO | started process 13953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_fw5vt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:48 INFO - PID 13953 | 15:15:48 INFO - PID 13953 | (/builds/slave/test/build/application/firefox/firefox:14007): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:15:48 INFO - PID 13953 | 15:15:59 INFO - PID 13953 | RSS: Main: 173621248 15:15:59 INFO - PID 13953 | 15:18:58 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37886/tests/dromaeo/cssquery-ext.html) 15:19:00 INFO - PID 13953 | RSS: Main: 175538176 15:19:00 INFO - PID 13953 | 15:22:02 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-ext.html (next: http://localhost:37886/tests/dromaeo/cssquery-jquery.html) 15:22:03 INFO - PID 13953 | RSS: Main: 172888064 15:22:03 INFO - PID 13953 | 15:25:04 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37886/tests/dromaeo/cssquery-mootools.html) 15:25:05 INFO - PID 13953 | RSS: Main: 174858240 15:25:05 INFO - PID 13953 | 15:28:07 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37886/tests/dromaeo/cssquery-prototype.html) 15:28:08 INFO - PID 13953 | RSS: Main: 173912064 15:28:08 INFO - PID 13953 | 15:31:12 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37886/tests/dromaeo/cssquery-yui.html) 15:31:12 INFO - PID 13953 | RSS: Main: 174153728 15:31:12 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | Cycle 1(1): loaded http://localhost:37886/tests/dromaeo/cssquery-yui.html (next: http://localhost:37886/tests/dromaeo/cssquery-dojo.html) 15:34:14 INFO - PID 13953 | RSS: Main: 177328128 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | __start_tp_report 15:34:14 INFO - PID 13953 | _x_x_mozilla_page_load 15:34:14 INFO - PID 13953 | _x_x_mozilla_page_load_details 15:34:14 INFO - PID 13953 | |i|pagename|runs| 15:34:14 INFO - PID 13953 | |0;dojo.html;3164.873405063797;3172.793768405052;3180.538821870827;3206.358728254349;3219.1308346746378;6123.724432400541;6191.380861913812;6191.9071213931775;6298.3386744391755;6333.493320534358;6248.437640612344;6264.655443950581;6295.401936815995;6312.368763123685;6376.266729326129;5626.2967129108865;5666.235058267122;5774.191613174159;5784.595078344528;5825.213596164527;5616.943830561703;5653.4911857932775;5699.344575373823;5749.885002299951;5760;5699.743511541969;5748.770049198027;5767.740451679663;5795.391483894194;5804.390538993429;5678.290213723285;5704.401037891044;5762.279715035621;5797.739101740432;5798.971005144947;5546.112621980504;5651.2935883014625;5663.0655941769555;5665.660060396348;5671.631343962629;6102.69486525672;6127.5710700251;6176.4441200292185;6184.721687524027;6186.412290832363;6705.061291419205;6724.529282950147;6759.864802703918;6764.864702705968;6766.7969960901255;6789.694463749143;6795.762148324785;6869.622170780605;6875.621840798754;6894.207166175904;6171.166892469549;6221.440070393686;6237;6282.905756413657;6336.588121772116;6941.895871561931;6954.200266969363;6958.582485050913;6960.234374218832;6966.512344135862;6525.4453371463005;6636.13730215069;6643.60138391698;6645.202575690948;6651.102101216371;6712.865742685119;6727.360900714424;6738;6738.831529211711;6740.629265390353;6613.6362500062;6671.3328667133865;6680.331966803378;6720.193576770819;6720.798376048726;5820.214271073351;6725.092112564741;6831.863362732717;6833.897491537631;6846.418054465426;5410.91883621746;5453.700046497402;5526.309211348582;5536.086545719912;5541.861453463695;4626.167289887785;4629.3518907353;4654.720716756938;4672.252439609714;4680.53194680536;5909.763609455659;5914.497267732291;5928.051511758098;5931.377205393458;5940.762369505172;6726;6814.250432452426;6827.044213810071;6835.829104272433;6840.042394064835;5852.561057920673;5859.121131830259;5938.584299099021;5948.613340132878;5950.464458198696;5808.506276966421;5846.035404158266;5956.821295361146;5969.164316995624;6018.458338749533;6534.444572211415;6556.934430655728;6557.311482294386;6557.967210164014;6560.147180866456;6722.092517510269;6793.592384456949;6793.864122717419;6836.658167091526;6851.040854280504;6493.383128602775;6511.2512061113575;6574.342565743387;6610.702518386588;6617.7683781067435;6485.805425837232;6615.239247486408;6677.699503522256;6777.423918966943;6780.491463140185;6621.602703837785;6732.528722989539;6772.966135169293;6783.982402639644;6784.626845523346;6437.903431448625;6543.247526534509;6557.311482294291;6561.1470508835455;6567.310432404529;6541.411272985454;6573.737050518117;6615.17310336208;6617.371349721769;6619.27188009309;6447.097406363019;6450.967745161244;6525.510586706111;6536.411722944958;6548.607083575001;6469.77355792545;6572.7042283098335;6583.703733331916;6584.440322572635;6595.208574971034;6404.295527492065;6417.26201486835;6419.2296924369375;6422;6428.453581445629 15:34:14 INFO - PID 13953 | |1;ext.html;686.8591938652577;753.1489416958835;773.1804287455298;777.6345117794634;1162.7209469727268;29522.409551808953;30018.699813001862;40624;41571.58428415715;41613.375799363035;41459.37810932838;41762.7911860441;41782.37326440106;41845.95385115374;41859;7456.70173193073;7580.583067931261;7618.162002179756;7825.765227043198;7842.254985776371;7660;7756.340711039568;7756.612169391536;7761.301482866541;7762.922370776277;7757.728479503218;7789.987301650777;7794.06471223454;7808.25821546955;7808.726694565691;7709.151993280735;7747;7779.727709530168;7811.375089992787;7826.099998500188;7627.733029344002;7691.30778229962;7696.307332340116;7700.6919723211;7704.229577042307;36760.448593271125;36952.26095478075;36997;37082.25835483275;37334.813325933195;3506.9649303506894;3532.1346270163717;3539.94690079649;3550.414181660023;3553.8578456861696;29830.254243643867;30013.24966875824;30033.399332013454;30073.849630751924;30092.24769380761;4683.133620280225;4710.952890471086;4742.1701202289805;4765.332853400527;4768.952310476886;180253;181191;181989.0900545502;182050;182137;46827;47398.5260147401;47466.76266618714;47646.5235347649;47696.76151619289;49202.26196607054;49329.50670493249;49342.50657493379;49468.257976130386;49564.50435495671;14498.057626254471;16182.59543511398;16645.750313745302;16655.41706040307;16664.08347540897;12212.755744885053;13719.245441500812;13928.721425571432;13956.162630242217;13992.51026214098;14180.716385672435;14186.645333866736;14214;14220.857791421953;14339.641508962359;5677.659340439587;5777.19119323295;5782.88434231313;5802.593818432669;5875.089361149029;970.5923512124924;986.2504496582505;1003.1322905686675;1019.0879163148941;1020.1940467031111;22195.11219551232;22338.106475740788;28214.576781348296;28624.427511449656;29519.114426567237;1089.7330154112294;1090.2259395828892;1098.3794156301665;1112.065864673678;1116.0959622705634;12034.699132521757;12580.119391642496;12702.42839072244;12728.745425091447;12784.6803829905;232368;232392;233143;235033;235407;50649.49350506521;51176.23235651468;51636;51647.225291620656;51700.74149629228;1451.9637009074859;1461.9415223390945;1474.1891959422276;1485.1979930837442;1501.4519700309309;21587;22153.824630128413;22169.667454987866;23041.76958230396;23129.65305520385;44147.117057658026;44198.77900610476;44625.10749785051;44881.1023779516;45090.549094508635;200405;201102;202953;203878;204723;30820.229494261926;30897.382052359277;30903;31241.218969525034;33756.83121584376;36992.63007369892;42383.576164239195;42408.15183696247;42802.35796463118;42864;27588.44823103567;29210.853945730134;30011;30245.243868903453;30276.5458518118;25522.10672626449;25753.227403177934;27041.59437608477;27042.05352812642;27254.591181131902;37515.81242093881;38026.239475210896;38354.42468362921;38389;38438.807805960794;30825.22936926505;32224.19439514031;32939.341213176085;33330.500042499865;33801.83099084489;22517.887410562842;24281.878590606935;24988.500229994934;25094.37264068413;25114.62328065117 15:34:14 INFO - PID 13953 | |2;jquery.html;572.8796952639946;573.8077743955774;576.9019266724657;581.380829416671;595.8927393069247;21730.89134554327;22554.097836086537;22593.209237676685;22627.66058509124;22644.43388915278;24560.631590526158;26062.218133456026;27332.863335683345;27696.446071078568;27742.722572774266;7049.54177978431;7213.783586492414;7220.783376498714;7231.421486281085;7233.565986040828;6315.842103947392;7061.788146355618;7091.149062112528;7123.89314160288;7132.6077065761365;6941.236463988957;6959.164900211957;6964.616946067964;6975.476839237052;6982.441404687613;6934.410575101122;6970.09388779458;6972.616506092163;6984.3364880336285;6985.126859142607;6772.322767723237;6822.522423430361;6830.248672646005;6835.965820170917;6842.384185423336;30001.849990750125;30677.69322306793;31349.8432507836;32670.509942350884;32819.83590082058;1927.9132439040277;1975.140813746025;1979.297349440942;1981.6135853508572;1983.8611297209202;19728.605427891507;20288.289909853083;20344.796552034437;20459.693104603444;20472;2303.9308820735237;2371.5968285391523;2391;2396.197273913241;2513.1204078572355;143257;144955;146590;146788;147413.2629336857;19755.40733777989;21552.676709849366;21961.890190548944;22029.889850550644;23311.650325245137;23274.767252327598;24020.39949001254;24066.51866962651;43542.56457435385;43723;10326.793464130675;10358.637447689294;10537.262391632665;10549.84175237372;10796.244262901522;9729.124378805942;9789.314747967574;9833.950830245803;9874.259430542737;9919;9222.492762898106;9375.812483750287;9450.669226577036;9636.903630963601;9861.471471921863;2646.245819941346;2702.6891907430895;2709.525832979221;2866.097179388528;2968.168912704446;958.6213445688913;966.2897770138942;978.888961029237;979.3356210984178;989.6189966862665;19427.611447770967;19650.919199444168;19692.40922772319;20252.291169808985;20547.280845170346;1020.8774947006407;1031.2523420520063;1043.2019505078622;1061.1139698351963;1063.574570171922;10684.465776711133;13127.934360328138;14005.159690418608;14046.1572305662;14490.275486225646;519799;519853;524954;535717;541488;116140.41929790298;119556;122612;123326;124148.1377779334;1241.5778635263873;1242.6147894152841;1286.3311078239262;1294.7345794112184;1296.3906963727034;20710.58578828445;21097.367078987656;21218.57562848765;21669.133234671066;22167.889160554096;56421;58451.123233152386;58550.7072464635;60283.69858150681;60751.69624151851;63605;68042.3195768036;68203.65898170676;68428.31571684219;68768;14960.476383326532;15162.166080865658;15210.391584336503;15282.541523754306;15285;23591.882040589688;23671.171508997104;23775.643365349188;23895.283141505784;24070.39824004414;18725.812741872953;18912.43262702121;19114.80885191186;19346.51633709112;19349.613007739485;16108.355665773706;16476.42332518356;16562;16870.325186992875;17061.146942653068;18416.447506574823;19066;19224.423267302005;19414.417567473;19487.02564871779;14837.629059273604;14853.108813470793;14872.256387180381;14898.553043408716;14974.47589334368;18535.81464185341;18677;18859.96270205097;18866.151023204264;19023.429297121107 15:34:14 INFO - PID 13953 | |3;mootools.html;1348.467355394619;1408.4577437686494;1408.717498803637;1417.7093695792364;1425.3942074618285;13684.657883552916;14295.78556321656;14315.856841431583;14322.140671559688;14337.068090574105;13194.142380745245;13612.455501779941;14165.362558684858;14170;14208.644783880409;2652.4032092779066;2724.4278701472713;2726.2775364528416;2746.382064035596;2753.366725653101;2636.512245234628;2694.8517831519257;2696.9325766855886;2720.64631597892;2751.876165572544;2638.432736961553;2674.9063782767607;2713.050432348672;2721.1972468121853;2726.4683386739594;2607.11358138233;2611.9216423507323;2613.2290974162665;2630.552806022981;2634.894604215829;2596.234110937259;2597.285746419731;2637.934051648724;2643.220250026247;2645.4709058188246;13407.597772066854;13701.109427887155;13701.109427887255;13725.313734313244;13757.79363309541;7495.8500829983095;7862.135165131831;7868.25251601097;7886.171951945078;7889.343237920044;5040.6471546991725;5284.233786100994;5307.893842123174;5356.571474282048;5387.757550910218;1827.616200597876;1841.373932862833;1864.86013548983;1905.6188762247607;1920.118284081608;22777.20279790216;22908.541829163325;23000.19499317516;23015.53968920629;23023.079076836908;6329.525285603599;6459.644719540471;6530.542861999709;6665.266820649725;6728.764493242713;15566.143862087694;15568.065916045074;15587.532374028797;15633.687326253412;15655;7547.811304717426;7715.768526944201;7719.112302085332;7728;7740.961295193488;5830.795922142789;6181.35095814933;6344.777932772331;6395.136656551399;7162.964185179041;5069.695818250917;5207.609429292818;5208.270842082112;5281.788728450896;5303.787848486095;1474.1965628732366;1519.1113198778617;1519.9924000379926;1520.5134357005652;1544.173866981182;828.2214718164905;831.2767891934056;853.8164294676675;860.3676297921023;888.3470649072926;6514.478841692653;6802.8639427212165;6968.303169682991;7043.859122817515;7059.117610298713;687.4912564702084;698.3923986131996;698.6681326370035;721.9963900180466;726.9345758881726;4651.3023046543285;4912.189488734319;4980.551750342486;5181.637285389987;5336.03951288764;18539.258429662663;18698.81301186998;19329.4201173965;19423.708644370345;19431.611367772566;17843.28626854937;19269;19351;19578.70631940522;19585.804141958397;10346.844797328045;10686.679399618024;10703.464826758787;10713.35719856811;10748.677539673823;7233;7709.884351734616;7819.882701759364;7872.881906771518;8067.273945344947;16417.261223244743;16508.504744857673;16653.3338666452;17406.91296543509;17776.91111544434;16030.759538606697;16951.830481695517;17507.649847002733;17682.469525914243;17759.556011099827;10994.560217591206;11385.715357116138;11818.881811181778;11844.70388240301;11888.702782430508;13255.204687718768;13304.600861974157;13365.465381384636;13387.196768193939;13419.597412077654;10030.147437467896;10567.154627629925;10601.1519078472;10603.94698026505;10649.201309901633;10297.691069267934;10390.428526431118;10470.581176752845;10621.89378106209;10765.46172691378;8839.558022098998;8943.731688049369;9114.36199466031;9217.170454659114;9246.306527010367;6629.46964242869;6800.229188193901;7031.296870313133;7047.224805271519;7059.563821233576;6658.500612453989;6738;6969.54697944632;7005.2644472329675;7092.645367731489 15:34:14 INFO - PID 13953 | |4;prototype.html;481.2300319488821;502.91621555547783;507.77404055195456;513.2609042978112;518.8702824293927;6080.206339129956;6118.235220597426;6127.754889804408;6128.540359473035;6186.1339412482175;5878.970605146968;5962.34414214436;5974.669878747292;6059.091136329553;6064.696765161746;4875.829345972892;4895.461499235082;4906.460289368167;4915.483874193203;4922.926156107661;4740.691855029412;4887.1447496688115;4922.876928076809;4941.998490611309;4951.925721114186;4865.975670121645;4868.878278043059;4888.340074090006;4906.165951788204;4951.678140920847;4888.364512613355;4891.461939186686;4926.3989203509;4943.876403089916;4949.059678661043;4372.934405983913;4398.120375924796;4417.823287068513;4421.38100665907;4426.15902978433;5781.653100813965;5844.766209351621;5943.463639134708;5948.851278718067;5974.701264936736;5594.944050559483;5600.719964001783;5626.240457538221;5680.744366503517;5698.6580805151825;6482.957868271479;6495.447886929616;6495.837604059889;6503.122078519434;6505.60966342021;4817.421909370898;4832.9758351208375;4843.757812109416;4851.781669824866;4868.488808675073;6719.328067193291;6745.831354216135;6828.965855170742;6837.282085381063;6848.7260509580055;4936.753162341868;4945.2582112683385;4957.182064959314;4986.180044283883;4993.325901003318;5032.345795046694;5033.899322013613;5046.47012063728;5053.444121146671;5063.746812659352;5626.606137570413;5628.480310316192;5658.321001479767;5669.177969194444;5685.82942511717;6532.859112434297;6535.411812936763;6536.444402225769;6538.869222615616;6547.770828020996;1658.9087600181865;1676.597616572014;1714.5713571607098;1718.9226484808214;1729.9913500432417;1204.9397530123458;1210.6549633354452;1211.4669545400172;1216.2702378572785;1227.5948936850818;5754.108113242454;5766;5791.8552036199435;5808.128780682847;5822.1266809978;6510.73957041713;6529.314421985718;6544.643928185849;6585.308542603054;6665.200175978914;5718.771249149988;5771.740271687784;5780.364159942403;5809.912851307234;5825.825225243249;3534.770239934396;3542.9645703542633;3554.928901422009;3571.160777217352;3592.6946209571956;6481.189851268591;6538.1500404947055;6550.639714815731;6551.312112228243;6560.376764207393;6844.459996500747;6869.931300687029;6886.311368863174;6911.205211400653;6919.930800692029;6435.903461447989;6490.935090649033;6543.303033785895;6548.607083575001;6554.180727409074;6680.331966803476;6689.799306020827;6703.664816759045;6703.865922681422;6738.6967586459705;6617.503687223574;6623.238327592196;6640.501962352746;6667.333266673294;6705.256633275286;6350.571121497626;6428.357164283534;6429.453496452854;6483.935160648333;6535.869282614226;4955;4995.375578052744;5002.17464118431;5015.297858299914;5032.471590482946;6725.0921125649365;6729.798106056826;6781.762638307833;6842.110525631636;6846.4522838173825;6451.935480645134;6462.578232788779;6481.578697384655;6491.545591808528;6521.347865213441;6524.869502610016;6538.1827271591055;6558.737650493927;6590.275069742421;6611.371919667624;6112.541559383153;6213.844653883689;6284.560080794484;6303.36966303366;6337.2395312562785;6443.96778016107;6475.923936130301;6507.707153178213;6525.575837570543;6531.301861516135;6194.659293738888;6199.442050215322;6220.315765265907;6282.623042617458;6387.584806987531 15:34:14 INFO - PID 13953 | |5;yui.html;892.2594246775174;913.707613563659;915.2312057871387;915.9496227707476;932.7947851472676;18428.170732317045;19063.52341191471;19094.42716718497;19122.33071842486;19124.808751912493;19381.224751009944;20475.897620511914;21359.35921922341;21400.785992140074;21462.89268553659;991.5240684471459;1006.5269323418019;1011.1405305490348;1013.6046941692746;1017.2828156149897;994.7065615643367;1038.0761122600854;1040.7658276887717;1042.6767702012362;1042.8487869258952;1091.2306823689319;1093.305750848209;1099.8240281554952;1100.1089117814556;1101.1686176936441;1087.8912108789136;1093.1582681335328;1095.802755504009;1097.1168209591276;1097.6981330134197;799.3125911715978;801.8436404901047;803.5620586780219;803.8593246181895;805.5810978291256;17757.822421775876;17891.46325610234;17934.820651793445;18253.45239642813;20215.191392344288;18727.78269412484;19023.61952760951;19428.320008799765;19482.80517194824;19844.702329465068;15401.614959626098;15756.369745210293;15885.682286354207;15943.840561594352;15951.680966380723;3457.360388328142;3458.775179613342;3476.9652303476896;3495.667911548399;3499.125218695326;117989.41005294918;121728;122737;127456.36271818582;128393;15561.14413707257;16012.879098462996;16096.195190240442;16107;16129.919350403174;29980;30058.248543786143;30104;30160;30238.84880575583;7745.457817952802;8114.229148230908;8132.6746930122135;8224.424290299741;8229.95885020583;3819.9809000955374;3996.300647386754;4125.566815484391;4138.875833724993;4144.730592511477;4300.397944287803;4400.515943246241;5653.575981801381;5850.795222167204;5878.588498805043;1055.5355643516828;1077.857471080657;1095.5672509358758;1095.9287646302964;1104.7348636327383;644.7227692092351;645.6578013652771;663.091564556551;666.6566718140161;679.106974328766;11899.107566932515;12171.391430428443;12322.81515777264;13002.349882505838;13370.532031378854;632.718440294074;678.5555461172939;679.67035987546;682.2495255219318;683.4464084091901;5471.6169868108855;5476.616636835463;5536.584756143306;5648.954943335496;5740.6268592541355;95180;96969.5151524252;99158.5042074785;101351.49324253331;103480.48259758652;84173.57913210394;85790;86473.56763216143;87817.5609121963;93083;75308;75654.24345756472;75708;79364.60317698374;82478.58760706279;11480.368579727861;12267.69330766738;12270.877291226974;12451.688707782378;12511.749765004832;34224.315513689085;34946.65053349434;35330.823345884135;37479.62520374871;37790.62209377981;62096.68951655213;65094.67452662707;67385.66307168432;69215;69915;17592.56018599545;18302.176402061672;18868.811311887253;18916.432507024812;19053.14260858237;17782.199801009243;19272.710909336092;20383.388498345073;20456.590868182255;20568.58862822765;17369;17615;18934.905325473286;18970.336038238594;18992.905035474734;18994.90502547534;19081;19107.522311941757;19160.329388471335;19352;16497;16752.41366552165;16806.915965420096;17459.47621571355;18758;12986.480540778262;13017.088803783645;13278.402471888981;13299.80050299227;13961.441542338192;14224.928875355557;14448.205348705922;14526.346314416089;14929.402823886923;14955.925220374264 15:34:14 INFO - PID 13953 | __end_tp_report 15:34:14 INFO - PID 13953 | __start_cc_report 15:34:14 INFO - PID 13953 | _x_x_mozilla_cycle_collect,393 15:34:14 INFO - PID 13953 | __end_cc_report 15:34:14 INFO - PID 13953 | __startTimestamp1501281254787__endTimestamp 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | ------- Summary: start ------- 15:34:14 INFO - PID 13953 | Number of tests: 6 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#0] dojo.html Cycles:165 Average:6197.94 Median:6447.10 stddev:736.68 (11.4%) stddev-sans-first:699.46 15:34:14 INFO - PID 13953 | Values: 3164.9 3172.8 3180.5 3206.4 3219.1 6123.7 6191.4 6191.9 6298.3 6333.5 6248.4 6264.7 6295.4 6312.4 6376.3 5626.3 5666.2 5774.2 5784.6 5825.2 5616.9 5653.5 5699.3 5749.9 5760.0 5699.7 5748.8 5767.7 5795.4 5804.4 5678.3 5704.4 5762.3 5797.7 5799.0 5546.1 5651.3 5663.1 5665.7 5671.6 6102.7 6127.6 6176.4 6184.7 6186.4 6705.1 6724.5 6759.9 6764.9 6766.8 6789.7 6795.8 6869.6 6875.6 6894.2 6171.2 6221.4 6237.0 6282.9 6336.6 6941.9 6954.2 6958.6 6960.2 6966.5 6525.4 6636.1 6643.6 6645.2 6651.1 6712.9 6727.4 6738.0 6738.8 6740.6 6613.6 6671.3 6680.3 6720.2 6720.8 5820.2 6725.1 6831.9 6833.9 6846.4 5410.9 5453.7 5526.3 5536.1 5541.9 4626.2 4629.4 4654.7 4672.3 4680.5 5909.8 5914.5 5928.1 5931.4 5940.8 6726.0 6814.3 6827.0 6835.8 6840.0 5852.6 5859.1 5938.6 5948.6 5950.5 5808.5 5846.0 5956.8 5969.2 6018.5 6534.4 6556.9 6557.3 6558.0 6560.1 6722.1 6793.6 6793.9 6836.7 6851.0 6493.4 6511.3 6574.3 6610.7 6617.8 6485.8 6615.2 6677.7 6777.4 6780.5 6621.6 6732.5 6773.0 6784.0 6784.6 6437.9 6543.2 6557.3 6561.1 6567.3 6541.4 6573.7 6615.2 6617.4 6619.3 6447.1 6451.0 6525.5 6536.4 6548.6 6469.8 6572.7 6583.7 6584.4 6595.2 6404.3 6417.3 6419.2 6422.0 6428.5 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#1] ext.html Cycles:180 Average:37287.69 Median:18654.40 stddev:53650.64 (287.6%) stddev-sans-first:53730.76 15:34:14 INFO - PID 13953 | Values: 686.9 753.1 773.2 777.6 1162.7 29522.4 30018.7 40624.0 41571.6 41613.4 41459.4 41762.8 41782.4 41846.0 41859.0 7456.7 7580.6 7618.2 7825.8 7842.3 7660.0 7756.3 7756.6 7761.3 7762.9 7757.7 7790.0 7794.1 7808.3 7808.7 7709.2 7747.0 7779.7 7811.4 7826.1 7627.7 7691.3 7696.3 7700.7 7704.2 36760.4 36952.3 36997.0 37082.3 37334.8 3507.0 3532.1 3539.9 3550.4 3553.9 29830.3 30013.2 30033.4 30073.8 30092.2 4683.1 4711.0 4742.2 4765.3 4769.0 180253.0 181191.0 181989.1 182050.0 182137.0 46827.0 47398.5 47466.8 47646.5 47696.8 49202.3 49329.5 49342.5 49468.3 49564.5 14498.1 16182.6 16645.8 16655.4 16664.1 12212.8 13719.2 13928.7 13956.2 13992.5 14180.7 14186.6 14214.0 14220.9 14339.6 5677.7 5777.2 5782.9 5802.6 5875.1 970.6 986.3 1003.1 1019.1 1020.2 22195.1 22338.1 28214.6 28624.4 29519.1 1089.7 1090.2 1098.4 1112.1 1116.1 12034.7 12580.1 12702.4 12728.7 12784.7 232368.0 232392.0 233143.0 235033.0 235407.0 50649.5 51176.2 51636.0 51647.2 51700.7 1452.0 1461.9 1474.2 1485.2 1501.5 21587.0 22153.8 22169.7 23041.8 23129.7 44147.1 44198.8 44625.1 44881.1 45090.5 200405.0 201102.0 202953.0 203878.0 204723.0 30820.2 30897.4 30903.0 31241.2 33756.8 36992.6 42383.6 42408.2 42802.4 42864.0 27588.4 29210.9 30011.0 30245.2 30276.5 25522.1 25753.2 27041.6 27042.1 27254.6 37515.8 38026.2 38354.4 38389.0 38438.8 30825.2 32224.2 32939.3 33330.5 33801.8 22517.9 24281.9 24988.5 25094.4 25114.6 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#2] jquery.html Cycles:180 Average:37048.37 Median:23293.21 stddev:88747.34 (381.0%) stddev-sans-first:88954.04 15:34:14 INFO - PID 13953 | Values: 572.9 573.8 576.9 581.4 595.9 21730.9 22554.1 22593.2 22627.7 22644.4 24560.6 26062.2 27332.9 27696.4 27742.7 7049.5 7213.8 7220.8 7231.4 7233.6 6315.8 7061.8 7091.1 7123.9 7132.6 6941.2 6959.2 6964.6 6975.5 6982.4 6934.4 6970.1 6972.6 6984.3 6985.1 6772.3 6822.5 6830.2 6836.0 6842.4 30001.8 30677.7 31349.8 32670.5 32819.8 1927.9 1975.1 1979.3 1981.6 1983.9 19728.6 20288.3 20344.8 20459.7 20472.0 2303.9 2371.6 2391.0 2396.2 2513.1 143257.0 144955.0 146590.0 146788.0 147413.3 19755.4 21552.7 21961.9 22029.9 23311.7 23274.8 24020.4 24066.5 43542.6 43723.0 10326.8 10358.6 10537.3 10549.8 10796.2 9729.1 9789.3 9834.0 9874.3 9919.0 9222.5 9375.8 9450.7 9636.9 9861.5 2646.2 2702.7 2709.5 2866.1 2968.2 958.6 966.3 978.9 979.3 989.6 19427.6 19650.9 19692.4 20252.3 20547.3 1020.9 1031.3 1043.2 1061.1 1063.6 10684.5 13127.9 14005.2 14046.2 14490.3 519799.0 519853.0 524954.0 535717.0 541488.0 116140.4 119556.0 122612.0 123326.0 124148.1 1241.6 1242.6 1286.3 1294.7 1296.4 20710.6 21097.4 21218.6 21669.1 22167.9 56421.0 58451.1 58550.7 60283.7 60751.7 63605.0 68042.3 68203.7 68428.3 68768.0 14960.5 15162.2 15210.4 15282.5 15285.0 23591.9 23671.2 23775.6 23895.3 24070.4 18725.8 18912.4 19114.8 19346.5 19349.6 16108.4 16476.4 16562.0 16870.3 17061.1 18416.4 19066.0 19224.4 19414.4 19487.0 14837.6 14853.1 14872.3 14898.6 14974.5 18535.8 18677.0 18860.0 18866.2 19023.4 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#3] mootools.html Cycles:180 Average:8619.75 Median:2632.72 stddev:5908.40 (224.4%) stddev-sans-first:5899.71 15:34:14 INFO - PID 13953 | Values: 1348.5 1408.5 1408.7 1417.7 1425.4 13684.7 14295.8 14315.9 14322.1 14337.1 13194.1 13612.5 14165.4 14170.0 14208.6 2652.4 2724.4 2726.3 2746.4 2753.4 2636.5 2694.9 2696.9 2720.6 2751.9 2638.4 2674.9 2713.1 2721.2 2726.5 2607.1 2611.9 2613.2 2630.6 2634.9 2596.2 2597.3 2637.9 2643.2 2645.5 13407.6 13701.1 13701.1 13725.3 13757.8 7495.9 7862.1 7868.3 7886.2 7889.3 5040.6 5284.2 5307.9 5356.6 5387.8 1827.6 1841.4 1864.9 1905.6 1920.1 22777.2 22908.5 23000.2 23015.5 23023.1 6329.5 6459.6 6530.5 6665.3 6728.8 15566.1 15568.1 15587.5 15633.7 15655.0 7547.8 7715.8 7719.1 7728.0 7741.0 5830.8 6181.4 6344.8 6395.1 7163.0 5069.7 5207.6 5208.3 5281.8 5303.8 1474.2 1519.1 1520.0 1520.5 1544.2 828.2 831.3 853.8 860.4 888.3 6514.5 6802.9 6968.3 7043.9 7059.1 687.5 698.4 698.7 722.0 726.9 4651.3 4912.2 4980.6 5181.6 5336.0 18539.3 18698.8 19329.4 19423.7 19431.6 17843.3 19269.0 19351.0 19578.7 19585.8 10346.8 10686.7 10703.5 10713.4 10748.7 7233.0 7709.9 7819.9 7872.9 8067.3 16417.3 16508.5 16653.3 17406.9 17776.9 16030.8 16951.8 17507.6 17682.5 17759.6 10994.6 11385.7 11818.9 11844.7 11888.7 13255.2 13304.6 13365.5 13387.2 13419.6 10030.1 10567.2 10601.2 10603.9 10649.2 10297.7 10390.4 10470.6 10621.9 10765.5 8839.6 8943.7 9114.4 9217.2 9246.3 6629.5 6800.2 7031.3 7047.2 7059.6 6658.5 6738.0 6969.5 7005.3 7092.6 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#4] prototype.html Cycles:180 Average:5463.76 Median:5968.51 stddev:1539.03 (25.8%) stddev-sans-first:1497.22 15:34:14 INFO - PID 13953 | Values: 481.2 502.9 507.8 513.3 518.9 6080.2 6118.2 6127.8 6128.5 6186.1 5879.0 5962.3 5974.7 6059.1 6064.7 4875.8 4895.5 4906.5 4915.5 4922.9 4740.7 4887.1 4922.9 4942.0 4951.9 4866.0 4868.9 4888.3 4906.2 4951.7 4888.4 4891.5 4926.4 4943.9 4949.1 4372.9 4398.1 4417.8 4421.4 4426.2 5781.7 5844.8 5943.5 5948.9 5974.7 5594.9 5600.7 5626.2 5680.7 5698.7 6483.0 6495.4 6495.8 6503.1 6505.6 4817.4 4833.0 4843.8 4851.8 4868.5 6719.3 6745.8 6829.0 6837.3 6848.7 4936.8 4945.3 4957.2 4986.2 4993.3 5032.3 5033.9 5046.5 5053.4 5063.7 5626.6 5628.5 5658.3 5669.2 5685.8 6532.9 6535.4 6536.4 6538.9 6547.8 1658.9 1676.6 1714.6 1718.9 1730.0 1204.9 1210.7 1211.5 1216.3 1227.6 5754.1 5766.0 5791.9 5808.1 5822.1 6510.7 6529.3 6544.6 6585.3 6665.2 5718.8 5771.7 5780.4 5809.9 5825.8 3534.8 3543.0 3554.9 3571.2 3592.7 6481.2 6538.2 6550.6 6551.3 6560.4 6844.5 6869.9 6886.3 6911.2 6919.9 6435.9 6490.9 6543.3 6548.6 6554.2 6680.3 6689.8 6703.7 6703.9 6738.7 6617.5 6623.2 6640.5 6667.3 6705.3 6350.6 6428.4 6429.5 6483.9 6535.9 4955.0 4995.4 5002.2 5015.3 5032.5 6725.1 6729.8 6781.8 6842.1 6846.5 6451.9 6462.6 6481.6 6491.5 6521.3 6524.9 6538.2 6558.7 6590.3 6611.4 6112.5 6213.8 6284.6 6303.4 6337.2 6444.0 6475.9 6507.7 6525.6 6531.3 6194.7 6199.4 6220.3 6282.6 6387.6 15:34:14 INFO - PID 13953 | 15:34:14 INFO - PID 13953 | [#5] yui.html Cycles:180 Average:22516.13 Median:19216.52 stddev:29843.87 (155.3%) stddev-sans-first:29883.42 15:34:14 INFO - PID 13953 | Values: 892.3 913.7 915.2 915.9 932.8 18428.2 19063.5 19094.4 19122.3 19124.8 19381.2 20475.9 21359.4 21400.8 21462.9 991.5 1006.5 1011.1 1013.6 1017.3 994.7 1038.1 1040.8 1042.7 1042.8 1091.2 1093.3 1099.8 1100.1 1101.2 1087.9 1093.2 1095.8 1097.1 1097.7 799.3 801.8 803.6 803.9 805.6 17757.8 17891.5 17934.8 18253.5 20215.2 18727.8 19023.6 19428.3 19482.8 19844.7 15401.6 15756.4 15885.7 15943.8 15951.7 3457.4 3458.8 3477.0 3495.7 3499.1 117989.4 121728.0 122737.0 127456.4 128393.0 15561.1 16012.9 16096.2 16107.0 16129.9 29980.0 30058.2 30104.0 30160.0 30238.8 7745.5 8114.2 8132.7 8224.4 8230.0 3820.0 3996.3 4125.6 4138.9 4144.7 4300.4 4400.5 5653.6 5850.8 5878.6 1055.5 1077.9 1095.6 1095.9 1104.7 644.7 645.7 663.1 666.7 679.1 11899.1 12171.4 12322.8 13002.3 13370.5 632.7 678.6 679.7 682.2 683.4 5471.6 5476.6 5536.6 5649.0 5740.6 95180.0 96969.5 99158.5 101351.5 103480.5 84173.6 85790.0 86473.6 87817.6 93083.0 75308.0 75654.2 75708.0 79364.6 82478.6 11480.4 12267.7 12270.9 12451.7 12511.7 34224.3 34946.7 35330.8 37479.6 37790.6 62096.7 65094.7 67385.7 69215.0 69915.0 17592.6 18302.2 18868.8 18916.4 19053.1 17782.2 19272.7 20383.4 20456.6 20568.6 17369.0 17615.0 18934.9 18970.3 18992.9 18994.9 19081.0 19107.5 19160.3 19352.0 16497.0 16752.4 16806.9 17459.5 18758.0 12986.5 13017.1 13278.4 13299.8 13961.4 14224.9 14448.2 14526.3 14929.4 14955.9 15:34:14 INFO - PID 13953 | -------- Summary: end -------- 15:34:14 INFO - PID 13953 | 15:34:15 INFO - TEST-INFO | 13953: exit 0 15:34:15 INFO - TEST-OK | dromaeo_css | took 1114378ms 15:34:15 INFO - TEST-START | kraken 15:34:15 INFO - Initialising browser for kraken test... 15:34:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37886/getInfo.html -profile /tmp/tmp6q3IJy/profile 15:34:15 INFO - TEST-INFO | started process 14328 (/builds/slave/test/build/application/firefox/firefox http://localhost:37886/getInfo.html) 15:34:21 INFO - TEST-INFO | 14328: exit 0 15:34:21 INFO - Browser initialized. 15:34:21 INFO - Running cycle 1/1 for kraken test... 15:34:21 INFO - TEST-INFO | started process 14550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6q3IJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:22 INFO - PID 14550 | 15:34:22 INFO - PID 14550 | (/builds/slave/test/build/application/firefox/firefox:14604): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:34:22 INFO - PID 14550 | 15:34:33 INFO - PID 14550 | RSS: Main: 173879296 15:34:33 INFO - PID 14550 | 15:34:35 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37886/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:36 INFO - PID 14550 | RSS: Main: 178630656 15:34:36 INFO - PID 14550 | 15:34:39 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37886/tests/kraken/driver.html?testName=audio-dft) 15:34:40 INFO - PID 14550 | RSS: Main: 179154944 15:34:40 INFO - PID 14550 | 15:34:43 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37886/tests/kraken/driver.html?testName=audio-fft) 15:34:43 INFO - PID 14550 | RSS: Main: 173473792 15:34:43 INFO - PID 14550 | 15:34:46 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37886/tests/kraken/driver.html?testName=audio-oscillator) 15:34:46 INFO - PID 14550 | RSS: Main: 174170112 15:34:46 INFO - PID 14550 | 15:34:48 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:49 INFO - PID 14550 | RSS: Main: 174649344 15:34:49 INFO - PID 14550 | 15:34:52 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37886/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:53 INFO - PID 14550 | RSS: Main: 177229824 15:34:53 INFO - PID 14550 | 15:34:56 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37886/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:57 INFO - PID 14550 | RSS: Main: 176996352 15:34:57 INFO - PID 14550 | 15:35:00 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37886/tests/kraken/driver.html?testName=json-parse-financial) 15:35:01 INFO - PID 14550 | RSS: Main: 177987584 15:35:01 INFO - PID 14550 | 15:35:02 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:03 INFO - PID 14550 | RSS: Main: 178212864 15:35:03 INFO - PID 14550 | 15:35:05 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:06 INFO - PID 14550 | RSS: Main: 175419392 15:35:06 INFO - PID 14550 | 15:35:08 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:08 INFO - PID 14550 | RSS: Main: 175517696 15:35:08 INFO - PID 14550 | 15:35:11 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:12 INFO - PID 14550 | RSS: Main: 175665152 15:35:12 INFO - PID 14550 | 15:35:15 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:16 INFO - PID 14550 | RSS: Main: 175255552 15:35:16 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | Cycle 1(1): loaded http://localhost:37886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37886/tests/kraken/driver.html?testName=ai-astar) 15:35:18 INFO - PID 14550 | RSS: Main: 177733632 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | __start_tp_report 15:35:18 INFO - PID 14550 | _x_x_mozilla_page_load 15:35:18 INFO - PID 14550 | _x_x_mozilla_page_load_details 15:35:18 INFO - PID 14550 | |i|pagename|runs| 15:35:18 INFO - PID 14550 | |0;ai-astar;99;110;109;107;110;109;110;101;108;108 15:35:18 INFO - PID 14550 | |1;audio-beat-detection;144;119;154;180;119;147;151;119;173;124 15:35:18 INFO - PID 14550 | |2;audio-dft;164;162;164;166;169;172;166;163;166;164 15:35:18 INFO - PID 14550 | |3;audio-fft;76;80;82;188;76;76;81;74;179;82 15:35:18 INFO - PID 14550 | |4;audio-oscillator;78;86;129;79;78;79;136;83;79;125 15:35:18 INFO - PID 14550 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;119;114;115 15:35:18 INFO - PID 14550 | |6;imaging-darkroom;150;152;151;158;151;153;150;151;151;151 15:35:18 INFO - PID 14550 | |7;imaging-desaturate;106;94;94;99;93;94;93;101;93;98 15:35:18 INFO - PID 14550 | |8;json-parse-financial;57;59;62;67;57;63;57;57;57;66 15:35:18 INFO - PID 14550 | |9;json-stringify-tinderbox;58;59;58;63;56;55;54;54;54;53 15:35:18 INFO - PID 14550 | |10;stanford-crypto-aes;84;91;80;80;81;79;81;83;81;83 15:35:18 INFO - PID 14550 | |11;stanford-crypto-ccm;130;130;134;137;142;128;130;141;134;167 15:35:18 INFO - PID 14550 | |12;stanford-crypto-pbkdf2;180;189;180;182;180;180;179;189;187;182 15:35:18 INFO - PID 14550 | |13;stanford-crypto-sha256-iterative;72;73;71;74;77;74;68;68;69;69 15:35:18 INFO - PID 14550 | __end_tp_report 15:35:18 INFO - PID 14550 | __start_cc_report 15:35:18 INFO - PID 14550 | _x_x_mozilla_cycle_collect,962 15:35:18 INFO - PID 14550 | __end_cc_report 15:35:18 INFO - PID 14550 | __startTimestamp1501281318443__endTimestamp 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | ------- Summary: start ------- 15:35:18 INFO - PID 14550 | Number of tests: 14 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.50 stddev:3.90 (3.6%) stddev-sans-first:2.83 15:35:18 INFO - PID 14550 | Values: 99.0 110.0 109.0 107.0 110.0 109.0 110.0 101.0 108.0 108.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:149.00 stddev:22.51 (15.1%) stddev-sans-first:23.87 15:35:18 INFO - PID 14550 | Values: 144.0 119.0 154.0 180.0 119.0 147.0 151.0 119.0 173.0 124.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:2.99 (1.8%) stddev-sans-first:3.11 15:35:18 INFO - PID 14550 | Values: 164.0 162.0 164.0 166.0 169.0 172.0 166.0 163.0 166.0 164.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#3] audio-fft Cycles:10 Average:99.40 Median:78.00 stddev:44.47 (57.0%) stddev-sans-first:46.35 15:35:18 INFO - PID 14550 | Values: 76.0 80.0 82.0 188.0 76.0 76.0 81.0 74.0 179.0 82.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:79.00 stddev:24.28 (30.7%) stddev-sans-first:24.95 15:35:18 INFO - PID 14550 | Values: 78.0 86.0 129.0 79.0 78.0 79.0 136.0 83.0 79.0 125.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.66 15:35:18 INFO - PID 14550 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 119.0 114.0 115.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.00 stddev:2.35 (1.6%) stddev-sans-first:2.40 15:35:18 INFO - PID 14550 | Values: 150.0 152.0 151.0 158.0 151.0 153.0 150.0 151.0 151.0 151.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:94.00 stddev:4.40 (4.7%) stddev-sans-first:3.05 15:35:18 INFO - PID 14550 | Values: 106.0 94.0 94.0 99.0 93.0 94.0 93.0 101.0 93.0 98.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:3.99 (6.6%) stddev-sans-first:4.07 15:35:18 INFO - PID 14550 | Values: 57.0 59.0 62.0 67.0 57.0 63.0 57.0 57.0 57.0 66.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:57.00 stddev:3.10 (5.4%) stddev-sans-first:3.23 15:35:18 INFO - PID 14550 | Values: 58.0 59.0 58.0 63.0 56.0 55.0 54.0 54.0 54.0 53.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:3.43 (4.2%) stddev-sans-first:3.59 15:35:18 INFO - PID 14550 | Values: 84.0 91.0 80.0 80.0 81.0 79.0 81.0 83.0 81.0 83.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.50 stddev:11.48 (8.5%) stddev-sans-first:11.87 15:35:18 INFO - PID 14550 | Values: 130.0 130.0 134.0 137.0 142.0 128.0 130.0 141.0 134.0 167.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:182.00 stddev:3.97 (2.2%) stddev-sans-first:4.08 15:35:18 INFO - PID 14550 | Values: 180.0 189.0 180.0 182.0 180.0 180.0 179.0 189.0 187.0 182.0 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.50 stddev:3.03 (4.2%) stddev-sans-first:3.21 15:35:18 INFO - PID 14550 | Values: 72.0 73.0 71.0 74.0 77.0 74.0 68.0 68.0 69.0 69.0 15:35:18 INFO - PID 14550 | -------- Summary: end -------- 15:35:18 INFO - PID 14550 | 15:35:18 INFO - PID 14550 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:35:19 INFO - TEST-INFO | 14550: exit 0 15:35:19 INFO - TEST-OK | kraken | took 63630ms 15:35:19 INFO - SUITE-END | took 1178s 15:35:19 INFO - Completed test suite (00:19:38) 15:35:19 INFO - javascript benchmark 15:35:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8487.211243439457, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.873405063797, 3172.793768405052, 3180.538821870827, 3206.358728254349, 3219.1308346746378, 6123.724432400541, 6191.380861913812, 6191.9071213931775, 6298.3386744391755, 6333.493320534358, 6248.437640612344, 6264.655443950581, 6295.401936815995, 6312.368763123685, 6376.266729326129, 5626.2967129108865, 5666.235058267122, 5774.191613174159, 5784.595078344528, 5825.213596164527, 5616.943830561703, 5653.4911857932775, 5699.344575373823, 5749.885002299951, 5760.0, 5699.743511541969, 5748.770049198027, 5767.740451679663, 5795.391483894194, 5804.390538993429, 5678.290213723285, 5704.401037891044, 5762.279715035621, 5797.739101740432, 5798.971005144947, 5546.112621980504, 5651.2935883014625, 5663.0655941769555, 5665.660060396348, 5671.631343962629, 6102.69486525672, 6127.5710700251, 6176.4441200292185, 6184.721687524027, 6186.412290832363, 6705.061291419205, 6724.529282950147, 6759.864802703918, 6764.864702705968, 6766.7969960901255, 6789.694463749143, 6795.762148324785, 6869.622170780605, 6875.621840798754, 6894.207166175904, 6171.166892469549, 6221.440070393686, 6237.0, 6282.905756413657, 6336.588121772116, 6941.895871561931, 6954.200266969363, 6958.582485050913, 6960.234374218832, 6966.512344135862, 6525.4453371463005, 6636.13730215069, 6643.60138391698, 6645.202575690948, 6651.102101216371, 6712.865742685119, 6727.360900714424, 6738.0, 6738.831529211711, 6740.629265390353, 6613.6362500062, 6671.3328667133865, 6680.331966803378, 6720.193576770819, 6720.798376048726, 5820.214271073351, 6725.092112564741, 6831.863362732717, 6833.897491537631, 6846.418054465426, 5410.91883621746, 5453.700046497402, 5526.309211348582, 5536.086545719912, 5541.861453463695, 4626.167289887785, 4629.3518907353, 4654.720716756938, 4672.252439609714, 4680.53194680536, 5909.763609455659, 5914.497267732291, 5928.051511758098, 5931.377205393458, 5940.762369505172, 6726.0, 6814.250432452426, 6827.044213810071, 6835.829104272433, 6840.042394064835, 5852.561057920673, 5859.121131830259, 5938.584299099021, 5948.613340132878, 5950.464458198696, 5808.506276966421, 5846.035404158266, 5956.821295361146, 5969.164316995624, 6018.458338749533, 6534.444572211415, 6556.934430655728, 6557.311482294386, 6557.967210164014, 6560.147180866456, 6722.092517510269, 6793.592384456949, 6793.864122717419, 6836.658167091526, 6851.040854280504, 6493.383128602775, 6511.2512061113575, 6574.342565743387, 6610.702518386588, 6617.7683781067435, 6485.805425837232, 6615.239247486408, 6677.699503522256, 6777.423918966943, 6780.491463140185, 6621.602703837785, 6732.528722989539, 6772.966135169293, 6783.982402639644, 6784.626845523346, 6437.903431448625, 6543.247526534509, 6557.311482294291, 6561.1470508835455, 6567.310432404529, 6541.411272985454, 6573.737050518117, 6615.17310336208, 6617.371349721769, 6619.27188009309, 6447.097406363019, 6450.967745161244, 6525.510586706111, 6536.411722944958, 6548.607083575001, 6469.77355792545, 6572.7042283098335, 6583.703733331916, 6584.440322572635, 6595.208574971034, 6404.295527492065, 6417.26201486835, 6419.2296924369375, 6422.0, 6428.453581445629], "value": 6142.839271020789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8591938652577, 753.1489416958835, 773.1804287455298, 777.6345117794634, 1162.7209469727268, 29522.409551808953, 30018.699813001862, 40624.0, 41571.58428415715, 41613.375799363035, 41459.37810932838, 41762.7911860441, 41782.37326440106, 41845.95385115374, 41859.0, 7456.70173193073, 7580.583067931261, 7618.162002179756, 7825.765227043198, 7842.254985776371, 7660.0, 7756.340711039568, 7756.612169391536, 7761.301482866541, 7762.922370776277, 7757.728479503218, 7789.987301650777, 7794.06471223454, 7808.25821546955, 7808.726694565691, 7709.151993280735, 7747.0, 7779.727709530168, 7811.375089992787, 7826.099998500188, 7627.733029344002, 7691.30778229962, 7696.307332340116, 7700.6919723211, 7704.229577042307, 36760.448593271125, 36952.26095478075, 36997.0, 37082.25835483275, 37334.813325933195, 3506.9649303506894, 3532.1346270163717, 3539.94690079649, 3550.414181660023, 3553.8578456861696, 29830.254243643867, 30013.24966875824, 30033.399332013454, 30073.849630751924, 30092.24769380761, 4683.133620280225, 4710.952890471086, 4742.1701202289805, 4765.332853400527, 4768.952310476886, 180253.0, 181191.0, 181989.0900545502, 182050.0, 182137.0, 46827.0, 47398.5260147401, 47466.76266618714, 47646.5235347649, 47696.76151619289, 49202.26196607054, 49329.50670493249, 49342.50657493379, 49468.257976130386, 49564.50435495671, 14498.057626254471, 16182.59543511398, 16645.750313745302, 16655.41706040307, 16664.08347540897, 12212.755744885053, 13719.245441500812, 13928.721425571432, 13956.162630242217, 13992.51026214098, 14180.716385672435, 14186.645333866736, 14214.0, 14220.857791421953, 14339.641508962359, 5677.659340439587, 5777.19119323295, 5782.88434231313, 5802.593818432669, 5875.089361149029, 970.5923512124924, 986.2504496582505, 1003.1322905686675, 1019.0879163148941, 1020.1940467031111, 22195.11219551232, 22338.106475740788, 28214.576781348296, 28624.427511449656, 29519.114426567237, 1089.7330154112294, 1090.2259395828892, 1098.3794156301665, 1112.065864673678, 1116.0959622705634, 12034.699132521757, 12580.119391642496, 12702.42839072244, 12728.745425091447, 12784.6803829905, 232368.0, 232392.0, 233143.0, 235033.0, 235407.0, 50649.49350506521, 51176.23235651468, 51636.0, 51647.225291620656, 51700.74149629228, 1451.9637009074859, 1461.9415223390945, 1474.1891959422276, 1485.1979930837442, 1501.4519700309309, 21587.0, 22153.824630128413, 22169.667454987866, 23041.76958230396, 23129.65305520385, 44147.117057658026, 44198.77900610476, 44625.10749785051, 44881.1023779516, 45090.549094508635, 200405.0, 201102.0, 202953.0, 203878.0, 204723.0, 30820.229494261926, 30897.382052359277, 30903.0, 31241.218969525034, 33756.83121584376, 36992.63007369892, 42383.576164239195, 42408.15183696247, 42802.35796463118, 42864.0, 27588.44823103567, 29210.853945730134, 30011.0, 30245.243868903453, 30276.5458518118, 25522.10672626449, 25753.227403177934, 27041.59437608477, 27042.05352812642, 27254.591181131902, 37515.81242093881, 38026.239475210896, 38354.42468362921, 38389.0, 38438.807805960794, 30825.22936926505, 32224.19439514031, 32939.341213176085, 33330.500042499865, 33801.83099084489, 22517.887410562842, 24281.878590606935, 24988.500229994934, 25094.37264068413, 25114.62328065117], "value": 17010.260629297998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8796952639946, 573.8077743955774, 576.9019266724657, 581.380829416671, 595.8927393069247, 21730.89134554327, 22554.097836086537, 22593.209237676685, 22627.66058509124, 22644.43388915278, 24560.631590526158, 26062.218133456026, 27332.863335683345, 27696.446071078568, 27742.722572774266, 7049.54177978431, 7213.783586492414, 7220.783376498714, 7231.421486281085, 7233.565986040828, 6315.842103947392, 7061.788146355618, 7091.149062112528, 7123.89314160288, 7132.6077065761365, 6941.236463988957, 6959.164900211957, 6964.616946067964, 6975.476839237052, 6982.441404687613, 6934.410575101122, 6970.09388779458, 6972.616506092163, 6984.3364880336285, 6985.126859142607, 6772.322767723237, 6822.522423430361, 6830.248672646005, 6835.965820170917, 6842.384185423336, 30001.849990750125, 30677.69322306793, 31349.8432507836, 32670.509942350884, 32819.83590082058, 1927.9132439040277, 1975.140813746025, 1979.297349440942, 1981.6135853508572, 1983.8611297209202, 19728.605427891507, 20288.289909853083, 20344.796552034437, 20459.693104603444, 20472.0, 2303.9308820735237, 2371.5968285391523, 2391.0, 2396.197273913241, 2513.1204078572355, 143257.0, 144955.0, 146590.0, 146788.0, 147413.2629336857, 19755.40733777989, 21552.676709849366, 21961.890190548944, 22029.889850550644, 23311.650325245137, 23274.767252327598, 24020.39949001254, 24066.51866962651, 43542.56457435385, 43723.0, 10326.793464130675, 10358.637447689294, 10537.262391632665, 10549.84175237372, 10796.244262901522, 9729.124378805942, 9789.314747967574, 9833.950830245803, 9874.259430542737, 9919.0, 9222.492762898106, 9375.812483750287, 9450.669226577036, 9636.903630963601, 9861.471471921863, 2646.245819941346, 2702.6891907430895, 2709.525832979221, 2866.097179388528, 2968.168912704446, 958.6213445688913, 966.2897770138942, 978.888961029237, 979.3356210984178, 989.6189966862665, 19427.611447770967, 19650.919199444168, 19692.40922772319, 20252.291169808985, 20547.280845170346, 1020.8774947006407, 1031.2523420520063, 1043.2019505078622, 1061.1139698351963, 1063.574570171922, 10684.465776711133, 13127.934360328138, 14005.159690418608, 14046.1572305662, 14490.275486225646, 519799.0, 519853.0, 524954.0, 535717.0, 541488.0, 116140.41929790298, 119556.0, 122612.0, 123326.0, 124148.1377779334, 1241.5778635263873, 1242.6147894152841, 1286.3311078239262, 1294.7345794112184, 1296.3906963727034, 20710.58578828445, 21097.367078987656, 21218.57562848765, 21669.133234671066, 22167.889160554096, 56421.0, 58451.123233152386, 58550.7072464635, 60283.69858150681, 60751.69624151851, 63605.0, 68042.3195768036, 68203.65898170676, 68428.31571684219, 68768.0, 14960.476383326532, 15162.166080865658, 15210.391584336503, 15282.541523754306, 15285.0, 23591.882040589688, 23671.171508997104, 23775.643365349188, 23895.283141505784, 24070.39824004414, 18725.812741872953, 18912.43262702121, 19114.80885191186, 19346.51633709112, 19349.613007739485, 16108.355665773706, 16476.42332518356, 16562.0, 16870.325186992875, 17061.146942653068, 18416.447506574823, 19066.0, 19224.423267302005, 19414.417567473, 19487.02564871779, 14837.629059273604, 14853.108813470793, 14872.256387180381, 14898.553043408716, 14974.47589334368, 18535.81464185341, 18677.0, 18859.96270205097, 18866.151023204264, 19023.429297121107], "value": 12698.059426491855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.467355394619, 1408.4577437686494, 1408.717498803637, 1417.7093695792364, 1425.3942074618285, 13684.657883552916, 14295.78556321656, 14315.856841431583, 14322.140671559688, 14337.068090574105, 13194.142380745245, 13612.455501779941, 14165.362558684858, 14170.0, 14208.644783880409, 2652.4032092779066, 2724.4278701472713, 2726.2775364528416, 2746.382064035596, 2753.366725653101, 2636.512245234628, 2694.8517831519257, 2696.9325766855886, 2720.64631597892, 2751.876165572544, 2638.432736961553, 2674.9063782767607, 2713.050432348672, 2721.1972468121853, 2726.4683386739594, 2607.11358138233, 2611.9216423507323, 2613.2290974162665, 2630.552806022981, 2634.894604215829, 2596.234110937259, 2597.285746419731, 2637.934051648724, 2643.220250026247, 2645.4709058188246, 13407.597772066854, 13701.109427887155, 13701.109427887255, 13725.313734313244, 13757.79363309541, 7495.8500829983095, 7862.135165131831, 7868.25251601097, 7886.171951945078, 7889.343237920044, 5040.6471546991725, 5284.233786100994, 5307.893842123174, 5356.571474282048, 5387.757550910218, 1827.616200597876, 1841.373932862833, 1864.86013548983, 1905.6188762247607, 1920.118284081608, 22777.20279790216, 22908.541829163325, 23000.19499317516, 23015.53968920629, 23023.079076836908, 6329.525285603599, 6459.644719540471, 6530.542861999709, 6665.266820649725, 6728.764493242713, 15566.143862087694, 15568.065916045074, 15587.532374028797, 15633.687326253412, 15655.0, 7547.811304717426, 7715.768526944201, 7719.112302085332, 7728.0, 7740.961295193488, 5830.795922142789, 6181.35095814933, 6344.777932772331, 6395.136656551399, 7162.964185179041, 5069.695818250917, 5207.609429292818, 5208.270842082112, 5281.788728450896, 5303.787848486095, 1474.1965628732366, 1519.1113198778617, 1519.9924000379926, 1520.5134357005652, 1544.173866981182, 828.2214718164905, 831.2767891934056, 853.8164294676675, 860.3676297921023, 888.3470649072926, 6514.478841692653, 6802.8639427212165, 6968.303169682991, 7043.859122817515, 7059.117610298713, 687.4912564702084, 698.3923986131996, 698.6681326370035, 721.9963900180466, 726.9345758881726, 4651.3023046543285, 4912.189488734319, 4980.551750342486, 5181.637285389987, 5336.03951288764, 18539.258429662663, 18698.81301186998, 19329.4201173965, 19423.708644370345, 19431.611367772566, 17843.28626854937, 19269.0, 19351.0, 19578.70631940522, 19585.804141958397, 10346.844797328045, 10686.679399618024, 10703.464826758787, 10713.35719856811, 10748.677539673823, 7233.0, 7709.884351734616, 7819.882701759364, 7872.881906771518, 8067.273945344947, 16417.261223244743, 16508.504744857673, 16653.3338666452, 17406.91296543509, 17776.91111544434, 16030.759538606697, 16951.830481695517, 17507.649847002733, 17682.469525914243, 17759.556011099827, 10994.560217591206, 11385.715357116138, 11818.881811181778, 11844.70388240301, 11888.702782430508, 13255.204687718768, 13304.600861974157, 13365.465381384636, 13387.196768193939, 13419.597412077654, 10030.147437467896, 10567.154627629925, 10601.1519078472, 10603.94698026505, 10649.201309901633, 10297.691069267934, 10390.428526431118, 10470.581176752845, 10621.89378106209, 10765.46172691378, 8839.558022098998, 8943.731688049369, 9114.36199466031, 9217.170454659114, 9246.306527010367, 6629.46964242869, 6800.229188193901, 7031.296870313133, 7047.224805271519, 7059.563821233576, 6658.500612453989, 6738.0, 6969.54697944632, 7005.2644472329675, 7092.645367731489], "value": 6262.830772271981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.2300319488821, 502.91621555547783, 507.77404055195456, 513.2609042978112, 518.8702824293927, 6080.206339129956, 6118.235220597426, 6127.754889804408, 6128.540359473035, 6186.1339412482175, 5878.970605146968, 5962.34414214436, 5974.669878747292, 6059.091136329553, 6064.696765161746, 4875.829345972892, 4895.461499235082, 4906.460289368167, 4915.483874193203, 4922.926156107661, 4740.691855029412, 4887.1447496688115, 4922.876928076809, 4941.998490611309, 4951.925721114186, 4865.975670121645, 4868.878278043059, 4888.340074090006, 4906.165951788204, 4951.678140920847, 4888.364512613355, 4891.461939186686, 4926.3989203509, 4943.876403089916, 4949.059678661043, 4372.934405983913, 4398.120375924796, 4417.823287068513, 4421.38100665907, 4426.15902978433, 5781.653100813965, 5844.766209351621, 5943.463639134708, 5948.851278718067, 5974.701264936736, 5594.944050559483, 5600.719964001783, 5626.240457538221, 5680.744366503517, 5698.6580805151825, 6482.957868271479, 6495.447886929616, 6495.837604059889, 6503.122078519434, 6505.60966342021, 4817.421909370898, 4832.9758351208375, 4843.757812109416, 4851.781669824866, 4868.488808675073, 6719.328067193291, 6745.831354216135, 6828.965855170742, 6837.282085381063, 6848.7260509580055, 4936.753162341868, 4945.2582112683385, 4957.182064959314, 4986.180044283883, 4993.325901003318, 5032.345795046694, 5033.899322013613, 5046.47012063728, 5053.444121146671, 5063.746812659352, 5626.606137570413, 5628.480310316192, 5658.321001479767, 5669.177969194444, 5685.82942511717, 6532.859112434297, 6535.411812936763, 6536.444402225769, 6538.869222615616, 6547.770828020996, 1658.9087600181865, 1676.597616572014, 1714.5713571607098, 1718.9226484808214, 1729.9913500432417, 1204.9397530123458, 1210.6549633354452, 1211.4669545400172, 1216.2702378572785, 1227.5948936850818, 5754.108113242454, 5766.0, 5791.8552036199435, 5808.128780682847, 5822.1266809978, 6510.73957041713, 6529.314421985718, 6544.643928185849, 6585.308542603054, 6665.200175978914, 5718.771249149988, 5771.740271687784, 5780.364159942403, 5809.912851307234, 5825.825225243249, 3534.770239934396, 3542.9645703542633, 3554.928901422009, 3571.160777217352, 3592.6946209571956, 6481.189851268591, 6538.1500404947055, 6550.639714815731, 6551.312112228243, 6560.376764207393, 6844.459996500747, 6869.931300687029, 6886.311368863174, 6911.205211400653, 6919.930800692029, 6435.903461447989, 6490.935090649033, 6543.303033785895, 6548.607083575001, 6554.180727409074, 6680.331966803476, 6689.799306020827, 6703.664816759045, 6703.865922681422, 6738.6967586459705, 6617.503687223574, 6623.238327592196, 6640.501962352746, 6667.333266673294, 6705.256633275286, 6350.571121497626, 6428.357164283534, 6429.453496452854, 6483.935160648333, 6535.869282614226, 4955.0, 4995.375578052744, 5002.17464118431, 5015.297858299914, 5032.471590482946, 6725.0921125649365, 6729.798106056826, 6781.762638307833, 6842.110525631636, 6846.4522838173825, 6451.935480645134, 6462.578232788779, 6481.578697384655, 6491.545591808528, 6521.347865213441, 6524.869502610016, 6538.1827271591055, 6558.737650493927, 6590.275069742421, 6611.371919667624, 6112.541559383153, 6213.844653883689, 6284.560080794484, 6303.36966303366, 6337.2395312562785, 6443.96778016107, 6475.923936130301, 6507.707153178213, 6525.575837570543, 6531.301861516135, 6194.659293738888, 6199.442050215322, 6220.315765265907, 6282.623042617458, 6387.584806987531], "value": 5008.978070672274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.2594246775174, 913.707613563659, 915.2312057871387, 915.9496227707476, 932.7947851472676, 18428.170732317045, 19063.52341191471, 19094.42716718497, 19122.33071842486, 19124.808751912493, 19381.224751009944, 20475.897620511914, 21359.35921922341, 21400.785992140074, 21462.89268553659, 991.5240684471459, 1006.5269323418019, 1011.1405305490348, 1013.6046941692746, 1017.2828156149897, 994.7065615643367, 1038.0761122600854, 1040.7658276887717, 1042.6767702012362, 1042.8487869258952, 1091.2306823689319, 1093.305750848209, 1099.8240281554952, 1100.1089117814556, 1101.1686176936441, 1087.8912108789136, 1093.1582681335328, 1095.802755504009, 1097.1168209591276, 1097.6981330134197, 799.3125911715978, 801.8436404901047, 803.5620586780219, 803.8593246181895, 805.5810978291256, 17757.822421775876, 17891.46325610234, 17934.820651793445, 18253.45239642813, 20215.191392344288, 18727.78269412484, 19023.61952760951, 19428.320008799765, 19482.80517194824, 19844.702329465068, 15401.614959626098, 15756.369745210293, 15885.682286354207, 15943.840561594352, 15951.680966380723, 3457.360388328142, 3458.775179613342, 3476.9652303476896, 3495.667911548399, 3499.125218695326, 117989.41005294918, 121728.0, 122737.0, 127456.36271818582, 128393.0, 15561.14413707257, 16012.879098462996, 16096.195190240442, 16107.0, 16129.919350403174, 29980.0, 30058.248543786143, 30104.0, 30160.0, 30238.84880575583, 7745.457817952802, 8114.229148230908, 8132.6746930122135, 8224.424290299741, 8229.95885020583, 3819.9809000955374, 3996.300647386754, 4125.566815484391, 4138.875833724993, 4144.730592511477, 4300.397944287803, 4400.515943246241, 5653.575981801381, 5850.795222167204, 5878.588498805043, 1055.5355643516828, 1077.857471080657, 1095.5672509358758, 1095.9287646302964, 1104.7348636327383, 644.7227692092351, 645.6578013652771, 663.091564556551, 666.6566718140161, 679.106974328766, 11899.107566932515, 12171.391430428443, 12322.81515777264, 13002.349882505838, 13370.532031378854, 632.718440294074, 678.5555461172939, 679.67035987546, 682.2495255219318, 683.4464084091901, 5471.6169868108855, 5476.616636835463, 5536.584756143306, 5648.954943335496, 5740.6268592541355, 95180.0, 96969.5151524252, 99158.5042074785, 101351.49324253331, 103480.48259758652, 84173.57913210394, 85790.0, 86473.56763216143, 87817.5609121963, 93083.0, 75308.0, 75654.24345756472, 75708.0, 79364.60317698374, 82478.58760706279, 11480.368579727861, 12267.69330766738, 12270.877291226974, 12451.688707782378, 12511.749765004832, 34224.315513689085, 34946.65053349434, 35330.823345884135, 37479.62520374871, 37790.62209377981, 62096.68951655213, 65094.67452662707, 67385.66307168432, 69215.0, 69915.0, 17592.56018599545, 18302.176402061672, 18868.811311887253, 18916.432507024812, 19053.14260858237, 17782.199801009243, 19272.710909336092, 20383.388498345073, 20456.590868182255, 20568.58862822765, 17369.0, 17615.0, 18934.905325473286, 18970.336038238594, 18992.905035474734, 18994.90502547534, 19081.0, 19107.522311941757, 19160.329388471335, 19352.0, 16497.0, 16752.41366552165, 16806.915965420096, 17459.47621571355, 18758.0, 12986.480540778262, 13017.088803783645, 13278.402471888981, 13299.80050299227, 13961.441542338192, 14224.928875355557, 14448.205348705922, 14526.346314416089, 14929.402823886923, 14955.925220374264], "value": 8978.937925162041, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 109.0, 107.0, 110.0, 109.0, 110.0, 101.0, 108.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 154.0, 180.0, 119.0, 147.0, 151.0, 119.0, 173.0, 124.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 166.0, 169.0, 172.0, 166.0, 163.0, 166.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 82.0, 188.0, 76.0, 76.0, 81.0, 74.0, 179.0, 82.0], "value": 99.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 129.0, 79.0, 78.0, 79.0, 136.0, 83.0, 79.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 119.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 158.0, 151.0, 153.0, 150.0, 151.0, 151.0, 151.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 94.0, 94.0, 99.0, 93.0, 94.0, 93.0, 101.0, 93.0, 98.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 62.0, 67.0, 57.0, 63.0, 57.0, 57.0, 57.0, 66.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 63.0, 56.0, 55.0, 54.0, 54.0, 54.0, 53.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 80.0, 80.0, 81.0, 79.0, 81.0, 83.0, 81.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 134.0, 137.0, 142.0, 128.0, 130.0, 141.0, 134.0, 167.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 189.0, 180.0, 182.0, 180.0, 180.0, 179.0, 189.0, 187.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 74.0, 77.0, 74.0, 68.0, 68.0, 69.0, 69.0], "value": 71.5, "unit": "score"}]}]} 15:35:19 INFO - Return code: 0 15:35:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:35:19 INFO - # TBPL SUCCESS # 15:35:19 INFO - Running post-action listener: _package_coverage_data 15:35:19 INFO - Running post-action listener: _resource_record_post_action 15:35:19 INFO - [mozharness: 2017-07-28 22:35:19.726235Z] Finished run-tests step (success) 15:35:19 INFO - Running post-run listener: _resource_record_post_run 15:35:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 339968; Write bytes: 442699776; Read time: 92; Write time: 310940 15:35:19 INFO - TinderboxPrint: CPU usage
13.1% 15:35:19 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 92 15:35:19 INFO - TinderboxPrint: I/O write bytes / time
442,699,776 / 310,940 15:35:19 INFO - TinderboxPrint: CPU idle
8,286.9 (86.8%) 15:35:19 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 15:35:19 INFO - TinderboxPrint: Swap in / out
0 / 0 15:35:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118214656; Read time: 0; Write time: 110116 15:35:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:35:19 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 335872; Write bytes: 323362816; Read time: 72; Write time: 200744 15:35:20 INFO - Running post-run listener: _upload_blobber_files 15:35:20 INFO - Blob upload gear active. 15:35:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:20 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 15:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:35:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:21 INFO - (blobuploader) - INFO - Done attempting. 15:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:29 INFO - (blobuploader) - INFO - Done attempting. 15:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:29 INFO - (blobuploader) - INFO - Done attempting. 15:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:30 INFO - (blobuploader) - INFO - Done attempting. 15:35:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:30 INFO - Return code: 0 15:35:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bfe746f2c6a362d962ffb1e42c212179a73f1b7ce57382b6df2b6a015b77bb2bce42775e6e7939aca6c4738897c1c8cbe8c546952f125d18b047853a9dc65cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a17054ef66d5a4c2626396a05905efd3add25c1db4cd6c55dcc08a732e16281758c70a6a6f0ea3e908fe0459019abdaacc761069e9f7339f908b4d5f90ec617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8a5f5efeff18aab66a8f0f275cf190d0a738cd4fbbb7bbc1ad396aae3eaf871eaf4bf5d32708f586f962ed757af67d41a56ce27e92db93c1b300c4705e08b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/299e5eb4aa6e4fad35b43a1c8737f3486753001824c309b538fd21f00177723515a906cf922656ebc4c00d66f1de0d4e11ef0f148703cb0577fa3b5cebb806ca"} 15:35:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:30 INFO - Contents: 15:35:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bfe746f2c6a362d962ffb1e42c212179a73f1b7ce57382b6df2b6a015b77bb2bce42775e6e7939aca6c4738897c1c8cbe8c546952f125d18b047853a9dc65cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a17054ef66d5a4c2626396a05905efd3add25c1db4cd6c55dcc08a732e16281758c70a6a6f0ea3e908fe0459019abdaacc761069e9f7339f908b4d5f90ec617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8a5f5efeff18aab66a8f0f275cf190d0a738cd4fbbb7bbc1ad396aae3eaf871eaf4bf5d32708f586f962ed757af67d41a56ce27e92db93c1b300c4705e08b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/299e5eb4aa6e4fad35b43a1c8737f3486753001824c309b538fd21f00177723515a906cf922656ebc4c00d66f1de0d4e11ef0f148703cb0577fa3b5cebb806ca"} 15:35:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:30 INFO - Copying logs to upload dir... 15:35:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.164163 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-28 15:35:30.977895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 15:35:30.981300) ========= 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=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bfe746f2c6a362d962ffb1e42c212179a73f1b7ce57382b6df2b6a015b77bb2bce42775e6e7939aca6c4738897c1c8cbe8c546952f125d18b047853a9dc65cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a17054ef66d5a4c2626396a05905efd3add25c1db4cd6c55dcc08a732e16281758c70a6a6f0ea3e908fe0459019abdaacc761069e9f7339f908b4d5f90ec617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8a5f5efeff18aab66a8f0f275cf190d0a738cd4fbbb7bbc1ad396aae3eaf871eaf4bf5d32708f586f962ed757af67d41a56ce27e92db93c1b300c4705e08b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/299e5eb4aa6e4fad35b43a1c8737f3486753001824c309b538fd21f00177723515a906cf922656ebc4c00d66f1de0d4e11ef0f148703cb0577fa3b5cebb806ca"} build_url:https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/OPaDeIT_QLCjtpwAEkMAGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bfe746f2c6a362d962ffb1e42c212179a73f1b7ce57382b6df2b6a015b77bb2bce42775e6e7939aca6c4738897c1c8cbe8c546952f125d18b047853a9dc65cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a17054ef66d5a4c2626396a05905efd3add25c1db4cd6c55dcc08a732e16281758c70a6a6f0ea3e908fe0459019abdaacc761069e9f7339f908b4d5f90ec617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8a5f5efeff18aab66a8f0f275cf190d0a738cd4fbbb7bbc1ad396aae3eaf871eaf4bf5d32708f586f962ed757af67d41a56ce27e92db93c1b300c4705e08b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/299e5eb4aa6e4fad35b43a1c8737f3486753001824c309b538fd21f00177723515a906cf922656ebc4c00d66f1de0d4e11ef0f148703cb0577fa3b5cebb806ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 15:35:31.005085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:35:31.005370) ========= 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=4300f881736b422476174874000001bc-1501272933.887005-909370870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 15:35:31.054610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 15:35:31.054896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 15:35:31.055164) ========= ========= Total master_lag: 0.41 =========