builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1503080763.98 results: success (0) revision: 978f68c17245c37283a3635629efff66d2cdcba9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:03.982683) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:03.983111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:03.983382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:03.999355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:03.999665) ========= 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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 11:26:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2017-08-18 11:26:04 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.228518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:04.245294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:04.245624) ========= 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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:04.294777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:04.297123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 978f68c17245c37283a3635629efff66d2cdcba9 --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 978f68c17245c37283a3635629efff66d2cdcba9 --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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 11:26:04,290 truncating revision to first 12 chars 2017-08-18 11:26:04,290 Setting DEBUG logging. 2017-08-18 11:26:04,290 attempt 1/10 2017-08-18 11:26:04,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/978f68c17245?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 11:26:04,744 unpacking tar archive at: mozilla-central-978f68c17245/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:05.065868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:05.066177) ========= script_repo_revision: 978f68c17245c37283a3635629efff66d2cdcba9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:05.066547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:05.066807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 11:26:05.083510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-18 11:26:05.083793) ========= /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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:05 INFO - MultiFileLogger online at 20170818 11:26:05 in /builds/slave/test 11:26:05 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 11:26:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:05 INFO - {'append_to_log': False, 11:26:05 INFO - 'base_work_dir': '/builds/slave/test', 11:26:05 INFO - 'blob_upload_branch': 'Firefox', 11:26:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:05 INFO - 'branch': 'Firefox', 11:26:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:05 INFO - 'code_coverage': False, 11:26:05 INFO - 'config_files': ('talos/linux_config.py',), 11:26:05 INFO - 'default_actions': ('clobber', 11:26:05 INFO - 'read-buildbot-config', 11:26:05 INFO - 'download-and-extract', 11:26:05 INFO - 'populate-webroot', 11:26:05 INFO - 'create-virtualenv', 11:26:05 INFO - 'install', 11:26:05 INFO - 'setup-mitmproxy', 11:26:05 INFO - 'run-tests'), 11:26:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:05 INFO - 'disable_ccov_upload': False, 11:26:05 INFO - 'download_minidump_stackwalk': True, 11:26:05 INFO - 'download_symbols': 'ondemand', 11:26:05 INFO - 'enable_stylo': False, 11:26:05 INFO - 'enable_webrender': False, 11:26:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:05 INFO - 'gecko_profile': False, 11:26:05 INFO - 'gecko_profile_interval': 0, 11:26:05 INFO - 'installer_path': 'installer.exe', 11:26:05 INFO - 'log_level': 'info', 11:26:05 INFO - 'log_name': 'talos', 11:26:05 INFO - 'log_to_console': True, 11:26:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:05 INFO - 'opt_config_files': (), 11:26:05 INFO - 'pip_index': False, 11:26:05 INFO - 'suite': 'dromaeojs-e10s', 11:26:05 INFO - 'system_bits': '32', 11:26:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:05 INFO - 'title': 'talos-linux64-ix-028', 11:26:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:05 INFO - 'use_talos_json': True, 11:26:05 INFO - 'verify': 'False', 11:26:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:05 INFO - 'work_dir': 'build'} 11:26:05 INFO - [mozharness: 2017-08-18 18:26:05.222360Z] Running clobber step. 11:26:05 INFO - Running pre-action listener: _resource_record_pre_action 11:26:05 INFO - Running main action method: clobber 11:26:05 INFO - rmtree: /builds/slave/test/build 11:26:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:06 INFO - Running post-action listener: _resource_record_post_action 11:26:06 INFO - [mozharness: 2017-08-18 18:26:06.848178Z] Finished clobber step (success) 11:26:06 INFO - [mozharness: 2017-08-18 18:26:06.848276Z] Running read-buildbot-config step. 11:26:06 INFO - Running pre-action listener: _resource_record_pre_action 11:26:06 INFO - Running main action method: read_buildbot_config 11:26:06 INFO - Using buildbot properties: 11:26:06 INFO - { 11:26:06 INFO - "project": "", 11:26:06 INFO - "product": "firefox", 11:26:06 INFO - "who": "ffxbld@noreply.mozilla.org", 11:26:06 INFO - "installer_path": "public/build/target.tar.bz2", 11:26:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:26:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:26:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:26:06 INFO - "stage_platform": "linux64-stylosequential", 11:26:06 INFO - "basedir": "/builds/slave/test", 11:26:06 INFO - "buildnumber": 157, 11:26:06 INFO - "platform": "ubuntu64_hw_styloseq", 11:26:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:26:06 INFO - "slavebuilddir": "test", 11:26:06 INFO - "taskId": "QPC8S1hqRN2FxuyKs5OwzA", 11:26:06 INFO - "branch": "mozilla-central", 11:26:06 INFO - "script_repo_revision": "production", 11:26:06 INFO - "revision": "978f68c17245c37283a3635629efff66d2cdcba9", 11:26:06 INFO - "slavename": "talos-linux64-ix-028", 11:26:06 INFO - "repo_path": "mozilla-central" 11:26:06 INFO - } 11:26:06 INFO - Finding installer, test and symbols from parent task. 11:26:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPC8S1hqRN2FxuyKs5OwzA'}, attempt #1 11:26:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPC8S1hqRN2FxuyKs5OwzA'}, attempt #1 11:26:07 INFO - Task dependencies: XXL59VVeTnurjyY8BNj5uA 11:26:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA'}, attempt #1 11:26:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 11:26:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.test_packages.json 11:26:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.crashreporter-symbols.zip 11:26:08 INFO - Running post-action listener: _resource_record_post_action 11:26:08 INFO - [mozharness: 2017-08-18 18:26:08.216041Z] Finished read-buildbot-config step (success) 11:26:08 INFO - [mozharness: 2017-08-18 18:26:08.216260Z] Running download-and-extract step. 11:26:08 INFO - Running pre-action listener: _resource_record_pre_action 11:26:08 INFO - Running main action method: download_and_extract 11:26:08 INFO - mkdir: /builds/slave/test/build/tests 11:26: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')]} 11:26:08 INFO - trying https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.test_packages.json 11:26:08 INFO - Downloading https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:26:08 INFO - Downloaded 989 bytes. 11:26:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:26:08 INFO - Using the following test package requirements: 11:26:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:26:08 INFO - u'common': [u'target.common.tests.zip'], 11:26:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:26:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:26:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:26:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:26:08 INFO - u'mozbase': [u'target.common.tests.zip'], 11:26:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:26:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:26:08 INFO - u'web-platform': [u'target.common.tests.zip', 11:26:08 INFO - u'target.web-platform.tests.tar.gz'], 11:26:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:26:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:26:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip 11:26:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:08 INFO - Fetch https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip into memory 11:26:09 INFO - Content-Length response header: 54001980 11:26:09 INFO - Bytes received: 54001980 11:26:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:26:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip 11:26:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:20 INFO - Fetch https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.common.tests.zip into memory 11:26:22 INFO - Content-Length response header: 54001980 11:26:22 INFO - Bytes received: 54001980 11:26:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.talos.tests.zip 11:26:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:26:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.talos.tests.zip into memory 11:26:34 INFO - Content-Length response header: 14496161 11:26:34 INFO - Bytes received: 14496161 11:26:34 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')]} 11:26:34 INFO - trying https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 11:26:34 INFO - Downloading https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:26:36 INFO - Downloaded 62277221 bytes. 11:26:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 11:26:36 INFO - mkdir: /builds/slave/test/properties 11:26:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:36 INFO - Contents: 11:26:36 INFO - build_url:https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 11:26:36 INFO - Running post-action listener: _resource_record_post_action 11:26:36 INFO - Running post-action listener: find_tests_for_verification 11:26:36 INFO - Running post-action listener: set_extra_try_arguments 11:26:36 INFO - [mozharness: 2017-08-18 18:26:36.030402Z] Finished download-and-extract step (success) 11:26:36 INFO - [mozharness: 2017-08-18 18:26:36.030500Z] Running populate-webroot step. 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: populate_webroot 11:26:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:36 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:36 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:36 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'tests': ['damp', 'tps']}, 11:26:36 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['damp', 'tps']}, 11:26:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:26:36 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:26:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:26:36 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:26:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_many_windows', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_many_windows', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:26:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:26:36 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['bloom_basic_singleton']}, 11:26:36 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['bloom_basic']}, 11:26:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:36 INFO - 'tsvgr_opacity', 11:26:36 INFO - 'tart', 11:26:36 INFO - 'tscrollx', 11:26:36 INFO - 'tsvg_static']}, 11:26:36 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['tsvgx', 11:26:36 INFO - 'tsvgr_opacity', 11:26:36 INFO - 'tart', 11:26:36 INFO - 'tscrollx', 11:26:36 INFO - 'tsvg_static']}, 11:26:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:36 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--stylo'], 11:26:36 INFO - 'tests': ['tp5o']}, 11:26:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:36 INFO - 'talos_options': ['--mitmproxy', 11:26:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:36 INFO - '--firstNonBlankPaint'], 11:26:36 INFO - 'tests': ['tp6_google', 11:26:36 INFO - 'tp6_youtube', 11:26:36 INFO - 'tp6_amazon', 11:26:36 INFO - 'tp6_facebook']}, 11:26:36 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:36 INFO - 'talos_options': ['--stylo', 11:26:36 INFO - '--mitmproxy', 11:26:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:36 INFO - '--firstNonBlankPaint'], 11:26:36 INFO - 'tests': ['tp6_google', 11:26:36 INFO - 'tp6_youtube', 11:26:36 INFO - 'tp6_amazon', 11:26:36 INFO - 'tp6_facebook']}, 11:26:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:36 INFO - 'talos_options': ['--stylo', 11:26:36 INFO - '--stylo-threads=1', 11:26:36 INFO - '--mitmproxy', 11:26:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:36 INFO - '--firstNonBlankPaint'], 11:26:36 INFO - 'tests': ['tp6_google', 11:26:36 INFO - 'tp6_youtube', 11:26:36 INFO - 'tp6_amazon', 11:26:36 INFO - 'tp6_facebook']}, 11:26:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--xperf_path', 11:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:36 INFO - 'tests': ['tp5n']}, 11:26:36 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:26:36 INFO - 'talos_options': ['--stylo', 11:26:36 INFO - '--xperf_path', 11:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:36 INFO - 'tests': ['tp5n']}}} 11:26:36 INFO - Running post-action listener: _resource_record_post_action 11:26:36 INFO - [mozharness: 2017-08-18 18:26:36.044740Z] Finished populate-webroot step (success) 11:26:36 INFO - [mozharness: 2017-08-18 18:26:36.044830Z] Running create-virtualenv step. 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: create_virtualenv 11:26:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:36 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 11:26:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:26:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:36 INFO - Using real prefix '/usr' 11:26:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:38 INFO - Installing pip.................done. 11:26:38 INFO - Return code: 0 11:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:26:38 INFO - Reading from file tmpfile_stdout 11:26:38 INFO - Output received: 11:26:38 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) 11:26:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:38 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')]} 11:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:38 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')]} 11:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:38 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:38 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 11:26:38 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 11:26:38 INFO - Using env: {'DISPLAY': ':0', 11:26:38 INFO - 'HOME': '/home/cltbld', 11:26:38 INFO - 'LANG': 'en_US.UTF-8', 11:26:38 INFO - 'LANGUAGE': 'en_US:en', 11:26:38 INFO - 'LOGNAME': 'cltbld', 11:26:38 INFO - 'MAIL': '/var/mail/cltbld', 11:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:38 INFO - 'MOZ_NO_REMOTE': '1', 11:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:38 INFO - 'NO_EM_RESTART': '1', 11:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:38 INFO - 'PWD': '/builds/slave/test', 11:26:38 INFO - 'SHELL': '/bin/bash', 11:26:38 INFO - 'SHLVL': '1', 11:26:38 INFO - 'TERM': 'linux', 11:26:38 INFO - 'TMOUT': '86400', 11:26:38 INFO - 'USER': 'cltbld', 11:26:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:38 INFO - '_': '/tools/buildbot/bin/python'} 11:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:39 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 11:26:39 INFO - Cleaning up... 11:26:39 INFO - Return code: 0 11:26:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:39 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')]} 11:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:39 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')]} 11:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:39 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:39 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 11:26:39 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 11:26:39 INFO - Using env: {'DISPLAY': ':0', 11:26:39 INFO - 'HOME': '/home/cltbld', 11:26:39 INFO - 'LANG': 'en_US.UTF-8', 11:26:39 INFO - 'LANGUAGE': 'en_US:en', 11:26:39 INFO - 'LOGNAME': 'cltbld', 11:26:39 INFO - 'MAIL': '/var/mail/cltbld', 11:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:39 INFO - 'MOZ_NO_REMOTE': '1', 11:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:39 INFO - 'NO_EM_RESTART': '1', 11:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:39 INFO - 'PWD': '/builds/slave/test', 11:26:39 INFO - 'SHELL': '/bin/bash', 11:26:39 INFO - 'SHLVL': '1', 11:26:39 INFO - 'TERM': 'linux', 11:26:39 INFO - 'TMOUT': '86400', 11:26:39 INFO - 'USER': 'cltbld', 11:26:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:39 INFO - '_': '/tools/buildbot/bin/python'} 11:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:39 INFO - Downloading/unpacking psutil>=3.1.1 11:26:39 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 11:26:39 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 11:26:39 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 11:26:39 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 11:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:40 INFO - Installing collected packages: psutil 11:26:40 INFO - Running setup.py install for psutil 11:26:40 INFO - building 'psutil._psutil_linux' extension 11:26:40 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 11:26:40 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 11:26:40 INFO - building 'psutil._psutil_posix' extension 11:26:40 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 11:26:40 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 11:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:40 INFO - Successfully installed psutil 11:26:40 INFO - Cleaning up... 11:26:40 INFO - Return code: 0 11:26:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:40 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:40 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 11:26:40 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 11:26:40 INFO - Using env: {'DISPLAY': ':0', 11:26:40 INFO - 'HOME': '/home/cltbld', 11:26:40 INFO - 'LANG': 'en_US.UTF-8', 11:26:40 INFO - 'LANGUAGE': 'en_US:en', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MAIL': '/var/mail/cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SHLVL': '1', 11:26:40 INFO - 'TERM': 'linux', 11:26:40 INFO - 'TMOUT': '86400', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:41 INFO - '_': '/tools/buildbot/bin/python'} 11:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26:41 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 11:26:41 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 11:26:41 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 11:26:41 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 11:26:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:42 INFO - Installing collected packages: mozsystemmonitor 11:26:42 INFO - Running setup.py install for mozsystemmonitor 11:26:42 INFO - Successfully installed mozsystemmonitor 11:26:42 INFO - Cleaning up... 11:26:42 INFO - Return code: 0 11:26:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:26:42 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')]} 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:42 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')]} 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:42 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:42 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 11:26:42 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 11:26:42 INFO - Using env: {'DISPLAY': ':0', 11:26:42 INFO - 'HOME': '/home/cltbld', 11:26:42 INFO - 'LANG': 'en_US.UTF-8', 11:26:42 INFO - 'LANGUAGE': 'en_US:en', 11:26:42 INFO - 'LOGNAME': 'cltbld', 11:26:42 INFO - 'MAIL': '/var/mail/cltbld', 11:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:42 INFO - 'MOZ_NO_REMOTE': '1', 11:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:42 INFO - 'NO_EM_RESTART': '1', 11:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:42 INFO - 'PWD': '/builds/slave/test', 11:26:42 INFO - 'SHELL': '/bin/bash', 11:26:42 INFO - 'SHLVL': '1', 11:26:42 INFO - 'TERM': 'linux', 11:26:42 INFO - 'TMOUT': '86400', 11:26:42 INFO - 'USER': 'cltbld', 11:26:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:42 INFO - '_': '/tools/buildbot/bin/python'} 11:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:42 INFO - Downloading/unpacking jsonschema==2.5.1 11:26:42 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 11:26:42 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 11:26:42 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 11:26:42 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 11:26:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:26:43 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 11:26:43 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 11:26:43 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 11:26:43 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 11:26:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:43 INFO - warning: no files found matching '*.txt' 11:26:43 INFO - no previously-included directories found matching 'build' 11:26:43 INFO - no previously-included directories found matching 'dist' 11:26:43 INFO - no previously-included directories found matching '.git*' 11:26:44 INFO - Installing collected packages: jsonschema, functools32 11:26:44 INFO - Running setup.py install for functools32 11:26:44 INFO - warning: no files found matching '*.txt' 11:26:44 INFO - no previously-included directories found matching 'build' 11:26:44 INFO - no previously-included directories found matching 'dist' 11:26:44 INFO - no previously-included directories found matching '.git*' 11:26:44 INFO - Successfully installed jsonschema functools32 11:26:44 INFO - Cleaning up... 11:26:44 INFO - Return code: 0 11:26:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:26:44 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')]} 11:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:44 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')]} 11:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:44 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:44 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 11:26:44 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 11:26:44 INFO - Using env: {'DISPLAY': ':0', 11:26:44 INFO - 'HOME': '/home/cltbld', 11:26:44 INFO - 'LANG': 'en_US.UTF-8', 11:26:44 INFO - 'LANGUAGE': 'en_US:en', 11:26:44 INFO - 'LOGNAME': 'cltbld', 11:26:44 INFO - 'MAIL': '/var/mail/cltbld', 11:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:44 INFO - 'MOZ_NO_REMOTE': '1', 11:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:44 INFO - 'NO_EM_RESTART': '1', 11:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:44 INFO - 'PWD': '/builds/slave/test', 11:26:44 INFO - 'SHELL': '/bin/bash', 11:26:44 INFO - 'SHLVL': '1', 11:26:44 INFO - 'TERM': 'linux', 11:26:44 INFO - 'TMOUT': '86400', 11:26:44 INFO - 'USER': 'cltbld', 11:26:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:44 INFO - '_': '/tools/buildbot/bin/python'} 11:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:26:44 INFO - Cleaning up... 11:26:44 INFO - Return code: 0 11:26:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:44 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')]} 11:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:44 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')]} 11:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:44 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:44 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 11:26:44 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 11:26:44 INFO - Using env: {'DISPLAY': ':0', 11:26:44 INFO - 'HOME': '/home/cltbld', 11:26:44 INFO - 'LANG': 'en_US.UTF-8', 11:26:44 INFO - 'LANGUAGE': 'en_US:en', 11:26:44 INFO - 'LOGNAME': 'cltbld', 11:26:44 INFO - 'MAIL': '/var/mail/cltbld', 11:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:44 INFO - 'MOZ_NO_REMOTE': '1', 11:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:44 INFO - 'NO_EM_RESTART': '1', 11:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:44 INFO - 'PWD': '/builds/slave/test', 11:26:44 INFO - 'SHELL': '/bin/bash', 11:26:44 INFO - 'SHLVL': '1', 11:26:44 INFO - 'TERM': 'linux', 11:26:44 INFO - 'TMOUT': '86400', 11:26:44 INFO - 'USER': 'cltbld', 11:26:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:44 INFO - '_': '/tools/buildbot/bin/python'} 11:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:44 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 11:26:44 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 11:26:44 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 11:26:44 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 11:26:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:46 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 11:26:46 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 11:26:46 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 11:26:46 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 11:26:46 INFO - Downloading docopt-0.6.1.tar.gz 11:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:46 INFO - Running setup.py install for blobuploader 11:26:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:46 INFO - Running setup.py install for requests 11:26:46 INFO - Running setup.py install for docopt 11:26:46 INFO - Successfully installed blobuploader requests docopt 11:26:46 INFO - Cleaning up... 11:26:46 INFO - Return code: 0 11:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:46 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:46 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 11:26:46 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 11:26:46 INFO - Using env: {'DISPLAY': ':0', 11:26:46 INFO - 'HOME': '/home/cltbld', 11:26:46 INFO - 'LANG': 'en_US.UTF-8', 11:26:46 INFO - 'LANGUAGE': 'en_US:en', 11:26:46 INFO - 'LOGNAME': 'cltbld', 11:26:46 INFO - 'MAIL': '/var/mail/cltbld', 11:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:46 INFO - 'MOZ_NO_REMOTE': '1', 11:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:46 INFO - 'NO_EM_RESTART': '1', 11:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:46 INFO - 'PWD': '/builds/slave/test', 11:26:46 INFO - 'SHELL': '/bin/bash', 11:26:46 INFO - 'SHLVL': '1', 11:26:46 INFO - 'TERM': 'linux', 11:26:46 INFO - 'TMOUT': '86400', 11:26:46 INFO - 'USER': 'cltbld', 11:26:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:46 INFO - '_': '/tools/buildbot/bin/python'} 11:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:47 INFO - Running setup.py (path:/tmp/pip-g2fcaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:47 INFO - Running setup.py (path:/tmp/pip-rmNSek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:47 INFO - Running setup.py (path:/tmp/pip-Ad4Iut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:47 INFO - Running setup.py (path:/tmp/pip-gMhIkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:47 INFO - Running setup.py (path:/tmp/pip-OTsGlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:47 INFO - Running setup.py (path:/tmp/pip-I79hKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:47 INFO - Running setup.py (path:/tmp/pip-_tyQPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:47 INFO - Running setup.py (path:/tmp/pip-hjCDnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:47 INFO - Running setup.py (path:/tmp/pip-FxBdBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:47 INFO - Running setup.py (path:/tmp/pip-TY6X0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:47 INFO - Running setup.py (path:/tmp/pip-7S3_Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:47 INFO - Running setup.py (path:/tmp/pip-EUSOzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:47 INFO - Running setup.py (path:/tmp/pip-0y1bXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:48 INFO - Running setup.py (path:/tmp/pip-wjX61f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:48 INFO - Running setup.py (path:/tmp/pip-S5sKVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:48 INFO - Running setup.py (path:/tmp/pip-Fh5BsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:48 INFO - Running setup.py (path:/tmp/pip-BHriEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:48 INFO - Running setup.py install for manifestparser 11:26:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:48 INFO - Running setup.py install for mozcrash 11:26:48 INFO - Running setup.py install for mozdebug 11:26:48 INFO - Running setup.py install for mozdevice 11:26:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:48 INFO - Running setup.py install for mozfile 11:26:48 INFO - Running setup.py install for mozhttpd 11:26:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:48 INFO - Running setup.py install for mozinfo 11:26:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for mozInstall 11:26:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for mozleak 11:26:49 INFO - Running setup.py install for mozlog 11:26:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for moznetwork 11:26:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for mozprocess 11:26:49 INFO - Running setup.py install for mozprofile 11:26:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for mozrunner 11:26:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:49 INFO - Running setup.py install for mozscreenshot 11:26:49 INFO - Running setup.py install for moztest 11:26:49 INFO - Running setup.py install for mozversion 11:26:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:50 INFO - Cleaning up... 11:26:50 INFO - Return code: 0 11:26:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:50 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')]} 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:50 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')]} 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:50 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:50 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 11:26:50 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 11:26:50 INFO - Using env: {'DISPLAY': ':0', 11:26:50 INFO - 'HOME': '/home/cltbld', 11:26:50 INFO - 'LANG': 'en_US.UTF-8', 11:26:50 INFO - 'LANGUAGE': 'en_US:en', 11:26:50 INFO - 'LOGNAME': 'cltbld', 11:26:50 INFO - 'MAIL': '/var/mail/cltbld', 11:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:50 INFO - 'MOZ_NO_REMOTE': '1', 11:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:50 INFO - 'NO_EM_RESTART': '1', 11:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:50 INFO - 'PWD': '/builds/slave/test', 11:26:50 INFO - 'SHELL': '/bin/bash', 11:26:50 INFO - 'SHLVL': '1', 11:26:50 INFO - 'TERM': 'linux', 11:26:50 INFO - 'TMOUT': '86400', 11:26:50 INFO - 'USER': 'cltbld', 11:26:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:50 INFO - '_': '/tools/buildbot/bin/python'} 11:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:50 INFO - Running setup.py (path:/tmp/pip-lqnevv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:50 INFO - Running setup.py (path:/tmp/pip-0oJaZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:50 INFO - Running setup.py (path:/tmp/pip-fJNOiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:50 INFO - Running setup.py (path:/tmp/pip-LJ0YSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:50 INFO - Running setup.py (path:/tmp/pip-fP0JZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:50 INFO - Running setup.py (path:/tmp/pip-84jpRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:50 INFO - Running setup.py (path:/tmp/pip-QuDG2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:50 INFO - Running setup.py (path:/tmp/pip-dY1GD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:50 INFO - Running setup.py (path:/tmp/pip-axS8FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:50 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)) 11:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:50 INFO - Running setup.py (path:/tmp/pip-xyfW_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:51 INFO - Running setup.py (path:/tmp/pip-Ilj47S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:51 INFO - Running setup.py (path:/tmp/pip-RuKxyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:51 INFO - Running setup.py (path:/tmp/pip-6YKOmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:51 INFO - Running setup.py (path:/tmp/pip-pFAE7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:51 INFO - Running setup.py (path:/tmp/pip-JUkK7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:51 INFO - Running setup.py (path:/tmp/pip-31MR1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:51 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)) 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:51 INFO - Running setup.py (path:/tmp/pip-IKJ62y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:51 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)) 11:26:51 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)) 11:26:51 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)) 11:26:51 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)) 11:26:51 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)) 11:26:51 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)) 11:26:51 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)) 11:26:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:51 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 11:26:51 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 11:26:51 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 11:26:51 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 11:26:52 INFO - Downloading blessings-1.6.tar.gz 11:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:52 INFO - Installing collected packages: blessings 11:26:52 INFO - Running setup.py install for blessings 11:26:52 INFO - Successfully installed blessings 11:26:52 INFO - Cleaning up... 11:26:52 INFO - Return code: 0 11:26:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:53 INFO - Reading from file tmpfile_stdout 11:26:53 INFO - Current package versions: 11:26:53 INFO - argparse == 1.2.1 11:26:53 INFO - blessings == 1.6 11:26:53 INFO - blobuploader == 1.2.4 11:26:53 INFO - docopt == 0.6.1 11:26:53 INFO - functools32 == 3.2.3-2 11:26:53 INFO - jsonschema == 2.5.1 11:26:53 INFO - manifestparser == 1.1 11:26:53 INFO - mozInstall == 1.13 11:26:53 INFO - mozcrash == 1.0 11:26:53 INFO - mozdebug == 0.1 11:26:53 INFO - mozdevice == 0.51 11:26:53 INFO - mozfile == 1.2 11:26:53 INFO - mozhttpd == 0.7 11:26:53 INFO - mozinfo == 0.10 11:26:53 INFO - mozleak == 0.1 11:26:53 INFO - mozlog == 3.5 11:26:53 INFO - moznetwork == 0.27 11:26:53 INFO - mozprocess == 0.25 11:26:53 INFO - mozprofile == 0.28 11:26:53 INFO - mozrunner == 6.13 11:26:53 INFO - mozscreenshot == 0.1 11:26:53 INFO - mozsystemmonitor == 0.3 11:26:53 INFO - moztest == 0.8 11:26:53 INFO - mozversion == 1.4 11:26:53 INFO - psutil == 3.1.1 11:26:53 INFO - requests == 1.2.3 11:26:53 INFO - wsgiref == 0.1.2 11:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:53 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 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:53 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 11:26:53 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 11:26:53 INFO - Using env: {'DISPLAY': ':0', 11:26:53 INFO - 'HOME': '/home/cltbld', 11:26:53 INFO - 'LANG': 'en_US.UTF-8', 11:26:53 INFO - 'LANGUAGE': 'en_US:en', 11:26:53 INFO - 'LOGNAME': 'cltbld', 11:26:53 INFO - 'MAIL': '/var/mail/cltbld', 11:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:53 INFO - 'MOZ_NO_REMOTE': '1', 11:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:53 INFO - 'NO_EM_RESTART': '1', 11:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:53 INFO - 'PWD': '/builds/slave/test', 11:26:53 INFO - 'SHELL': '/bin/bash', 11:26:53 INFO - 'SHLVL': '1', 11:26:53 INFO - 'TERM': 'linux', 11:26:53 INFO - 'TMOUT': '86400', 11:26:53 INFO - 'USER': 'cltbld', 11:26:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:53 INFO - '_': '/tools/buildbot/bin/python'} 11:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:26:53 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 11:26:53 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 11:26:53 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 11:26:53 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 11:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:26:54 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)) 11:26:54 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)) 11:26:54 INFO - Installing collected packages: simplejson 11:26:54 INFO - Running setup.py install for simplejson 11:26:54 INFO - building 'simplejson._speedups' extension 11:26:54 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 11:26:55 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 11:26:55 INFO - Successfully installed simplejson 11:26:55 INFO - Cleaning up... 11:26:55 INFO - Return code: 0 11:26:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1435a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, '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': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', '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 11:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:26:55 INFO - Using env: {'DISPLAY': ':0', 11:26:55 INFO - 'HOME': '/home/cltbld', 11:26:55 INFO - 'LANG': 'en_US.UTF-8', 11:26:55 INFO - 'LANGUAGE': 'en_US:en', 11:26:55 INFO - 'LOGNAME': 'cltbld', 11:26:55 INFO - 'MAIL': '/var/mail/cltbld', 11:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:55 INFO - 'MOZ_NO_REMOTE': '1', 11:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:55 INFO - 'NO_EM_RESTART': '1', 11:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:55 INFO - 'PWD': '/builds/slave/test', 11:26:55 INFO - 'SHELL': '/bin/bash', 11:26:55 INFO - 'SHLVL': '1', 11:26:55 INFO - 'TERM': 'linux', 11:26:55 INFO - 'TMOUT': '86400', 11:26:55 INFO - 'USER': 'cltbld', 11:26:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:55 INFO - '_': '/tools/buildbot/bin/python'} 11:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:26:55 INFO - Cleaning up... 11:26:55 INFO - Return code: 0 11:26:55 INFO - Running post-action listener: _resource_record_post_action 11:26:55 INFO - Running post-action listener: _start_resource_monitoring 11:26:55 INFO - Starting resource monitoring. 11:26:55 INFO - [mozharness: 2017-08-18 18:26:55.791312Z] Finished create-virtualenv step (success) 11:26:55 INFO - [mozharness: 2017-08-18 18:26:55.791837Z] Running install step. 11:26:55 INFO - Running pre-action listener: _resource_record_pre_action 11:26:55 INFO - Running main action method: install 11:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Output received: 11:26:56 INFO - Usage: mozinstall [options] installer 11:26:56 INFO - Options: 11:26:56 INFO - -h, --help show this help message and exit 11:26:56 INFO - -d DEST, --destination=DEST 11:26:56 INFO - Directory to install application into. [default: 11:26:56 INFO - "/builds/slave/test"] 11:26:56 INFO - --app=APP Application being installed. [default: firefox] 11:26:56 INFO - mkdir: /builds/slave/test/build/application 11:26:56 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'] 11:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:27:14 INFO - Reading from file tmpfile_stdout 11:27:14 INFO - Output received: 11:27:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:14 INFO - Running post-action listener: _resource_record_post_action 11:27:14 INFO - [mozharness: 2017-08-18 18:27:14.178227Z] Finished install step (success) 11:27:14 INFO - [mozharness: 2017-08-18 18:27:14.178474Z] Running setup-mitmproxy step. 11:27:14 INFO - Running pre-action listener: _resource_record_pre_action 11:27:14 INFO - Running main action method: setup_mitmproxy 11:27:14 INFO - Skipping: mitmproxy is not required 11:27:14 INFO - Running post-action listener: _resource_record_post_action 11:27:14 INFO - [mozharness: 2017-08-18 18:27:14.179615Z] Finished setup-mitmproxy step (success) 11:27:14 INFO - [mozharness: 2017-08-18 18:27:14.179833Z] Running run-tests step. 11:27:14 INFO - Running pre-action listener: _resource_record_pre_action 11:27:14 INFO - Running pre-action listener: _set_gcov_prefix 11:27:14 INFO - Running main action method: run_tests 11:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:14 INFO - Python 2.7.3 11:27:14 INFO - Return code: 0 11:27:14 INFO - grabbing minidump binary from tooltool 11:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:14 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 0x15d60b0>, '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 0x15d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:14 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 11:27:14 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 11:27:14 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 11:27:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:14 INFO - Return code: 0 11:27:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:14 INFO - ENV: RUST_BACKTRACE is now full 11:27:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:14 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/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:27:14 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/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 11:27:14 INFO - Using env: {'DISPLAY': ':0', 11:27:14 INFO - 'HOME': '/home/cltbld', 11:27:14 INFO - 'LANG': 'en_US.UTF-8', 11:27:14 INFO - 'LANGUAGE': 'en_US:en', 11:27:14 INFO - 'LOGNAME': 'cltbld', 11:27:14 INFO - 'MAIL': '/var/mail/cltbld', 11:27:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:14 INFO - 'MOZ_NO_REMOTE': '1', 11:27:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:14 INFO - 'NO_EM_RESTART': '1', 11:27:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:14 INFO - 'PWD': '/builds/slave/test', 11:27:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:14 INFO - 'RUST_BACKTRACE': 'full', 11:27:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:14 INFO - 'SHELL': '/bin/bash', 11:27:14 INFO - 'SHLVL': '1', 11:27:14 INFO - 'STYLO_FORCE_ENABLED': '1', 11:27:14 INFO - 'TERM': 'linux', 11:27:14 INFO - 'TMOUT': '86400', 11:27:14 INFO - 'USER': 'cltbld', 11:27:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776', 11:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:14 INFO - '_': '/tools/buildbot/bin/python'} 11:27:14 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/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:27:14 INFO - mozversion application_buildid: 20170818173348 11:27:14 INFO - mozversion application_changeset: 978f68c17245c37283a3635629efff66d2cdcba9 11:27:14 INFO - mozversion application_display_name: Nightly 11:27:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:14 INFO - mozversion application_name: Firefox 11:27:14 INFO - mozversion application_remotingname: firefox 11:27:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:27:14 INFO - mozversion application_vendor: Mozilla 11:27:14 INFO - mozversion application_version: 57.0a1 11:27:14 INFO - mozversion platform_buildid: 20170818173348 11:27:14 INFO - mozversion platform_changeset: 978f68c17245c37283a3635629efff66d2cdcba9 11:27:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:27:14 INFO - mozversion platform_version: 57.0a1 11:27:14 INFO - using testdate: 1503080834 11:27:14 INFO - actual date: 1503080834 11:27:14 INFO - starting webserver on 'localhost:38297' 11:27:14 INFO - SUITE-START | Running 2 tests 11:27:14 INFO - TEST-START | dromaeo_css 11:27:14 INFO - Initialising browser for dromaeo_css test... 11:27:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38297/getInfo.html -profile /tmp/tmpMlVqRG/profile 11:27:14 INFO - TEST-INFO | started process 15858 (/builds/slave/test/build/application/firefox/firefox http://localhost:38297/getInfo.html) 11:27:20 INFO - TEST-INFO | 15858: exit 0 11:27:20 INFO - Browser initialized. 11:27:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:20 INFO - TEST-INFO | started process 16051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlVqRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:21 INFO - PID 16051 | 11:27:21 INFO - PID 16051 | (/builds/slave/test/build/application/firefox/firefox:16105): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:27:21 INFO - PID 16051 | 11:27:32 INFO - PID 16051 | RSS: Main: 166129664 11:27:32 INFO - PID 16051 | 11:30:30 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38297/tests/dromaeo/cssquery-ext.html) 11:30:32 INFO - PID 16051 | RSS: Main: 175443968 11:30:32 INFO - PID 16051 | 11:33:34 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-ext.html (next: http://localhost:38297/tests/dromaeo/cssquery-jquery.html) 11:33:34 INFO - PID 16051 | RSS: Main: 171679744 11:33:34 INFO - PID 16051 | 11:36:36 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38297/tests/dromaeo/cssquery-mootools.html) 11:36:37 INFO - PID 16051 | RSS: Main: 173801472 11:36:37 INFO - PID 16051 | 11:39:38 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38297/tests/dromaeo/cssquery-prototype.html) 11:39:39 INFO - PID 16051 | RSS: Main: 172146688 11:39:39 INFO - PID 16051 | 11:42:43 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38297/tests/dromaeo/cssquery-yui.html) 11:42:43 INFO - PID 16051 | RSS: Main: 175624192 11:42:43 INFO - PID 16051 | 11:45:45 INFO - PID 16051 | Cycle 1(1): loaded http://localhost:38297/tests/dromaeo/cssquery-yui.html (next: http://localhost:38297/tests/dromaeo/cssquery-dojo.html) 11:45:46 INFO - PID 16051 | RSS: Main: 176136192 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | __start_tp_report 11:45:46 INFO - PID 16051 | _x_x_mozilla_page_load 11:45:46 INFO - PID 16051 | _x_x_mozilla_page_load_details 11:45:46 INFO - PID 16051 | |i|pagename|runs| 11:45:46 INFO - PID 16051 | |0;dojo.html;3128.343047959927;3144.63836658784;3168.9207769805753;3194.664560221176;3203.2152122729935;6099.451049405553;6151.846203844906;6181.6600086995195;6260.060990851374;6324.430801227889;6197.2563292404975;6226.84432889178;6291.1821463209835;6293.24481062272;6314.1475900753385;5548.112302031675;5696.544276457894;5775.855603609912;5783.450572195656;5820.941790582104;5648.519875810561;5648.858778530549;5649.830505084834;5654.236678048473;5666.914996275059;5681.545476361881;5742.770289188427;5749.712514374285;5750.798722044729;5770.336411312711;5666.9716651416475;5673.404292549264;5751.597388182787;5759.5968282220265;5760.942390576124;5491.341039075336;5564.86087847803;5635.154726790973;5699.914501282484;5707.74315155819;6150.7232174552255;6177.1969643945995;6178.84552886177;6223.471004964584;6241.7191226394925;6615.801525954229;6671.232808227068;6726.192856857208;6726.3609957054005;6738.056672065914;6674.799756007279;6684.766033188864;6711.295313992009;6788.49086318528;6795.93204067958;6021.187139736167;6109.175261339751;6168.722407491674;6207.844803879894;6298.968505157491;6796.35434633709;6842.623655698885;6845.281245469254;6855.314468553105;6855.931440685629;6382.585131966407;6456.192975878015;6530.967345163243;6532.836679082966;6539;6608;6631.204255489372;6667.466602671871;6690.632015239111;6719.260881303053;6457.192850893638;6568.737250510022;6629.767958121539;6671.733130674718;6684.197896252481;6641.33586641332;6641.601503909685;6643;6645.833854153588;6654.301298363699;5384.192371144281;5391.218273350342;5435.918461223085;5463.7814487420055;5482.753276102585;4605.078984203173;4621.930671039937;4683.906321873544;4689.859304220879;4701;5682.7442765075675;5765.048766953406;5772.9711351442975;5828.795992140254;5832.504237139806;6792.660366981631;6802.489813263926;6811.4210292124735;6819.965900170468;6830.965845170742;5758.165066065397;5761.164631128463;5828.358880523139;5839.124131380327;5845.941540584625;5847.56143289255;5866.208061911672;5951.821445356646;5962.314333851663;5967.254093238345;6366.076918846741;6460.870782584416;6467.223933128054;6468.870622587522;6546.0508226307875;6588.374104460068;6657.567258128206;6660.433863121689;6664.733410663519;6670.533062685566;6340.1123842661145;6439.7424103035355;6447.451966582706;6454.257760357619;6455.580387274812;6559.409653131241;6559.868802623825;6569.277379488348;6570.638614876037;6576.309487503743;6391.616503009835;6644.501662375244;6683.565568238049;6695.631740254138;6709.664516774239;6415.358464153547;6463.709133089116;6492.870142597028;6494.090827284279;6512.6092434454085;6398.200224971879;6445.323241059808;6470.288268290578;6573.244076931214;6574.572652777745;6357.8728425432155;6376.585521941059;6389.16940797712;6390.7443702251385;6395.520335974914;6287.497000239879;6429.067785171031;6498.090267362479;6518.2504012037325;6664.166979127609;6351.777687780906;6356.451460862496;6431.517636177212;6437.098806167047;6439 11:45:46 INFO - PID 16051 | |1;ext.html;801.6392623319504;835.5446281776432;862.3790870573187;885.7431344909976;886.8625363068722;38362.232755344914;39060.80469597651;39149.21701565967;39168;39206.607933920655;36153;36484.27031459369;36532.81733591335;36540.81729591355;36546;6771.356721111487;6866.210385805622;6872.072270243503;6879;6883.174019117713;6791.083203767503;6851.691673874688;6860.622665753382;6864.107666003412;6867.381935625793;7530.736424225153;7692.4615276930635;7739.110002349717;7740.148583655793;7753.379729621617;7643.159252482223;7701.422393320523;7705.460617756759;7705.922940770604;7710.267524585155;7386;7512.248775122499;7599.050118735158;7604.201558836353;7606;36486.45270320947;36908.81545592282;36929;36951.445728314095;36957.81521092404;3587.3901436755814;3630.09247688078;3633.364161271767;3634;3640.1263696712863;30010.69989300101;30075.849620751975;30079.548806767914;30095.097147085624;30223.546646800314;4928.408590969071;4960.156773348539;4988.800447982077;4990.101781679296;5009.098362294785;224029;227202;228256;228523;229060;47658;47768.76115619469;47838.28242576364;47908.28137577939;48144.277835832494;49353.259701104515;49422.25866612004;49552.50447495551;49556;49622.25566616504;15530.378784848479;15728.68542629141;15842;15856.603584910239;15859.762103568455;13008.349582520836;13008.674783130307;13015.479380824661;13027.804582931263;13032.348382580833;13897.374618142208;14094.154350738989;14104.153750774987;14194;14333.56999290023;5804.82585522435;5842.2405087338375;5881.764729410861;5993.760249590055;6061.909071363933;1004.2066767253933;1015.8374660054355;1022.1669339488293;1035.4563853976572;1035.746242170658;22725.545489090455;22873.19943801959;23005.194818181284;23073.769262307498;23264.65103023456;1128.311729844794;1131.637875879727;1135.392564977733;1137.5506674863382;1148.8736239013701;12155.63533093991;12304.384780760925;12386.5664701735;12422.875771242172;12459.501619935101;222195;223019;223632;223865;229123;51665.225021624705;51933.22100168501;52160.73919630377;52201.47798521966;55451.44548554543;1482.6886353865593;1502.684436268374;1515.4923100761148;1516.2646116633423;1519.8176218853807;27273.863630682514;27597.86201068982;27767;27914;27985.160445186677;49107.26339104845;49563;49613.25580116373;49633;49668.25497617611;205300;206378;206567;206726;206765;35684.46473302851;35792.46311305385;35898.10254743652;36081;36166.457503138;41613.16773664449;43814.56185438232;44098.77950610226;44107.55892441035;44127.77936110299;31646;32284.515732264506;32338.35323293568;32528;32631.836840815646;32326.676733232365;32613.205665270107;32672;33166.502502462965;33571.49642755409;35785.64214357823;35800.28399432049;35811.64188358083;36120.63879361278;36122.27755444929;33475.4978675325;33700.49449258312;33870.66129338773;34104;34274.82862585671;24308.392290192885;24544.509109817347;25142.371440714127;25191.37021574475;25307.240782776546 11:45:46 INFO - PID 16051 | |2;jquery.html;566.5411017076171;569.831899589621;571.1575426246286;571.6084482129739;581.7120525339957;21545.67681484777;22416;22497;22523.999999999978;22765.43086422836;26392.86803565984;26660.066897658588;26769.598456023174;26789.86605066972;26823.19530414086;6425.421712045927;6583.440407565338;6584.9012264816065;6608.405243528082;6612.669366531678;6277.278113017016;6547;6567.310432404601;6576.046473261375;6583;6525.184351956005;6533.771318003871;6534.509911756637;6540.149780528548;6541.051547525606;6525.412712855842;6534.150560427114;6535.313792051814;6537.836554086139;6538.313477084933;6037.154798328237;6040.09398590215;6046.879062418771;6062.696865156725;6082.908756368658;29724.851375742983;30062.098137055924;30184.698153018628;30191.396172076657;30326.090217293517;1937.9709304360447;1957.3834242213657;1961.9117139728603;1968.1045124468333;1968.3897991622644;18998.24007039717;19520.023998800145;19544.70682939757;19547.21811127553;19582.21671133153;2416.4321384474633;2427.9150229741877;2455.1652438170927;2507.0723832182025;2509.0214816221687;130999;133930;134128;134177;134599.32700336532;14925.70148597022;15118.94167408271;15197.696046079016;15429.922850385676;15871.365145394286;23358.64962025571;23728.64407033896;24313.270601881974;24315.63526547103;24373.63439548408;10498.10766084876;10548.630797922036;10662.360258384522;10730.2488825783;10778.676639700665;9792.314537982415;9801.264905132;9853.802923941625;9907.554160062815;9909.900900990899;9488.861336639648;9826.4104153751;9876.60493580263;9923.206143508647;9970.850437243447;2847.4589827932627;2860.3850172213074;2872.9281767955968;2899.362140329124;2956.645202575705;962.8748262725801;977.8777652793401;980.9950950245203;993.7863359377768;998.9051040151174;20197.384209263222;20264.594708105757;20664.690029649566;20779.79220207809;21261;1039.0804138337626;1047.041956609709;1048.9685309440729;1054.4516851237468;1057.2493529593921;11164.720881978015;11195.60815371458;11373.374464404536;11467.598634047768;11531.308121512737;506463;522059;522197;522833;523499;104038;107139.46430267798;107159;107898.46050769853;112444;1206.5776978057609;1207.2032458577296;1236.7526494701096;1242.465739731924;1246.6073186946082;17525.737113943556;17711.82288177102;17820.198091086193;18084.005379703718;18157.36449224271;54433.72783136217;55130.72434637801;55266.44733552613;55283;56750.14874776964;65661.67169164124;66046.66976665086;66404.33595664175;67016.32983670296;67436.6628166856;14435.78346324785;14661.560153195422;14785.704285914006;14803.555893323217;14908.701825963637;23457.41356466102;23673.881630591735;23697.40756481102;23716.762832371456;23882.52234955326;18054.90972545129;18702.719459207852;18817.811821882155;18846.71729924025;18883.05584720731;17468;18175.545611359823;18566;18708.532286692942;18895.149718262986;20078.096485657887;20344.69482957727;20394.490137746674;20454.693179602615;20474.692879607115;14910;15064.623384415478;15189.468368607046;15295.388184472497;15323.923380383027;19036.524086897938;19044;19069.14188861477;19145.234190632218;19490.90254548718 11:45:46 INFO - PID 16051 | |3;mootools.html;1349.8312710911136;1398.7971744097106;1404.3399602186971;1410.428776345579;1411.1815147214616;13288.269145197022;13927.37326820293;13931.860681393184;13942.95427842912;13945.233012184339;13823.37794799234;14058.156510609371;14132.929335353334;14169.645758856033;14294.285285735723;2654.0578094776365;2711.376383431812;2719.646445962022;2721.6053672217517;2728.945421091577;2563.7564431378987;2675.785937125025;2724.632174656416;2727.304537342975;2727.931801704963;2554.4763323518728;2654.6416233808477;2731.399092199713;2731.986340068297;2740.849253291068;2666;2707.44497378037;2732.0437846753675;2733.3576609496754;2733.72662733728;2551.170869467412;2564.5896656534865;2587.2496975876975;2692.4749673813612;2701.2706569226393;13572.45710171592;13843.930780346134;13845.584632461043;13850.09974351664;13861.4455421783;7315.707371705125;7595.658195381166;7627.847443051163;7629.122650895107;7630.38956883448;4764.7617619119255;4916.631252656065;5009.273655319958;5021.297018417425;5023.572996295319;1771.5836778357075;1790.176518801353;1822.1526989949605;1856.628674265139;1862.3425151615074;22006.88996555023;22177.223797167022;22181;22200.555988880133;22203.44491387712;6332.873342533124;6343.984495353612;6386.329435409308;6476.6114033158165;6488.253850807123;15220.847791522165;15280.159591222367;15367;15397.23013849303;15406.614834629225;7241.782746517613;7443.144038435541;7444.367228785505;7447.180810110884;7448.590327532038;6734.528582999143;6861.691223894937;6891.483138764613;6987.441004719611;7044.859102818017;4964.60283177345;5108.901586158993;5121.308623335802;5124.8206312778875;5129.281900533928;1342.6777573382317;1488.6352843553398;1498.4755335632442;1499.3477837140879;1519.5517322389921;712.291270186168;863.7797361672859;864.8832407625016;875.6147295190096;880.7489865388334;8102.865598816171;8147.103818579952;8199.098099209083;8286.958565207256;8335.499870007698;970.815545046439;990.5592011554933;1021.7394564386034;1022.2741853284251;1025.9384436933808;4865.927011094836;5212.087884620177;5255.500727430888;5462.016836969384;5516.7517461714315;18037.368692095715;18060.458186254433;18610.720839187423;18851.3976312015;19106;18223.908880455514;18692.719609205873;18740.25038998425;18921.81078189228;19089.713654295196;10218.948905255425;10392.58429662805;10421.5831366746;10483.633072842415;10490.16078713701;7391.445641576795;7501.549907005378;7507.737229196952;7519.849603008019;7534.284242996907;15964.281607327466;16317.755233671267;16416.835831641532;16578.253978570752;16854.15729213559;16811;16842.57893552671;16859.578510537336;16884.409045683344;16958.830411695726;10177.134943529883;10209.132223761064;10256.230782691477;10294.845577316197;10306.072453478922;12711.300878451404;12755.298458584495;12824.551140710031;12893.871061289266;12906.677333066373;10566.947165264432;10682.519286632276;10693.037626613643;10863.076638485818;10915.454227288445;10483;10492.108170805566;10495.842562361724;10499.422531760521;10624.309419887682;9530.904690953003;9688.806223875625;9710.077542633438;9710.514474276399;9723.222142228746;6983.336583024605;6984.755533556301;6994.825129371807;7087.539309944837;7103.786886393416;7097.893531597134;7148.17795953472;7169.462290328351;7171.677274522554;7312.670929808065 11:45:46 INFO - PID 16051 | |4;prototype.html;498.6538337123833;501.8946021335519;527.6174773289365;529.3058333084599;531.7367902888069;6378.298387177419;6397.1683681121385;6412.390822871826;6419.358064193579;6468.870622587546;6074.48366888815;6206.162168107304;6246.281677607077;6279.623222606647;6298.937010629892;5000.999800039988;5012.323336349601;5062.392512898457;5064;5076.79692812288;4987.127252730776;5006.54941055305;5028.145215313405;5060.316857224265;5061.671631049721;4860.927086093711;5011.173156429185;5029.497050294978;5054.646174767768;5059.709774007623;5026.6983980960895;5049.545540901318;5050.49495050492;5066.442691303953;5072.72100034498;4519.728816271035;4531.229690952546;4531.342955271467;4539.546045395434;4541.182587134314;6158.784442544489;6174.351693072253;6197.25632924052;6217.191765070557;6230.937690623081;5796.000379868939;5796.710164491758;5807.912881306742;5809.941900580982;5821.22452651941;6556.213254409501;6612.140421745143;6612.702428390686;6622.53642245043;6709.664516774142;4925.7783399747095;4929;4929.950700492985;4945.604351651859;4952.232403977389;6995.216219863953;7067.22260551339;7087.929120708778;7094.8293531566715;7099.751508697171;5045.562014825757;5056.747162641853;5072.873178170576;5080.6028342205445;5130.127878260705;5153;5156.149235376196;5159.2003239497935;5161.245176639885;5164.354455693038;5780.855478613068;5788.623739457006;5798.855028624318;5826.329972053183;5846.064629659234;6628.701708423133;6660.833479162963;6686.264510903797;6694.263631000586;6708.161479815023;1678.261564911435;1731.3638611512001;1748.6273275478688;1768.51365874383;1776.2539733311783;1197.1141355396944;1239.6157191270736;1239.9708242158986;1244.7323825377407;1257.1891130220956;5842.8539286517325;5844.736986835517;5852.853678658068;5861.824145275648;5877.147813567094;6646.933530664728;6830.31696830313;6832.145981752281;6847.246802851682;6882.827929301808;5873.0047675684855;5889.322727886348;5909.2908850938165;5917.171595976567;5918;3664.120611053328;3685.3182161300247;3694.18727879866;3696.392069449798;3699.8150092495266;6663.600183988976;6666;6680.298568650222;6693.732250710014;6701.095352127498;7074.398676112485;7075.823104422328;7089.751858685025;7097.254788247263;7098.290170982964;6617.073609694647;6620.63586502747;6650.401463868275;6662.400383965466;6669.233038200572;6863.931360686329;6898.482613803884;6901.75843845463;6926.826829329307;6943.68753406108;6759.594424334556;6814.284500127415;6814.727410903508;6819.181698196248;6829.658517074027;6539.444147247537;6568.704408301543;6585;6621.470282377494;6643.800685979429;5473.042217611982;5543.72281385921;5561.805336813192;5574.9442505574425;5580.190872323409;6869;6906.8618627628175;6926.515143939876;6942.271061538668;6965.686544105629;6612.867742645217;6631.336866313523;6637.084120368812;6678.365555272241;6693.163354580677;6469.353064693493;6624.0395142705;6656.7004484797335;6687.699053542505;6710.932890671031;6366.458850997532;6550.344965503412;6567.934320656732;6599.967000164968;6613;6652;6654.933450665431;6691;6714.563553369211;6749.156355455568;6395.16862807832;6430.2605200400685;6463.798530954917;6507.381798729113;6513.3161018094315 11:45:46 INFO - PID 16051 | |5;yui.html;907.2560500389675;915.9587818548167;928.7353104365253;935.7660584853786;936.3492372800897;19179.616407671838;19959.501012474695;19960.20159193634;19979.100940457676;22615.773842261573;21872;22125.446863828412;22227.66658500124;22285.888570557167;22367;1024.4365598920601;1055.8521806947033;1056.8837427882927;1057.973550661232;1058.4072919165292;1009.9849651100634;1054.098745572536;1056.9947150264277;1060.2790102730141;1062.8193207154802;1115.1190559458018;1118.776244751049;1118.7874303882236;1118.9160812939062;1119.0879433261907;1095.8411030400587;1102.581019212694;1105.237386203517;1105.4969988655143;1111.7887601355717;804.1717031457608;806.1897792718339;809.3929552835374;810.0360570920585;811.5698679699768;20337;20501.17995280187;20562.074706638236;20593.38219853407;21521;21420.46448838776;21620;21763.782362176335;22054.448638783997;22290.88854555733;16977.405790797264;17046.48860534186;17085.889417187842;17248.741268880978;17452.738208926876;3739.6821270192067;3748.7188460865545;3755.906102347436;3758.586555478895;3764.134249122717;124572.37713811464;124978;125667;127299.36350318282;130374;16839.74740378895;16968.57578560546;17270.913645431694;17325.133743312785;17412.564685882702;31121.844390778355;31541.84229078886;31637.20906977344;32884.83557582197;33083.3383332332;7899.407544434191;8235.876461853077;8754.86867696985;8841.204291613785;8982.461052336881;4330.545292744217;4429.092036132585;4432;4434.268345722984;4436.800343984464;5368.1679339702405;5509.724513774296;5518.227448157261;5943.58394912352;6106.847328816815;1106.502074066657;1106.983395249072;1132.4337831084458;1138.3738943580997;1142.5829572206085;682.8019874236415;701.8806802843427;707.706301884712;715.5170260074428;727.3126895084094;13007.284599347127;13938.442462301597;13947.790783138262;14128.43486260538;14362.491938346531;700.2017699822206;705.1009962298111;708.1855865754424;708.574855086954;713.115736486763;5664.065429204217;5730.19777231188;5742.626729262584;5928.140419639214;6011.9699401503585;108474;110776;112704.43647781873;112764;119282.4035879815;96554;98685;98930.50534747425;104201;104786;83823;84636.57681711552;86190.56904715311;87882;89258.55370723235;11314.773704526027;12432.12975091735;12624.74750505003;12691.93654031724;12819.42312595954;38318.61681383262;38469.6153038466;38571.42142867803;40040;41348.379774302804;70351;70748.64625676839;70832.64583677049;70885.6455717718;75432;20283.290084846958;20395.18419263213;20412.591748164657;20550.691739623617;20692.689609655565;22251.443713906636;22490.987905544618;22928.19751308696;23338.416539586648;23340.416489587216;17721.379751708628;17833.643327133126;17836.732449013536;18048.097595120453;18832.058397080364;18408;18551.90724046371;20069.29757458482;20860.269890554366;21016.474588135417;18188.72716909221;18194.818051819842;19352.32266870653;19701.605967880274;19995.800041999977;12668.366581671064;12764.29796361209;13080.476780928657;13353.332333383487;13683.04218704681;14241.860651147676;15033.699326013637;15159.393624254906;15282.312295946931;15312.234388280764 11:45:46 INFO - PID 16051 | __end_tp_report 11:45:46 INFO - PID 16051 | __start_cc_report 11:45:46 INFO - PID 16051 | _x_x_mozilla_cycle_collect,367 11:45:46 INFO - PID 16051 | __end_cc_report 11:45:46 INFO - PID 16051 | __startTimestamp1503081945999__endTimestamp 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | ------- Summary: start ------- 11:45:46 INFO - PID 16051 | Number of tests: 6 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#0] dojo.html Cycles:165 Average:6135.88 Median:6382.59 stddev:714.96 (11.2%) stddev-sans-first:677.10 11:45:46 INFO - PID 16051 | Values: 3128.3 3144.6 3168.9 3194.7 3203.2 6099.5 6151.8 6181.7 6260.1 6324.4 6197.3 6226.8 6291.2 6293.2 6314.1 5548.1 5696.5 5775.9 5783.5 5820.9 5648.5 5648.9 5649.8 5654.2 5666.9 5681.5 5742.8 5749.7 5750.8 5770.3 5667.0 5673.4 5751.6 5759.6 5760.9 5491.3 5564.9 5635.2 5699.9 5707.7 6150.7 6177.2 6178.8 6223.5 6241.7 6615.8 6671.2 6726.2 6726.4 6738.1 6674.8 6684.8 6711.3 6788.5 6795.9 6021.2 6109.2 6168.7 6207.8 6299.0 6796.4 6842.6 6845.3 6855.3 6855.9 6382.6 6456.2 6531.0 6532.8 6539.0 6608.0 6631.2 6667.5 6690.6 6719.3 6457.2 6568.7 6629.8 6671.7 6684.2 6641.3 6641.6 6643.0 6645.8 6654.3 5384.2 5391.2 5435.9 5463.8 5482.8 4605.1 4621.9 4683.9 4689.9 4701.0 5682.7 5765.0 5773.0 5828.8 5832.5 6792.7 6802.5 6811.4 6820.0 6831.0 5758.2 5761.2 5828.4 5839.1 5845.9 5847.6 5866.2 5951.8 5962.3 5967.3 6366.1 6460.9 6467.2 6468.9 6546.1 6588.4 6657.6 6660.4 6664.7 6670.5 6340.1 6439.7 6447.5 6454.3 6455.6 6559.4 6559.9 6569.3 6570.6 6576.3 6391.6 6644.5 6683.6 6695.6 6709.7 6415.4 6463.7 6492.9 6494.1 6512.6 6398.2 6445.3 6470.3 6573.2 6574.6 6357.9 6376.6 6389.2 6390.7 6395.5 6287.5 6429.1 6498.1 6518.3 6664.2 6351.8 6356.5 6431.5 6437.1 6439.0 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#1] ext.html Cycles:180 Average:38917.64 Median:19742.75 stddev:56920.22 (288.3%) stddev-sans-first:57007.94 11:45:46 INFO - PID 16051 | Values: 801.6 835.5 862.4 885.7 886.9 38362.2 39060.8 39149.2 39168.0 39206.6 36153.0 36484.3 36532.8 36540.8 36546.0 6771.4 6866.2 6872.1 6879.0 6883.2 6791.1 6851.7 6860.6 6864.1 6867.4 7530.7 7692.5 7739.1 7740.1 7753.4 7643.2 7701.4 7705.5 7705.9 7710.3 7386.0 7512.2 7599.1 7604.2 7606.0 36486.5 36908.8 36929.0 36951.4 36957.8 3587.4 3630.1 3633.4 3634.0 3640.1 30010.7 30075.8 30079.5 30095.1 30223.5 4928.4 4960.2 4988.8 4990.1 5009.1 224029.0 227202.0 228256.0 228523.0 229060.0 47658.0 47768.8 47838.3 47908.3 48144.3 49353.3 49422.3 49552.5 49556.0 49622.3 15530.4 15728.7 15842.0 15856.6 15859.8 13008.3 13008.7 13015.5 13027.8 13032.3 13897.4 14094.2 14104.2 14194.0 14333.6 5804.8 5842.2 5881.8 5993.8 6061.9 1004.2 1015.8 1022.2 1035.5 1035.7 22725.5 22873.2 23005.2 23073.8 23264.7 1128.3 1131.6 1135.4 1137.6 1148.9 12155.6 12304.4 12386.6 12422.9 12459.5 222195.0 223019.0 223632.0 223865.0 229123.0 51665.2 51933.2 52160.7 52201.5 55451.4 1482.7 1502.7 1515.5 1516.3 1519.8 27273.9 27597.9 27767.0 27914.0 27985.2 49107.3 49563.0 49613.3 49633.0 49668.3 205300.0 206378.0 206567.0 206726.0 206765.0 35684.5 35792.5 35898.1 36081.0 36166.5 41613.2 43814.6 44098.8 44107.6 44127.8 31646.0 32284.5 32338.4 32528.0 32631.8 32326.7 32613.2 32672.0 33166.5 33571.5 35785.6 35800.3 35811.6 36120.6 36122.3 33475.5 33700.5 33870.7 34104.0 34274.8 24308.4 24544.5 25142.4 25191.4 25307.2 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#2] jquery.html Cycles:180 Average:35391.14 Median:23408.03 stddev:86663.29 (370.2%) stddev-sans-first:86866.96 11:45:46 INFO - PID 16051 | Values: 566.5 569.8 571.2 571.6 581.7 21545.7 22416.0 22497.0 22524.0 22765.4 26392.9 26660.1 26769.6 26789.9 26823.2 6425.4 6583.4 6584.9 6608.4 6612.7 6277.3 6547.0 6567.3 6576.0 6583.0 6525.2 6533.8 6534.5 6540.1 6541.1 6525.4 6534.2 6535.3 6537.8 6538.3 6037.2 6040.1 6046.9 6062.7 6082.9 29724.9 30062.1 30184.7 30191.4 30326.1 1938.0 1957.4 1961.9 1968.1 1968.4 18998.2 19520.0 19544.7 19547.2 19582.2 2416.4 2427.9 2455.2 2507.1 2509.0 130999.0 133930.0 134128.0 134177.0 134599.3 14925.7 15118.9 15197.7 15429.9 15871.4 23358.6 23728.6 24313.3 24315.6 24373.6 10498.1 10548.6 10662.4 10730.2 10778.7 9792.3 9801.3 9853.8 9907.6 9909.9 9488.9 9826.4 9876.6 9923.2 9970.9 2847.5 2860.4 2872.9 2899.4 2956.6 962.9 977.9 981.0 993.8 998.9 20197.4 20264.6 20664.7 20779.8 21261.0 1039.1 1047.0 1049.0 1054.5 1057.2 11164.7 11195.6 11373.4 11467.6 11531.3 506463.0 522059.0 522197.0 522833.0 523499.0 104038.0 107139.5 107159.0 107898.5 112444.0 1206.6 1207.2 1236.8 1242.5 1246.6 17525.7 17711.8 17820.2 18084.0 18157.4 54433.7 55130.7 55266.4 55283.0 56750.1 65661.7 66046.7 66404.3 67016.3 67436.7 14435.8 14661.6 14785.7 14803.6 14908.7 23457.4 23673.9 23697.4 23716.8 23882.5 18054.9 18702.7 18817.8 18846.7 18883.1 17468.0 18175.5 18566.0 18708.5 18895.1 20078.1 20344.7 20394.5 20454.7 20474.7 14910.0 15064.6 15189.5 15295.4 15323.9 19036.5 19044.0 19069.1 19145.2 19490.9 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#3] mootools.html Cycles:180 Average:8543.96 Median:2564.17 stddev:5723.46 (223.2%) stddev-sans-first:5713.98 11:45:46 INFO - PID 16051 | Values: 1349.8 1398.8 1404.3 1410.4 1411.2 13288.3 13927.4 13931.9 13943.0 13945.2 13823.4 14058.2 14132.9 14169.6 14294.3 2654.1 2711.4 2719.6 2721.6 2728.9 2563.8 2675.8 2724.6 2727.3 2727.9 2554.5 2654.6 2731.4 2732.0 2740.8 2666.0 2707.4 2732.0 2733.4 2733.7 2551.2 2564.6 2587.2 2692.5 2701.3 13572.5 13843.9 13845.6 13850.1 13861.4 7315.7 7595.7 7627.8 7629.1 7630.4 4764.8 4916.6 5009.3 5021.3 5023.6 1771.6 1790.2 1822.2 1856.6 1862.3 22006.9 22177.2 22181.0 22200.6 22203.4 6332.9 6344.0 6386.3 6476.6 6488.3 15220.8 15280.2 15367.0 15397.2 15406.6 7241.8 7443.1 7444.4 7447.2 7448.6 6734.5 6861.7 6891.5 6987.4 7044.9 4964.6 5108.9 5121.3 5124.8 5129.3 1342.7 1488.6 1498.5 1499.3 1519.6 712.3 863.8 864.9 875.6 880.7 8102.9 8147.1 8199.1 8287.0 8335.5 970.8 990.6 1021.7 1022.3 1025.9 4865.9 5212.1 5255.5 5462.0 5516.8 18037.4 18060.5 18610.7 18851.4 19106.0 18223.9 18692.7 18740.3 18921.8 19089.7 10218.9 10392.6 10421.6 10483.6 10490.2 7391.4 7501.5 7507.7 7519.8 7534.3 15964.3 16317.8 16416.8 16578.3 16854.2 16811.0 16842.6 16859.6 16884.4 16958.8 10177.1 10209.1 10256.2 10294.8 10306.1 12711.3 12755.3 12824.6 12893.9 12906.7 10566.9 10682.5 10693.0 10863.1 10915.5 10483.0 10492.1 10495.8 10499.4 10624.3 9530.9 9688.8 9710.1 9710.5 9723.2 6983.3 6984.8 6994.8 7087.5 7103.8 7097.9 7148.2 7169.5 7171.7 7312.7 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#4] prototype.html Cycles:180 Average:5626.55 Median:6224.06 stddev:1582.17 (25.4%) stddev-sans-first:1539.08 11:45:46 INFO - PID 16051 | Values: 498.7 501.9 527.6 529.3 531.7 6378.3 6397.2 6412.4 6419.4 6468.9 6074.5 6206.2 6246.3 6279.6 6298.9 5001.0 5012.3 5062.4 5064.0 5076.8 4987.1 5006.5 5028.1 5060.3 5061.7 4860.9 5011.2 5029.5 5054.6 5059.7 5026.7 5049.5 5050.5 5066.4 5072.7 4519.7 4531.2 4531.3 4539.5 4541.2 6158.8 6174.4 6197.3 6217.2 6230.9 5796.0 5796.7 5807.9 5809.9 5821.2 6556.2 6612.1 6612.7 6622.5 6709.7 4925.8 4929.0 4930.0 4945.6 4952.2 6995.2 7067.2 7087.9 7094.8 7099.8 5045.6 5056.7 5072.9 5080.6 5130.1 5153.0 5156.1 5159.2 5161.2 5164.4 5780.9 5788.6 5798.9 5826.3 5846.1 6628.7 6660.8 6686.3 6694.3 6708.2 1678.3 1731.4 1748.6 1768.5 1776.3 1197.1 1239.6 1240.0 1244.7 1257.2 5842.9 5844.7 5852.9 5861.8 5877.1 6646.9 6830.3 6832.1 6847.2 6882.8 5873.0 5889.3 5909.3 5917.2 5918.0 3664.1 3685.3 3694.2 3696.4 3699.8 6663.6 6666.0 6680.3 6693.7 6701.1 7074.4 7075.8 7089.8 7097.3 7098.3 6617.1 6620.6 6650.4 6662.4 6669.2 6863.9 6898.5 6901.8 6926.8 6943.7 6759.6 6814.3 6814.7 6819.2 6829.7 6539.4 6568.7 6585.0 6621.5 6643.8 5473.0 5543.7 5561.8 5574.9 5580.2 6869.0 6906.9 6926.5 6942.3 6965.7 6612.9 6631.3 6637.1 6678.4 6693.2 6469.4 6624.0 6656.7 6687.7 6710.9 6366.5 6550.3 6567.9 6600.0 6613.0 6652.0 6654.9 6691.0 6714.6 6749.2 6395.2 6430.3 6463.8 6507.4 6513.3 11:45:46 INFO - PID 16051 | 11:45:46 INFO - PID 16051 | [#5] yui.html Cycles:180 Average:24450.84 Median:20577.73 stddev:32540.22 (158.1%) stddev-sans-first:32583.48 11:45:46 INFO - PID 16051 | Values: 907.3 916.0 928.7 935.8 936.3 19179.6 19959.5 19960.2 19979.1 22615.8 21872.0 22125.4 22227.7 22285.9 22367.0 1024.4 1055.9 1056.9 1058.0 1058.4 1010.0 1054.1 1057.0 1060.3 1062.8 1115.1 1118.8 1118.8 1118.9 1119.1 1095.8 1102.6 1105.2 1105.5 1111.8 804.2 806.2 809.4 810.0 811.6 20337.0 20501.2 20562.1 20593.4 21521.0 21420.5 21620.0 21763.8 22054.4 22290.9 16977.4 17046.5 17085.9 17248.7 17452.7 3739.7 3748.7 3755.9 3758.6 3764.1 124572.4 124978.0 125667.0 127299.4 130374.0 16839.7 16968.6 17270.9 17325.1 17412.6 31121.8 31541.8 31637.2 32884.8 33083.3 7899.4 8235.9 8754.9 8841.2 8982.5 4330.5 4429.1 4432.0 4434.3 4436.8 5368.2 5509.7 5518.2 5943.6 6106.8 1106.5 1107.0 1132.4 1138.4 1142.6 682.8 701.9 707.7 715.5 727.3 13007.3 13938.4 13947.8 14128.4 14362.5 700.2 705.1 708.2 708.6 713.1 5664.1 5730.2 5742.6 5928.1 6012.0 108474.0 110776.0 112704.4 112764.0 119282.4 96554.0 98685.0 98930.5 104201.0 104786.0 83823.0 84636.6 86190.6 87882.0 89258.6 11314.8 12432.1 12624.7 12691.9 12819.4 38318.6 38469.6 38571.4 40040.0 41348.4 70351.0 70748.6 70832.6 70885.6 75432.0 20283.3 20395.2 20412.6 20550.7 20692.7 22251.4 22491.0 22928.2 23338.4 23340.4 17721.4 17833.6 17836.7 18048.1 18832.1 18408.0 18551.9 20069.3 20860.3 21016.5 18188.7 18194.8 19352.3 19701.6 19995.8 12668.4 12764.3 13080.5 13353.3 13683.0 14241.9 15033.7 15159.4 15282.3 15312.2 11:45:46 INFO - PID 16051 | -------- Summary: end -------- 11:45:46 INFO - PID 16051 | 11:45:46 INFO - TEST-INFO | 16051: exit 0 11:45:46 INFO - TEST-OK | dromaeo_css | took 1112205ms 11:45:46 INFO - TEST-START | kraken 11:45:46 INFO - Initialising browser for kraken test... 11:45:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38297/getInfo.html -profile /tmp/tmppNnvxS/profile 11:45:46 INFO - TEST-INFO | started process 16427 (/builds/slave/test/build/application/firefox/firefox http://localhost:38297/getInfo.html) 11:45:52 INFO - TEST-INFO | 16427: exit 0 11:45:52 INFO - Browser initialized. 11:45:52 INFO - Running cycle 1/1 for kraken test... 11:45:52 INFO - TEST-INFO | started process 16624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppNnvxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:53 INFO - PID 16624 | 11:45:53 INFO - PID 16624 | (/builds/slave/test/build/application/firefox/firefox:16678): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:45:53 INFO - PID 16624 | 11:46:04 INFO - PID 16624 | RSS: Main: 170278912 11:46:04 INFO - PID 16624 | 11:46:06 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38297/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:07 INFO - PID 16624 | RSS: Main: 176050176 11:46:07 INFO - PID 16624 | 11:46:10 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38297/tests/kraken/driver.html?testName=audio-dft) 11:46:11 INFO - PID 16624 | RSS: Main: 178958336 11:46:11 INFO - PID 16624 | 11:46:14 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38297/tests/kraken/driver.html?testName=audio-fft) 11:46:14 INFO - PID 16624 | RSS: Main: 174047232 11:46:14 INFO - PID 16624 | 11:46:17 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38297/tests/kraken/driver.html?testName=audio-oscillator) 11:46:17 INFO - PID 16624 | RSS: Main: 174960640 11:46:17 INFO - PID 16624 | 11:46:19 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:20 INFO - PID 16624 | RSS: Main: 175075328 11:46:20 INFO - PID 16624 | 11:46:23 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38297/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:24 INFO - PID 16624 | RSS: Main: 176136192 11:46:24 INFO - PID 16624 | 11:46:27 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38297/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:28 INFO - PID 16624 | RSS: Main: 176873472 11:46:28 INFO - PID 16624 | 11:46:31 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38297/tests/kraken/driver.html?testName=json-parse-financial) 11:46:31 INFO - PID 16624 | RSS: Main: 176799744 11:46:31 INFO - PID 16624 | 11:46:33 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:34 INFO - PID 16624 | RSS: Main: 176463872 11:46:34 INFO - PID 16624 | 11:46:36 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:36 INFO - PID 16624 | RSS: Main: 173584384 11:46:36 INFO - PID 16624 | 11:46:38 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:39 INFO - PID 16624 | RSS: Main: 173670400 11:46:39 INFO - PID 16624 | 11:46:42 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:42 INFO - PID 16624 | RSS: Main: 174047232 11:46:42 INFO - PID 16624 | 11:46:46 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:46 INFO - PID 16624 | RSS: Main: 174366720 11:46:46 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | Cycle 1(1): loaded http://localhost:38297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38297/tests/kraken/driver.html?testName=ai-astar) 11:46:48 INFO - PID 16624 | RSS: Main: 175833088 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | __start_tp_report 11:46:48 INFO - PID 16624 | _x_x_mozilla_page_load 11:46:48 INFO - PID 16624 | _x_x_mozilla_page_load_details 11:46:48 INFO - PID 16624 | |i|pagename|runs| 11:46:48 INFO - PID 16624 | |0;ai-astar;102;107;100;107;109;107;110;98;109;108 11:46:48 INFO - PID 16624 | |1;audio-beat-detection;148;118;138;177;118;146;146;118;173;120 11:46:48 INFO - PID 16624 | |2;audio-dft;163;162;162;162;165;162;163;166;171;163 11:46:48 INFO - PID 16624 | |3;audio-fft;75;75;76;176;76;75;79;75;159;84 11:46:48 INFO - PID 16624 | |4;audio-oscillator;81;80;134;88;81;79;133;79;79;131 11:46:48 INFO - PID 16624 | |5;imaging-gaussian-blur;114;114;116;115;117;117;117;117;118;117 11:46:48 INFO - PID 16624 | |6;imaging-darkroom;151;152;150;150;150;151;151;149;149;150 11:46:48 INFO - PID 16624 | |7;imaging-desaturate;95;96;94;94;98;95;93;110;97;99 11:46:48 INFO - PID 16624 | |8;json-parse-financial;53;53;53;54;54;53;53;54;53;53 11:46:48 INFO - PID 16624 | |9;json-stringify-tinderbox;62;55;55;56;55;55;58;61;55;56 11:46:48 INFO - PID 16624 | |10;stanford-crypto-aes;77;77;76;78;76;75;84;84;76;76 11:46:48 INFO - PID 16624 | |11;stanford-crypto-ccm;128;120;120;119;120;121;119;117;120;164 11:46:48 INFO - PID 16624 | |12;stanford-crypto-pbkdf2;179;177;204;192;171;185;197;176;175;174 11:46:48 INFO - PID 16624 | |13;stanford-crypto-sha256-iterative;69;67;66;67;66;74;67;78;71;71 11:46:48 INFO - PID 16624 | __end_tp_report 11:46:48 INFO - PID 16624 | __start_cc_report 11:46:48 INFO - PID 16624 | _x_x_mozilla_cycle_collect,988 11:46:48 INFO - PID 16624 | __end_cc_report 11:46:48 INFO - PID 16624 | __startTimestamp1503082008823__endTimestamp 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | ------- Summary: start ------- 11:46:48 INFO - PID 16624 | Number of tests: 14 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#0] ai-astar Cycles:10 Average:105.70 Median:108.50 stddev:4.16 (3.8%) stddev-sans-first:4.20 11:46:48 INFO - PID 16624 | Values: 102.0 107.0 100.0 107.0 109.0 107.0 110.0 98.0 109.0 108.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:146.00 stddev:22.24 (15.2%) stddev-sans-first:23.40 11:46:48 INFO - PID 16624 | Values: 148.0 118.0 138.0 177.0 118.0 146.0 146.0 118.0 173.0 120.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.85 (1.7%) stddev-sans-first:3.00 11:46:48 INFO - PID 16624 | Values: 163.0 162.0 162.0 162.0 165.0 162.0 163.0 166.0 171.0 163.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:38.52 (51.0%) stddev-sans-first:40.17 11:46:48 INFO - PID 16624 | Values: 75.0 75.0 76.0 176.0 76.0 75.0 79.0 75.0 159.0 84.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.50 stddev:25.11 (31.6%) stddev-sans-first:25.99 11:46:48 INFO - PID 16624 | Values: 81.0 80.0 134.0 88.0 81.0 79.0 133.0 79.0 79.0 131.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:117.00 stddev:1.40 (1.2%) stddev-sans-first:1.24 11:46:48 INFO - PID 16624 | Values: 114.0 114.0 116.0 115.0 117.0 117.0 117.0 117.0 118.0 117.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 11:46:48 INFO - PID 16624 | Values: 151.0 152.0 150.0 150.0 150.0 151.0 151.0 149.0 149.0 150.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:95.50 stddev:4.91 (5.1%) stddev-sans-first:5.15 11:46:48 INFO - PID 16624 | Values: 95.0 96.0 94.0 94.0 98.0 95.0 93.0 110.0 97.0 99.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 11:46:48 INFO - PID 16624 | Values: 53.0 53.0 53.0 54.0 54.0 53.0 53.0 54.0 53.0 53.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:2.66 (4.7%) stddev-sans-first:2.05 11:46:48 INFO - PID 16624 | Values: 62.0 55.0 55.0 56.0 55.0 55.0 58.0 61.0 55.0 56.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:3.31 (4.3%) stddev-sans-first:3.50 11:46:48 INFO - PID 16624 | Values: 77.0 77.0 76.0 78.0 76.0 75.0 84.0 84.0 76.0 76.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:120.00 stddev:14.07 (11.7%) stddev-sans-first:14.88 11:46:48 INFO - PID 16624 | Values: 128.0 120.0 120.0 119.0 120.0 121.0 119.0 117.0 120.0 164.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:182.00 stddev:11.12 (6.1%) stddev-sans-first:11.70 11:46:48 INFO - PID 16624 | Values: 179.0 177.0 204.0 192.0 171.0 185.0 197.0 176.0 175.0 174.0 11:46:48 INFO - PID 16624 | 11:46:48 INFO - PID 16624 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:3.95 (5.6%) stddev-sans-first:4.18 11:46:48 INFO - PID 16624 | Values: 69.0 67.0 66.0 67.0 66.0 74.0 67.0 78.0 71.0 71.0 11:46:48 INFO - PID 16624 | -------- Summary: end -------- 11:46:48 INFO - PID 16624 | 11:46:49 INFO - PID 16624 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:46:49 INFO - TEST-INFO | 16624: exit 0 11:46:49 INFO - TEST-OK | kraken | took 62852ms 11:46:49 INFO - SUITE-END | took 1175s 11:46:49 INFO - Completed test suite (00:19:35) 11:46:49 INFO - javascript benchmark 11:46:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8578.012188868755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.343047959927, 3144.63836658784, 3168.9207769805753, 3194.664560221176, 3203.2152122729935, 6099.451049405553, 6151.846203844906, 6181.6600086995195, 6260.060990851374, 6324.430801227889, 6197.2563292404975, 6226.84432889178, 6291.1821463209835, 6293.24481062272, 6314.1475900753385, 5548.112302031675, 5696.544276457894, 5775.855603609912, 5783.450572195656, 5820.941790582104, 5648.519875810561, 5648.858778530549, 5649.830505084834, 5654.236678048473, 5666.914996275059, 5681.545476361881, 5742.770289188427, 5749.712514374285, 5750.798722044729, 5770.336411312711, 5666.9716651416475, 5673.404292549264, 5751.597388182787, 5759.5968282220265, 5760.942390576124, 5491.341039075336, 5564.86087847803, 5635.154726790973, 5699.914501282484, 5707.74315155819, 6150.7232174552255, 6177.1969643945995, 6178.84552886177, 6223.471004964584, 6241.7191226394925, 6615.801525954229, 6671.232808227068, 6726.192856857208, 6726.3609957054005, 6738.056672065914, 6674.799756007279, 6684.766033188864, 6711.295313992009, 6788.49086318528, 6795.93204067958, 6021.187139736167, 6109.175261339751, 6168.722407491674, 6207.844803879894, 6298.968505157491, 6796.35434633709, 6842.623655698885, 6845.281245469254, 6855.314468553105, 6855.931440685629, 6382.585131966407, 6456.192975878015, 6530.967345163243, 6532.836679082966, 6539.0, 6608.0, 6631.204255489372, 6667.466602671871, 6690.632015239111, 6719.260881303053, 6457.192850893638, 6568.737250510022, 6629.767958121539, 6671.733130674718, 6684.197896252481, 6641.33586641332, 6641.601503909685, 6643.0, 6645.833854153588, 6654.301298363699, 5384.192371144281, 5391.218273350342, 5435.918461223085, 5463.7814487420055, 5482.753276102585, 4605.078984203173, 4621.930671039937, 4683.906321873544, 4689.859304220879, 4701.0, 5682.7442765075675, 5765.048766953406, 5772.9711351442975, 5828.795992140254, 5832.504237139806, 6792.660366981631, 6802.489813263926, 6811.4210292124735, 6819.965900170468, 6830.965845170742, 5758.165066065397, 5761.164631128463, 5828.358880523139, 5839.124131380327, 5845.941540584625, 5847.56143289255, 5866.208061911672, 5951.821445356646, 5962.314333851663, 5967.254093238345, 6366.076918846741, 6460.870782584416, 6467.223933128054, 6468.870622587522, 6546.0508226307875, 6588.374104460068, 6657.567258128206, 6660.433863121689, 6664.733410663519, 6670.533062685566, 6340.1123842661145, 6439.7424103035355, 6447.451966582706, 6454.257760357619, 6455.580387274812, 6559.409653131241, 6559.868802623825, 6569.277379488348, 6570.638614876037, 6576.309487503743, 6391.616503009835, 6644.501662375244, 6683.565568238049, 6695.631740254138, 6709.664516774239, 6415.358464153547, 6463.709133089116, 6492.870142597028, 6494.090827284279, 6512.6092434454085, 6398.200224971879, 6445.323241059808, 6470.288268290578, 6573.244076931214, 6574.572652777745, 6357.8728425432155, 6376.585521941059, 6389.16940797712, 6390.7443702251385, 6395.520335974914, 6287.497000239879, 6429.067785171031, 6498.090267362479, 6518.2504012037325, 6664.166979127609, 6351.777687780906, 6356.451460862496, 6431.517636177212, 6437.098806167047, 6439.0], "value": 6082.959792120974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6392623319504, 835.5446281776432, 862.3790870573187, 885.7431344909976, 886.8625363068722, 38362.232755344914, 39060.80469597651, 39149.21701565967, 39168.0, 39206.607933920655, 36153.0, 36484.27031459369, 36532.81733591335, 36540.81729591355, 36546.0, 6771.356721111487, 6866.210385805622, 6872.072270243503, 6879.0, 6883.174019117713, 6791.083203767503, 6851.691673874688, 6860.622665753382, 6864.107666003412, 6867.381935625793, 7530.736424225153, 7692.4615276930635, 7739.110002349717, 7740.148583655793, 7753.379729621617, 7643.159252482223, 7701.422393320523, 7705.460617756759, 7705.922940770604, 7710.267524585155, 7386.0, 7512.248775122499, 7599.050118735158, 7604.201558836353, 7606.0, 36486.45270320947, 36908.81545592282, 36929.0, 36951.445728314095, 36957.81521092404, 3587.3901436755814, 3630.09247688078, 3633.364161271767, 3634.0, 3640.1263696712863, 30010.69989300101, 30075.849620751975, 30079.548806767914, 30095.097147085624, 30223.546646800314, 4928.408590969071, 4960.156773348539, 4988.800447982077, 4990.101781679296, 5009.098362294785, 224029.0, 227202.0, 228256.0, 228523.0, 229060.0, 47658.0, 47768.76115619469, 47838.28242576364, 47908.28137577939, 48144.277835832494, 49353.259701104515, 49422.25866612004, 49552.50447495551, 49556.0, 49622.25566616504, 15530.378784848479, 15728.68542629141, 15842.0, 15856.603584910239, 15859.762103568455, 13008.349582520836, 13008.674783130307, 13015.479380824661, 13027.804582931263, 13032.348382580833, 13897.374618142208, 14094.154350738989, 14104.153750774987, 14194.0, 14333.56999290023, 5804.82585522435, 5842.2405087338375, 5881.764729410861, 5993.760249590055, 6061.909071363933, 1004.2066767253933, 1015.8374660054355, 1022.1669339488293, 1035.4563853976572, 1035.746242170658, 22725.545489090455, 22873.19943801959, 23005.194818181284, 23073.769262307498, 23264.65103023456, 1128.311729844794, 1131.637875879727, 1135.392564977733, 1137.5506674863382, 1148.8736239013701, 12155.63533093991, 12304.384780760925, 12386.5664701735, 12422.875771242172, 12459.501619935101, 222195.0, 223019.0, 223632.0, 223865.0, 229123.0, 51665.225021624705, 51933.22100168501, 52160.73919630377, 52201.47798521966, 55451.44548554543, 1482.6886353865593, 1502.684436268374, 1515.4923100761148, 1516.2646116633423, 1519.8176218853807, 27273.863630682514, 27597.86201068982, 27767.0, 27914.0, 27985.160445186677, 49107.26339104845, 49563.0, 49613.25580116373, 49633.0, 49668.25497617611, 205300.0, 206378.0, 206567.0, 206726.0, 206765.0, 35684.46473302851, 35792.46311305385, 35898.10254743652, 36081.0, 36166.457503138, 41613.16773664449, 43814.56185438232, 44098.77950610226, 44107.55892441035, 44127.77936110299, 31646.0, 32284.515732264506, 32338.35323293568, 32528.0, 32631.836840815646, 32326.676733232365, 32613.205665270107, 32672.0, 33166.502502462965, 33571.49642755409, 35785.64214357823, 35800.28399432049, 35811.64188358083, 36120.63879361278, 36122.27755444929, 33475.4978675325, 33700.49449258312, 33870.66129338773, 34104.0, 34274.82862585671, 24308.392290192885, 24544.509109817347, 25142.371440714127, 25191.37021574475, 25307.240782776546], "value": 17329.919781580506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.5411017076171, 569.831899589621, 571.1575426246286, 571.6084482129739, 581.7120525339957, 21545.67681484777, 22416.0, 22497.0, 22523.999999999978, 22765.43086422836, 26392.86803565984, 26660.066897658588, 26769.598456023174, 26789.86605066972, 26823.19530414086, 6425.421712045927, 6583.440407565338, 6584.9012264816065, 6608.405243528082, 6612.669366531678, 6277.278113017016, 6547.0, 6567.310432404601, 6576.046473261375, 6583.0, 6525.184351956005, 6533.771318003871, 6534.509911756637, 6540.149780528548, 6541.051547525606, 6525.412712855842, 6534.150560427114, 6535.313792051814, 6537.836554086139, 6538.313477084933, 6037.154798328237, 6040.09398590215, 6046.879062418771, 6062.696865156725, 6082.908756368658, 29724.851375742983, 30062.098137055924, 30184.698153018628, 30191.396172076657, 30326.090217293517, 1937.9709304360447, 1957.3834242213657, 1961.9117139728603, 1968.1045124468333, 1968.3897991622644, 18998.24007039717, 19520.023998800145, 19544.70682939757, 19547.21811127553, 19582.21671133153, 2416.4321384474633, 2427.9150229741877, 2455.1652438170927, 2507.0723832182025, 2509.0214816221687, 130999.0, 133930.0, 134128.0, 134177.0, 134599.32700336532, 14925.70148597022, 15118.94167408271, 15197.696046079016, 15429.922850385676, 15871.365145394286, 23358.64962025571, 23728.64407033896, 24313.270601881974, 24315.63526547103, 24373.63439548408, 10498.10766084876, 10548.630797922036, 10662.360258384522, 10730.2488825783, 10778.676639700665, 9792.314537982415, 9801.264905132, 9853.802923941625, 9907.554160062815, 9909.900900990899, 9488.861336639648, 9826.4104153751, 9876.60493580263, 9923.206143508647, 9970.850437243447, 2847.4589827932627, 2860.3850172213074, 2872.9281767955968, 2899.362140329124, 2956.645202575705, 962.8748262725801, 977.8777652793401, 980.9950950245203, 993.7863359377768, 998.9051040151174, 20197.384209263222, 20264.594708105757, 20664.690029649566, 20779.79220207809, 21261.0, 1039.0804138337626, 1047.041956609709, 1048.9685309440729, 1054.4516851237468, 1057.2493529593921, 11164.720881978015, 11195.60815371458, 11373.374464404536, 11467.598634047768, 11531.308121512737, 506463.0, 522059.0, 522197.0, 522833.0, 523499.0, 104038.0, 107139.46430267798, 107159.0, 107898.46050769853, 112444.0, 1206.5776978057609, 1207.2032458577296, 1236.7526494701096, 1242.465739731924, 1246.6073186946082, 17525.737113943556, 17711.82288177102, 17820.198091086193, 18084.005379703718, 18157.36449224271, 54433.72783136217, 55130.72434637801, 55266.44733552613, 55283.0, 56750.14874776964, 65661.67169164124, 66046.66976665086, 66404.33595664175, 67016.32983670296, 67436.6628166856, 14435.78346324785, 14661.560153195422, 14785.704285914006, 14803.555893323217, 14908.701825963637, 23457.41356466102, 23673.881630591735, 23697.40756481102, 23716.762832371456, 23882.52234955326, 18054.90972545129, 18702.719459207852, 18817.811821882155, 18846.71729924025, 18883.05584720731, 17468.0, 18175.545611359823, 18566.0, 18708.532286692942, 18895.149718262986, 20078.096485657887, 20344.69482957727, 20394.490137746674, 20454.693179602615, 20474.692879607115, 14910.0, 15064.623384415478, 15189.468368607046, 15295.388184472497, 15323.923380383027, 19036.524086897938, 19044.0, 19069.14188861477, 19145.234190632218, 19490.90254548718], "value": 12177.455576093811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.8312710911136, 1398.7971744097106, 1404.3399602186971, 1410.428776345579, 1411.1815147214616, 13288.269145197022, 13927.37326820293, 13931.860681393184, 13942.95427842912, 13945.233012184339, 13823.37794799234, 14058.156510609371, 14132.929335353334, 14169.645758856033, 14294.285285735723, 2654.0578094776365, 2711.376383431812, 2719.646445962022, 2721.6053672217517, 2728.945421091577, 2563.7564431378987, 2675.785937125025, 2724.632174656416, 2727.304537342975, 2727.931801704963, 2554.4763323518728, 2654.6416233808477, 2731.399092199713, 2731.986340068297, 2740.849253291068, 2666.0, 2707.44497378037, 2732.0437846753675, 2733.3576609496754, 2733.72662733728, 2551.170869467412, 2564.5896656534865, 2587.2496975876975, 2692.4749673813612, 2701.2706569226393, 13572.45710171592, 13843.930780346134, 13845.584632461043, 13850.09974351664, 13861.4455421783, 7315.707371705125, 7595.658195381166, 7627.847443051163, 7629.122650895107, 7630.38956883448, 4764.7617619119255, 4916.631252656065, 5009.273655319958, 5021.297018417425, 5023.572996295319, 1771.5836778357075, 1790.176518801353, 1822.1526989949605, 1856.628674265139, 1862.3425151615074, 22006.88996555023, 22177.223797167022, 22181.0, 22200.555988880133, 22203.44491387712, 6332.873342533124, 6343.984495353612, 6386.329435409308, 6476.6114033158165, 6488.253850807123, 15220.847791522165, 15280.159591222367, 15367.0, 15397.23013849303, 15406.614834629225, 7241.782746517613, 7443.144038435541, 7444.367228785505, 7447.180810110884, 7448.590327532038, 6734.528582999143, 6861.691223894937, 6891.483138764613, 6987.441004719611, 7044.859102818017, 4964.60283177345, 5108.901586158993, 5121.308623335802, 5124.8206312778875, 5129.281900533928, 1342.6777573382317, 1488.6352843553398, 1498.4755335632442, 1499.3477837140879, 1519.5517322389921, 712.291270186168, 863.7797361672859, 864.8832407625016, 875.6147295190096, 880.7489865388334, 8102.865598816171, 8147.103818579952, 8199.098099209083, 8286.958565207256, 8335.499870007698, 970.815545046439, 990.5592011554933, 1021.7394564386034, 1022.2741853284251, 1025.9384436933808, 4865.927011094836, 5212.087884620177, 5255.500727430888, 5462.016836969384, 5516.7517461714315, 18037.368692095715, 18060.458186254433, 18610.720839187423, 18851.3976312015, 19106.0, 18223.908880455514, 18692.719609205873, 18740.25038998425, 18921.81078189228, 19089.713654295196, 10218.948905255425, 10392.58429662805, 10421.5831366746, 10483.633072842415, 10490.16078713701, 7391.445641576795, 7501.549907005378, 7507.737229196952, 7519.849603008019, 7534.284242996907, 15964.281607327466, 16317.755233671267, 16416.835831641532, 16578.253978570752, 16854.15729213559, 16811.0, 16842.57893552671, 16859.578510537336, 16884.409045683344, 16958.830411695726, 10177.134943529883, 10209.132223761064, 10256.230782691477, 10294.845577316197, 10306.072453478922, 12711.300878451404, 12755.298458584495, 12824.551140710031, 12893.871061289266, 12906.677333066373, 10566.947165264432, 10682.519286632276, 10693.037626613643, 10863.076638485818, 10915.454227288445, 10483.0, 10492.108170805566, 10495.842562361724, 10499.422531760521, 10624.309419887682, 9530.904690953003, 9688.806223875625, 9710.077542633438, 9710.514474276399, 9723.222142228746, 6983.336583024605, 6984.755533556301, 6994.825129371807, 7087.539309944837, 7103.786886393416, 7097.893531597134, 7148.17795953472, 7169.462290328351, 7171.677274522554, 7312.670929808065], "value": 6296.47617050226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.6538337123833, 501.8946021335519, 527.6174773289365, 529.3058333084599, 531.7367902888069, 6378.298387177419, 6397.1683681121385, 6412.390822871826, 6419.358064193579, 6468.870622587546, 6074.48366888815, 6206.162168107304, 6246.281677607077, 6279.623222606647, 6298.937010629892, 5000.999800039988, 5012.323336349601, 5062.392512898457, 5064.0, 5076.79692812288, 4987.127252730776, 5006.54941055305, 5028.145215313405, 5060.316857224265, 5061.671631049721, 4860.927086093711, 5011.173156429185, 5029.497050294978, 5054.646174767768, 5059.709774007623, 5026.6983980960895, 5049.545540901318, 5050.49495050492, 5066.442691303953, 5072.72100034498, 4519.728816271035, 4531.229690952546, 4531.342955271467, 4539.546045395434, 4541.182587134314, 6158.784442544489, 6174.351693072253, 6197.25632924052, 6217.191765070557, 6230.937690623081, 5796.000379868939, 5796.710164491758, 5807.912881306742, 5809.941900580982, 5821.22452651941, 6556.213254409501, 6612.140421745143, 6612.702428390686, 6622.53642245043, 6709.664516774142, 4925.7783399747095, 4929.0, 4929.950700492985, 4945.604351651859, 4952.232403977389, 6995.216219863953, 7067.22260551339, 7087.929120708778, 7094.8293531566715, 7099.751508697171, 5045.562014825757, 5056.747162641853, 5072.873178170576, 5080.6028342205445, 5130.127878260705, 5153.0, 5156.149235376196, 5159.2003239497935, 5161.245176639885, 5164.354455693038, 5780.855478613068, 5788.623739457006, 5798.855028624318, 5826.329972053183, 5846.064629659234, 6628.701708423133, 6660.833479162963, 6686.264510903797, 6694.263631000586, 6708.161479815023, 1678.261564911435, 1731.3638611512001, 1748.6273275478688, 1768.51365874383, 1776.2539733311783, 1197.1141355396944, 1239.6157191270736, 1239.9708242158986, 1244.7323825377407, 1257.1891130220956, 5842.8539286517325, 5844.736986835517, 5852.853678658068, 5861.824145275648, 5877.147813567094, 6646.933530664728, 6830.31696830313, 6832.145981752281, 6847.246802851682, 6882.827929301808, 5873.0047675684855, 5889.322727886348, 5909.2908850938165, 5917.171595976567, 5918.0, 3664.120611053328, 3685.3182161300247, 3694.18727879866, 3696.392069449798, 3699.8150092495266, 6663.600183988976, 6666.0, 6680.298568650222, 6693.732250710014, 6701.095352127498, 7074.398676112485, 7075.823104422328, 7089.751858685025, 7097.254788247263, 7098.290170982964, 6617.073609694647, 6620.63586502747, 6650.401463868275, 6662.400383965466, 6669.233038200572, 6863.931360686329, 6898.482613803884, 6901.75843845463, 6926.826829329307, 6943.68753406108, 6759.594424334556, 6814.284500127415, 6814.727410903508, 6819.181698196248, 6829.658517074027, 6539.444147247537, 6568.704408301543, 6585.0, 6621.470282377494, 6643.800685979429, 5473.042217611982, 5543.72281385921, 5561.805336813192, 5574.9442505574425, 5580.190872323409, 6869.0, 6906.8618627628175, 6926.515143939876, 6942.271061538668, 6965.686544105629, 6612.867742645217, 6631.336866313523, 6637.084120368812, 6678.365555272241, 6693.163354580677, 6469.353064693493, 6624.0395142705, 6656.7004484797335, 6687.699053542505, 6710.932890671031, 6366.458850997532, 6550.344965503412, 6567.934320656732, 6599.967000164968, 6613.0, 6652.0, 6654.933450665431, 6691.0, 6714.563553369211, 6749.156355455568, 6395.16862807832, 6430.2605200400685, 6463.798530954917, 6507.381798729113, 6513.3161018094315], "value": 5156.916217887919, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.2560500389675, 915.9587818548167, 928.7353104365253, 935.7660584853786, 936.3492372800897, 19179.616407671838, 19959.501012474695, 19960.20159193634, 19979.100940457676, 22615.773842261573, 21872.0, 22125.446863828412, 22227.66658500124, 22285.888570557167, 22367.0, 1024.4365598920601, 1055.8521806947033, 1056.8837427882927, 1057.973550661232, 1058.4072919165292, 1009.9849651100634, 1054.098745572536, 1056.9947150264277, 1060.2790102730141, 1062.8193207154802, 1115.1190559458018, 1118.776244751049, 1118.7874303882236, 1118.9160812939062, 1119.0879433261907, 1095.8411030400587, 1102.581019212694, 1105.237386203517, 1105.4969988655143, 1111.7887601355717, 804.1717031457608, 806.1897792718339, 809.3929552835374, 810.0360570920585, 811.5698679699768, 20337.0, 20501.17995280187, 20562.074706638236, 20593.38219853407, 21521.0, 21420.46448838776, 21620.0, 21763.782362176335, 22054.448638783997, 22290.88854555733, 16977.405790797264, 17046.48860534186, 17085.889417187842, 17248.741268880978, 17452.738208926876, 3739.6821270192067, 3748.7188460865545, 3755.906102347436, 3758.586555478895, 3764.134249122717, 124572.37713811464, 124978.0, 125667.0, 127299.36350318282, 130374.0, 16839.74740378895, 16968.57578560546, 17270.913645431694, 17325.133743312785, 17412.564685882702, 31121.844390778355, 31541.84229078886, 31637.20906977344, 32884.83557582197, 33083.3383332332, 7899.407544434191, 8235.876461853077, 8754.86867696985, 8841.204291613785, 8982.461052336881, 4330.545292744217, 4429.092036132585, 4432.0, 4434.268345722984, 4436.800343984464, 5368.1679339702405, 5509.724513774296, 5518.227448157261, 5943.58394912352, 6106.847328816815, 1106.502074066657, 1106.983395249072, 1132.4337831084458, 1138.3738943580997, 1142.5829572206085, 682.8019874236415, 701.8806802843427, 707.706301884712, 715.5170260074428, 727.3126895084094, 13007.284599347127, 13938.442462301597, 13947.790783138262, 14128.43486260538, 14362.491938346531, 700.2017699822206, 705.1009962298111, 708.1855865754424, 708.574855086954, 713.115736486763, 5664.065429204217, 5730.19777231188, 5742.626729262584, 5928.140419639214, 6011.9699401503585, 108474.0, 110776.0, 112704.43647781873, 112764.0, 119282.4035879815, 96554.0, 98685.0, 98930.50534747425, 104201.0, 104786.0, 83823.0, 84636.57681711552, 86190.56904715311, 87882.0, 89258.55370723235, 11314.773704526027, 12432.12975091735, 12624.74750505003, 12691.93654031724, 12819.42312595954, 38318.61681383262, 38469.6153038466, 38571.42142867803, 40040.0, 41348.379774302804, 70351.0, 70748.64625676839, 70832.64583677049, 70885.6455717718, 75432.0, 20283.290084846958, 20395.18419263213, 20412.591748164657, 20550.691739623617, 20692.689609655565, 22251.443713906636, 22490.987905544618, 22928.19751308696, 23338.416539586648, 23340.416489587216, 17721.379751708628, 17833.643327133126, 17836.732449013536, 18048.097595120453, 18832.058397080364, 18408.0, 18551.90724046371, 20069.29757458482, 20860.269890554366, 21016.474588135417, 18188.72716909221, 18194.818051819842, 19352.32266870653, 19701.605967880274, 19995.800041999977, 12668.366581671064, 12764.29796361209, 13080.476780928657, 13353.332333383487, 13683.04218704681, 14241.860651147676, 15033.699326013637, 15159.393624254906, 15282.312295946931, 15312.234388280764], "value": 9557.345603595191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 100.0, 107.0, 109.0, 107.0, 110.0, 98.0, 109.0, 108.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 138.0, 177.0, 118.0, 146.0, 146.0, 118.0, 173.0, 120.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 165.0, 162.0, 163.0, 166.0, 171.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 176.0, 76.0, 75.0, 79.0, 75.0, 159.0, 84.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 134.0, 88.0, 81.0, 79.0, 133.0, 79.0, 79.0, 131.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 115.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 150.0, 150.0, 151.0, 151.0, 149.0, 149.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 98.0, 95.0, 93.0, 110.0, 97.0, 99.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 55.0, 56.0, 55.0, 55.0, 58.0, 61.0, 55.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 78.0, 76.0, 75.0, 84.0, 84.0, 76.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 120.0, 119.0, 120.0, 121.0, 119.0, 117.0, 120.0, 164.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 204.0, 192.0, 171.0, 185.0, 197.0, 176.0, 175.0, 174.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 67.0, 66.0, 74.0, 67.0, 78.0, 71.0, 71.0], "value": 69.6, "unit": "score"}]}]} 11:46:50 INFO - Return code: 0 11:46:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:46:50 INFO - # TBPL SUCCESS # 11:46:50 INFO - Running post-action listener: _package_coverage_data 11:46:50 INFO - Running post-action listener: _resource_record_post_action 11:46:50 INFO - [mozharness: 2017-08-18 18:46:50.113539Z] Finished run-tests step (success) 11:46:50 INFO - Running post-run listener: _resource_record_post_run 11:46:50 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432861184; Read time: 20; Write time: 377252 11:46:50 INFO - TinderboxPrint: CPU usage
13.1% 11:46:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:46:50 INFO - TinderboxPrint: I/O write bytes / time
432,861,184 / 377,252 11:46:50 INFO - TinderboxPrint: CPU idle
8,268.2 (86.9%) 11:46:50 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 11:46:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:46:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109125632; Read time: 0; Write time: 125024 11:46:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:46:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 323735552; Read time: 0; Write time: 252228 11:46:50 INFO - Running post-run listener: _upload_blobber_files 11:46:50 INFO - Blob upload gear active. 11:46:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:50 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 11:46:50 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'] 11:46:50 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 11:46:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:46:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:46:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:52 INFO - (blobuploader) - INFO - Done attempting. 11:46:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:46:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:46:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:53 INFO - (blobuploader) - INFO - Done attempting. 11:46:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:46:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:59 INFO - (blobuploader) - INFO - Done attempting. 11:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:00 INFO - (blobuploader) - INFO - Done attempting. 11:47:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:00 INFO - Return code: 0 11:47:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b97cddcdfb6bc34b527409c4d631920947d7a3f12cce49d89773b47dfa218afad6dd8fe0bcd00bebb79dff80826659d01ebda36f67afd63f68e9b8de1588f8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dea14d00b28e8093e507e41bdd5c472e598e4bbc18d28a17d93e2d6e67bae131b9ff51b569c743981f65418a44bc736b1bee2c24887706fd55e16277f2acaf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0c7b282108282915aa5b868c3af66eed069b2cd23cde6d491e2269b8efdfa436b1b90564f4d2eb3f3fdeae78a2800a9ac1151e226d8f2426926a9920f365983", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35883d55ca5c91ffff850309dae7f32878cbfda2e430ced18749a19b0f7d73fb676fa9baafd2a1642e4c2b5f3fe24a85106c63f391f42d0e9567c58332eaad9a"} 11:47:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:00 INFO - Contents: 11:47:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b97cddcdfb6bc34b527409c4d631920947d7a3f12cce49d89773b47dfa218afad6dd8fe0bcd00bebb79dff80826659d01ebda36f67afd63f68e9b8de1588f8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dea14d00b28e8093e507e41bdd5c472e598e4bbc18d28a17d93e2d6e67bae131b9ff51b569c743981f65418a44bc736b1bee2c24887706fd55e16277f2acaf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0c7b282108282915aa5b868c3af66eed069b2cd23cde6d491e2269b8efdfa436b1b90564f4d2eb3f3fdeae78a2800a9ac1151e226d8f2426926a9920f365983", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35883d55ca5c91ffff850309dae7f32878cbfda2e430ced18749a19b0f7d73fb676fa9baafd2a1642e4c2b5f3fe24a85106c63f391f42d0e9567c58332eaad9a"} 11:47:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:00 INFO - Copying logs to upload dir... 11:47:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.738419 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-18 11:47:00.864954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 11:47:00.869309) ========= 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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b97cddcdfb6bc34b527409c4d631920947d7a3f12cce49d89773b47dfa218afad6dd8fe0bcd00bebb79dff80826659d01ebda36f67afd63f68e9b8de1588f8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dea14d00b28e8093e507e41bdd5c472e598e4bbc18d28a17d93e2d6e67bae131b9ff51b569c743981f65418a44bc736b1bee2c24887706fd55e16277f2acaf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0c7b282108282915aa5b868c3af66eed069b2cd23cde6d491e2269b8efdfa436b1b90564f4d2eb3f3fdeae78a2800a9ac1151e226d8f2426926a9920f365983", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35883d55ca5c91ffff850309dae7f32878cbfda2e430ced18749a19b0f7d73fb676fa9baafd2a1642e4c2b5f3fe24a85106c63f391f42d0e9567c58332eaad9a"} build_url:https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/XXL59VVeTnurjyY8BNj5uA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b97cddcdfb6bc34b527409c4d631920947d7a3f12cce49d89773b47dfa218afad6dd8fe0bcd00bebb79dff80826659d01ebda36f67afd63f68e9b8de1588f8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dea14d00b28e8093e507e41bdd5c472e598e4bbc18d28a17d93e2d6e67bae131b9ff51b569c743981f65418a44bc736b1bee2c24887706fd55e16277f2acaf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0c7b282108282915aa5b868c3af66eed069b2cd23cde6d491e2269b8efdfa436b1b90564f4d2eb3f3fdeae78a2800a9ac1151e226d8f2426926a9920f365983", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35883d55ca5c91ffff850309dae7f32878cbfda2e430ced18749a19b0f7d73fb676fa9baafd2a1642e4c2b5f3fe24a85106c63f391f42d0e9567c58332eaad9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 11:47:00.898609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:47:00.898931) ========= 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=836cfdc75598d54cb747368e000001a9-1503080762.742551-1286122776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:47:00.979732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 11:47:00.983068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 11:47:00.983360) ========= ========= Total master_lag: 0.20 =========