builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1499773392.48 results: success (0) revision: b07db5d650b7056c78ba0dbc409d060ec4e922cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.476631) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.477097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.477378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.493629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.493971) ========= 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=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-11 04:43:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-07-11 04:43:12 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.233939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.748096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.748442) ========= 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=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018817 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.797715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:12.801253) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b07db5d650b7056c78ba0dbc409d060ec4e922cd --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 b07db5d650b7056c78ba0dbc409d060ec4e922cd --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=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-11 04:43:12,804 truncating revision to first 12 chars 2017-07-11 04:43:12,804 Setting DEBUG logging. 2017-07-11 04:43:12,804 attempt 1/10 2017-07-11 04:43:12,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b07db5d650b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-11 04:43:13,253 unpacking tar archive at: mozilla-central-b07db5d650b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:13.600070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:13.600445) ========= script_repo_revision: b07db5d650b7056c78ba0dbc409d060ec4e922cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:13.600851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:13.601145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-11 04:43:13.609578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-11 04:43:13.609971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:43:13 INFO - MultiFileLogger online at 20170711 04:43:13 in /builds/slave/test 04:43:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:43:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:13 INFO - {'append_to_log': False, 04:43:13 INFO - 'base_work_dir': '/builds/slave/test', 04:43:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:43:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:13 INFO - 'branch': 'Firefox-Non-PGO', 04:43:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:13 INFO - 'code_coverage': False, 04:43:13 INFO - 'config_files': ('talos/linux_config.py',), 04:43:13 INFO - 'default_actions': ('clobber', 04:43:13 INFO - 'read-buildbot-config', 04:43:13 INFO - 'download-and-extract', 04:43:13 INFO - 'populate-webroot', 04:43:13 INFO - 'create-virtualenv', 04:43:13 INFO - 'install', 04:43:13 INFO - 'setup-mitmproxy', 04:43:13 INFO - 'run-tests'), 04:43:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:13 INFO - 'disable_ccov_upload': False, 04:43:13 INFO - 'download_minidump_stackwalk': True, 04:43:13 INFO - 'download_symbols': 'ondemand', 04:43:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:13 INFO - 'gecko_profile': False, 04:43:13 INFO - 'gecko_profile_interval': 0, 04:43:13 INFO - 'installer_path': 'installer.exe', 04:43:13 INFO - 'log_level': 'info', 04:43:13 INFO - 'log_name': 'talos', 04:43:13 INFO - 'log_to_console': True, 04:43:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:43:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:43:13 INFO - 'opt_config_files': (), 04:43:13 INFO - 'pip_index': False, 04:43:13 INFO - 'suite': 'dromaeojs-e10s', 04:43:13 INFO - 'system_bits': '32', 04:43:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:13 INFO - 'title': 'talos-linux64-ix-010', 04:43:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:13 INFO - 'use_talos_json': True, 04:43:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:13 INFO - 'work_dir': 'build'} 04:43:13 INFO - [mozharness: 2017-07-11 11:43:13.825062Z] Running clobber step. 04:43:13 INFO - Running pre-action listener: _resource_record_pre_action 04:43:13 INFO - Running main action method: clobber 04:43:13 INFO - rmtree: /builds/slave/test/build 04:43:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:14 INFO - Running post-action listener: _resource_record_post_action 04:43:14 INFO - [mozharness: 2017-07-11 11:43:14.810174Z] Finished clobber step (success) 04:43:14 INFO - [mozharness: 2017-07-11 11:43:14.810275Z] Running read-buildbot-config step. 04:43:14 INFO - Running pre-action listener: _resource_record_pre_action 04:43:14 INFO - Running main action method: read_buildbot_config 04:43:14 INFO - Using buildbot properties: 04:43:14 INFO - { 04:43:14 INFO - "project": "", 04:43:14 INFO - "product": "firefox", 04:43:14 INFO - "who": "cbook@mozilla.com", 04:43:14 INFO - "installer_path": "public/build/target.tar.bz2", 04:43:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:43:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:43:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:43:14 INFO - "stage_platform": "linux64", 04:43:14 INFO - "basedir": "/builds/slave/test", 04:43:14 INFO - "buildnumber": 709, 04:43:14 INFO - "platform": "ubuntu64_hw", 04:43:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:43:14 INFO - "slavebuilddir": "test", 04:43:14 INFO - "taskId": "eW-brq-iQkmmoFDYtThLUg", 04:43:14 INFO - "branch": "mozilla-central", 04:43:14 INFO - "script_repo_revision": "production", 04:43:14 INFO - "revision": "b07db5d650b7056c78ba0dbc409d060ec4e922cd", 04:43:14 INFO - "slavename": "talos-linux64-ix-010", 04:43:14 INFO - "repo_path": "mozilla-central" 04:43:14 INFO - } 04:43:14 INFO - Finding installer, test and symbols from parent task. 04:43:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eW-brq-iQkmmoFDYtThLUg'}, attempt #1 04:43:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eW-brq-iQkmmoFDYtThLUg'}, attempt #1 04:43:15 INFO - Task dependencies: D9Mb_MqLSoCn5HSfVGmfbA 04:43:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA'}, attempt #1 04:43:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 04:43:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/test_packages.json 04:43:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.crashreporter-symbols.zip 04:43:16 INFO - Running post-action listener: _resource_record_post_action 04:43:16 INFO - [mozharness: 2017-07-11 11:43:16.161184Z] Finished read-buildbot-config step (success) 04:43:16 INFO - [mozharness: 2017-07-11 11:43:16.161406Z] Running download-and-extract step. 04:43:16 INFO - Running pre-action listener: _resource_record_pre_action 04:43:16 INFO - Running main action method: download_and_extract 04:43:16 INFO - mkdir: /builds/slave/test/build/tests 04:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:16 INFO - trying https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.test_packages.json 04:43:16 INFO - Downloading https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:43:16 INFO - Downloaded 989 bytes. 04:43:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:43:16 INFO - Using the following test package requirements: 04:43:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:43:16 INFO - u'common': [u'target.common.tests.zip'], 04:43:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:43:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:43:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:43:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:43:16 INFO - u'mozbase': [u'target.common.tests.zip'], 04:43:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:43:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:43:16 INFO - u'web-platform': [u'target.common.tests.zip', 04:43:16 INFO - u'target.web-platform.tests.tar.gz'], 04:43:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:43:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip 04:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip into memory 04:43:17 INFO - Content-Length response header: 67420397 04:43:17 INFO - Bytes received: 67420397 04:43:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:43:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip 04:43:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:43:29 INFO - Fetch https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.common.tests.zip into memory 04:43:30 INFO - Content-Length response header: 67420397 04:43:30 INFO - Bytes received: 67420397 04:43:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.talos.tests.zip 04:43:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:43:44 INFO - Fetch https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.talos.tests.zip into memory 04:43:45 INFO - Content-Length response header: 14474423 04:43:45 INFO - Bytes received: 14474423 04:43:45 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')]} 04:43:45 INFO - trying https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 04:43:45 INFO - Downloading https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:43:46 INFO - Downloaded 62237620 bytes. 04:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 04:43:46 INFO - mkdir: /builds/slave/test/properties 04:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:46 INFO - Contents: 04:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 04:43:46 INFO - Running post-action listener: _resource_record_post_action 04:43:46 INFO - Running post-action listener: set_extra_try_arguments 04:43:46 INFO - [mozharness: 2017-07-11 11:43:46.655024Z] Finished download-and-extract step (success) 04:43:46 INFO - [mozharness: 2017-07-11 11:43:46.655122Z] Running populate-webroot step. 04:43:46 INFO - Running pre-action listener: _resource_record_pre_action 04:43:46 INFO - Running main action method: populate_webroot 04:43:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:46 INFO - '--tppagecycles', 04:43:46 INFO - '7'], 04:43:46 INFO - 'tests': ['tsvgm']}}, 04:43:46 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['damp', 'tps']}, 04:43:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'tests': ['damp', 'tps']}, 04:43:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['dromaeo_dom']}, 04:43:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:43:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:43:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:43:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_many_windows', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_many_windows', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_many_windows', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['a11yr', 04:43:46 INFO - 'ts_paint', 04:43:46 INFO - 'tpaint', 04:43:46 INFO - 'sessionrestore', 04:43:46 INFO - 'sessionrestore_no_auto_restore', 04:43:46 INFO - 'tabpaint']}, 04:43:46 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 04:43:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:43:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:43:46 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:43:46 INFO - 'talos_options': ['--mitmproxy', 04:43:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:43:46 INFO - '--firstNonBlankPaint'], 04:43:46 INFO - 'tests': ['quantum_pageload_google', 04:43:46 INFO - 'quantum_pageload_youtube', 04:43:46 INFO - 'quantum_pageload_amazon', 04:43:46 INFO - 'quantum_pageload_facebook']}, 04:43:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['tsvgx', 04:43:46 INFO - 'tsvgr_opacity', 04:43:46 INFO - 'tart', 04:43:46 INFO - 'tscrollx', 04:43:46 INFO - 'cart', 04:43:46 INFO - 'tsvg_static']}, 04:43:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:46 INFO - 'tsvgr_opacity', 04:43:46 INFO - 'tart', 04:43:46 INFO - 'tscrollx', 04:43:46 INFO - 'cart', 04:43:46 INFO - 'tsvg_static']}, 04:43:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'talos_options': ['--disable-e10s'], 04:43:46 INFO - 'tests': ['tp5o']}, 04:43:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'talos_options': ['--disable-e10s', 04:43:46 INFO - '--xperf_path', 04:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:46 INFO - 'tests': ['tp5n']}, 04:43:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:46 INFO - 'talos_options': ['--xperf_path', 04:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:46 INFO - 'tests': ['tp5n']}}, 04:43:46 INFO - 'talos.zip': {'path': '', 04:43:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:46 INFO - Running post-action listener: _resource_record_post_action 04:43:46 INFO - [mozharness: 2017-07-11 11:43:46.672777Z] Finished populate-webroot step (success) 04:43:46 INFO - [mozharness: 2017-07-11 11:43:46.672867Z] Running create-virtualenv step. 04:43:46 INFO - Running pre-action listener: _resource_record_pre_action 04:43:46 INFO - Running main action method: create_virtualenv 04:43:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:46 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 04:43:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:47 INFO - Using real prefix '/usr' 04:43:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:49 INFO - Installing pip.................done. 04:43:49 INFO - Return code: 0 04:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:50 INFO - Reading from file tmpfile_stdout 04:43:50 INFO - Output received: 04:43:50 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) 04:43:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43: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')]} 04:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:50 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:50 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 04:43:50 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 04:43:50 INFO - Using env: {'DISPLAY': ':0', 04:43:50 INFO - 'HOME': '/home/cltbld', 04:43:50 INFO - 'LANG': 'en_US.UTF-8', 04:43:50 INFO - 'LANGUAGE': 'en_US:en', 04:43:50 INFO - 'LOGNAME': 'cltbld', 04:43:50 INFO - 'MAIL': '/var/mail/cltbld', 04:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:50 INFO - 'MOZ_NO_REMOTE': '1', 04:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:50 INFO - 'NO_EM_RESTART': '1', 04:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:50 INFO - 'PWD': '/builds/slave/test', 04:43:50 INFO - 'SHELL': '/bin/bash', 04:43:50 INFO - 'SHLVL': '1', 04:43:50 INFO - 'TERM': 'linux', 04:43:50 INFO - 'TMOUT': '86400', 04:43:50 INFO - 'USER': 'cltbld', 04:43:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:50 INFO - '_': '/tools/buildbot/bin/python'} 04:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:50 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 04:43:50 INFO - Cleaning up... 04:43:50 INFO - Return code: 0 04:43:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43: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')]} 04:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:50 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:50 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 04:43:50 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 04:43:50 INFO - Using env: {'DISPLAY': ':0', 04:43:50 INFO - 'HOME': '/home/cltbld', 04:43:50 INFO - 'LANG': 'en_US.UTF-8', 04:43:50 INFO - 'LANGUAGE': 'en_US:en', 04:43:50 INFO - 'LOGNAME': 'cltbld', 04:43:50 INFO - 'MAIL': '/var/mail/cltbld', 04:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:50 INFO - 'MOZ_NO_REMOTE': '1', 04:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:50 INFO - 'NO_EM_RESTART': '1', 04:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:50 INFO - 'PWD': '/builds/slave/test', 04:43:50 INFO - 'SHELL': '/bin/bash', 04:43:50 INFO - 'SHLVL': '1', 04:43:50 INFO - 'TERM': 'linux', 04:43:50 INFO - 'TMOUT': '86400', 04:43:50 INFO - 'USER': 'cltbld', 04:43:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:50 INFO - '_': '/tools/buildbot/bin/python'} 04:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:50 INFO - Downloading/unpacking psutil>=3.1.1 04:43:50 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 04:43:50 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 04:43:50 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 04:43:50 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 04:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:51 INFO - Installing collected packages: psutil 04:43:51 INFO - Running setup.py install for psutil 04:43:52 INFO - building 'psutil._psutil_linux' extension 04:43:52 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 04:43:53 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 04:43:53 INFO - building 'psutil._psutil_posix' extension 04:43:53 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 04:43:53 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 04:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:53 INFO - Successfully installed psutil 04:43:53 INFO - Cleaning up... 04:43:53 INFO - Return code: 0 04:43:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43: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')]} 04:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:53 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:53 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 04:43:53 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 04:43:53 INFO - Using env: {'DISPLAY': ':0', 04:43:53 INFO - 'HOME': '/home/cltbld', 04:43:53 INFO - 'LANG': 'en_US.UTF-8', 04:43:53 INFO - 'LANGUAGE': 'en_US:en', 04:43:53 INFO - 'LOGNAME': 'cltbld', 04:43:53 INFO - 'MAIL': '/var/mail/cltbld', 04:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:53 INFO - 'MOZ_NO_REMOTE': '1', 04:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:53 INFO - 'NO_EM_RESTART': '1', 04:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:53 INFO - 'PWD': '/builds/slave/test', 04:43:53 INFO - 'SHELL': '/bin/bash', 04:43:53 INFO - 'SHLVL': '1', 04:43:53 INFO - 'TERM': 'linux', 04:43:53 INFO - 'TMOUT': '86400', 04:43:53 INFO - 'USER': 'cltbld', 04:43:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:53 INFO - '_': '/tools/buildbot/bin/python'} 04:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43: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 04:43: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 04:43: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 04:43: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 04:43:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:55 INFO - Installing collected packages: mozsystemmonitor 04:43:55 INFO - Running setup.py install for mozsystemmonitor 04:43:55 INFO - Successfully installed mozsystemmonitor 04:43:55 INFO - Cleaning up... 04:43:55 INFO - Return code: 0 04:43:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43: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')]} 04:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:43:55 INFO - Using env: {'DISPLAY': ':0', 04:43:55 INFO - 'HOME': '/home/cltbld', 04:43:55 INFO - 'LANG': 'en_US.UTF-8', 04:43:55 INFO - 'LANGUAGE': 'en_US:en', 04:43:55 INFO - 'LOGNAME': 'cltbld', 04:43:55 INFO - 'MAIL': '/var/mail/cltbld', 04:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:55 INFO - 'MOZ_NO_REMOTE': '1', 04:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:55 INFO - 'NO_EM_RESTART': '1', 04:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:55 INFO - 'PWD': '/builds/slave/test', 04:43:55 INFO - 'SHELL': '/bin/bash', 04:43:55 INFO - 'SHLVL': '1', 04:43:55 INFO - 'TERM': 'linux', 04:43:55 INFO - 'TMOUT': '86400', 04:43:55 INFO - 'USER': 'cltbld', 04:43:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:55 INFO - '_': '/tools/buildbot/bin/python'} 04:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:55 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 04:43:55 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 04:43:55 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 04:43:55 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 04:43:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:57 INFO - warning: no files found matching '*.txt' 04:43:57 INFO - no previously-included directories found matching 'build' 04:43:57 INFO - no previously-included directories found matching 'dist' 04:43:57 INFO - no previously-included directories found matching '.git*' 04:43:57 INFO - Installing collected packages: jsonschema, functools32 04:43:57 INFO - Running setup.py install for functools32 04:43:57 INFO - warning: no files found matching '*.txt' 04:43:57 INFO - no previously-included directories found matching 'build' 04:43:57 INFO - no previously-included directories found matching 'dist' 04:43:57 INFO - no previously-included directories found matching '.git*' 04:43:57 INFO - Successfully installed jsonschema functools32 04:43:57 INFO - Cleaning up... 04:43:57 INFO - Return code: 0 04:43:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:43:57 INFO - Using env: {'DISPLAY': ':0', 04:43:57 INFO - 'HOME': '/home/cltbld', 04:43:57 INFO - 'LANG': 'en_US.UTF-8', 04:43:57 INFO - 'LANGUAGE': 'en_US:en', 04:43:57 INFO - 'LOGNAME': 'cltbld', 04:43:57 INFO - 'MAIL': '/var/mail/cltbld', 04:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:57 INFO - 'MOZ_NO_REMOTE': '1', 04:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:57 INFO - 'NO_EM_RESTART': '1', 04:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:57 INFO - 'PWD': '/builds/slave/test', 04:43:57 INFO - 'SHELL': '/bin/bash', 04:43:57 INFO - 'SHLVL': '1', 04:43:57 INFO - 'TERM': 'linux', 04:43:57 INFO - 'TMOUT': '86400', 04:43:57 INFO - 'USER': 'cltbld', 04:43:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:57 INFO - '_': '/tools/buildbot/bin/python'} 04:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:43:57 INFO - Cleaning up... 04:43:57 INFO - Return code: 0 04:43:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:58 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:43:58 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 04:43:58 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 04:43:58 INFO - Using env: {'DISPLAY': ':0', 04:43:58 INFO - 'HOME': '/home/cltbld', 04:43:58 INFO - 'LANG': 'en_US.UTF-8', 04:43:58 INFO - 'LANGUAGE': 'en_US:en', 04:43:58 INFO - 'LOGNAME': 'cltbld', 04:43:58 INFO - 'MAIL': '/var/mail/cltbld', 04:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:58 INFO - 'MOZ_NO_REMOTE': '1', 04:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:58 INFO - 'NO_EM_RESTART': '1', 04:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:58 INFO - 'PWD': '/builds/slave/test', 04:43:58 INFO - 'SHELL': '/bin/bash', 04:43:58 INFO - 'SHLVL': '1', 04:43:58 INFO - 'TERM': 'linux', 04:43:58 INFO - 'TMOUT': '86400', 04:43:58 INFO - 'USER': 'cltbld', 04:43:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:58 INFO - '_': '/tools/buildbot/bin/python'} 04:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:00 INFO - Downloading docopt-0.6.1.tar.gz 04:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:00 INFO - Running setup.py install for blobuploader 04:44:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:00 INFO - Running setup.py install for requests 04:44:00 INFO - Running setup.py install for docopt 04:44:00 INFO - Successfully installed blobuploader requests docopt 04:44:00 INFO - Cleaning up... 04:44:00 INFO - Return code: 0 04:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:00 INFO - Using env: {'DISPLAY': ':0', 04:44:00 INFO - 'HOME': '/home/cltbld', 04:44:00 INFO - 'LANG': 'en_US.UTF-8', 04:44:00 INFO - 'LANGUAGE': 'en_US:en', 04:44:00 INFO - 'LOGNAME': 'cltbld', 04:44:00 INFO - 'MAIL': '/var/mail/cltbld', 04:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:00 INFO - 'MOZ_NO_REMOTE': '1', 04:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:00 INFO - 'NO_EM_RESTART': '1', 04:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:00 INFO - 'PWD': '/builds/slave/test', 04:44:00 INFO - 'SHELL': '/bin/bash', 04:44:00 INFO - 'SHLVL': '1', 04:44:00 INFO - 'TERM': 'linux', 04:44:00 INFO - 'TMOUT': '86400', 04:44:00 INFO - 'USER': 'cltbld', 04:44:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:00 INFO - '_': '/tools/buildbot/bin/python'} 04:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:01 INFO - Running setup.py (path:/tmp/pip-kz2k06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:01 INFO - Running setup.py (path:/tmp/pip-dU6Yp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:01 INFO - Running setup.py (path:/tmp/pip-NLM0FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:01 INFO - Running setup.py (path:/tmp/pip-xEbK8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:01 INFO - Running setup.py (path:/tmp/pip-GsPEtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:01 INFO - Running setup.py (path:/tmp/pip-0o6KDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:01 INFO - Running setup.py (path:/tmp/pip-8pLQrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:01 INFO - Running setup.py (path:/tmp/pip-dwrlbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:01 INFO - Running setup.py (path:/tmp/pip-Aw8Fcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:01 INFO - Running setup.py (path:/tmp/pip-Nl0LZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:01 INFO - Running setup.py (path:/tmp/pip-BQzS1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:01 INFO - Running setup.py (path:/tmp/pip-vZblIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:01 INFO - Running setup.py (path:/tmp/pip-_aizi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:02 INFO - Running setup.py (path:/tmp/pip-1wpZXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:02 INFO - Running setup.py (path:/tmp/pip-IsPz2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:02 INFO - Running setup.py (path:/tmp/pip-xATq0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:02 INFO - Running setup.py (path:/tmp/pip-rjrpCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:02 INFO - Running setup.py install for manifestparser 04:44:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:02 INFO - Running setup.py install for mozcrash 04:44:02 INFO - Running setup.py install for mozdebug 04:44:02 INFO - Running setup.py install for mozdevice 04:44:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:02 INFO - Running setup.py install for mozfile 04:44:02 INFO - Running setup.py install for mozhttpd 04:44:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:02 INFO - Running setup.py install for mozinfo 04:44:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for mozInstall 04:44:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for mozleak 04:44:03 INFO - Running setup.py install for mozlog 04:44:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for moznetwork 04:44:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for mozprocess 04:44:03 INFO - Running setup.py install for mozprofile 04:44:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for mozrunner 04:44:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:03 INFO - Running setup.py install for mozscreenshot 04:44:03 INFO - Running setup.py install for moztest 04:44:04 INFO - Running setup.py install for mozversion 04:44:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:04 INFO - Cleaning up... 04:44:04 INFO - Return code: 0 04:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:04 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')]} 04:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:04 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')]} 04:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:04 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:44:04 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 04:44:04 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 04:44:04 INFO - Using env: {'DISPLAY': ':0', 04:44:04 INFO - 'HOME': '/home/cltbld', 04:44:04 INFO - 'LANG': 'en_US.UTF-8', 04:44:04 INFO - 'LANGUAGE': 'en_US:en', 04:44:04 INFO - 'LOGNAME': 'cltbld', 04:44:04 INFO - 'MAIL': '/var/mail/cltbld', 04:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:04 INFO - 'MOZ_NO_REMOTE': '1', 04:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:04 INFO - 'NO_EM_RESTART': '1', 04:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:04 INFO - 'PWD': '/builds/slave/test', 04:44:04 INFO - 'SHELL': '/bin/bash', 04:44:04 INFO - 'SHLVL': '1', 04:44:04 INFO - 'TERM': 'linux', 04:44:04 INFO - 'TMOUT': '86400', 04:44:04 INFO - 'USER': 'cltbld', 04:44:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:04 INFO - '_': '/tools/buildbot/bin/python'} 04:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:04 INFO - Running setup.py (path:/tmp/pip-W31jf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:04 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)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:04 INFO - Running setup.py (path:/tmp/pip-p798bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:04 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)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:04 INFO - Running setup.py (path:/tmp/pip-vFVz1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:04 INFO - Running setup.py (path:/tmp/pip-IeBJqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:04 INFO - Running setup.py (path:/tmp/pip-7l2uyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:04 INFO - Running setup.py (path:/tmp/pip-lTPEJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:04 INFO - Running setup.py (path:/tmp/pip-cJdw2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:05 INFO - Running setup.py (path:/tmp/pip-47j6Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:05 INFO - Running setup.py (path:/tmp/pip-RPgFKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:05 INFO - Running setup.py (path:/tmp/pip-5mG1Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:05 INFO - Running setup.py (path:/tmp/pip-5E3ouJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:05 INFO - Running setup.py (path:/tmp/pip-Fd28BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:05 INFO - Running setup.py (path:/tmp/pip-5Zk4hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:05 INFO - Running setup.py (path:/tmp/pip-zLT3a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:05 INFO - Running setup.py (path:/tmp/pip-7GioAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:05 INFO - Running setup.py (path:/tmp/pip-EIZ_sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:05 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)) 04:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:05 INFO - Running setup.py (path:/tmp/pip-52fwyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:07 INFO - Downloading blessings-1.6.tar.gz 04:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:07 INFO - Installing collected packages: blessings 04:44:07 INFO - Running setup.py install for blessings 04:44:07 INFO - Successfully installed blessings 04:44:07 INFO - Cleaning up... 04:44:07 INFO - Return code: 0 04:44:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:07 INFO - Reading from file tmpfile_stdout 04:44:07 INFO - Current package versions: 04:44:07 INFO - argparse == 1.2.1 04:44:07 INFO - blessings == 1.6 04:44:07 INFO - blobuploader == 1.2.4 04:44:07 INFO - docopt == 0.6.1 04:44:07 INFO - functools32 == 3.2.3-2 04:44:07 INFO - jsonschema == 2.5.1 04:44:07 INFO - manifestparser == 1.1 04:44:07 INFO - mozInstall == 1.13 04:44:07 INFO - mozcrash == 1.0 04:44:07 INFO - mozdebug == 0.1 04:44:07 INFO - mozdevice == 0.51 04:44:07 INFO - mozfile == 1.2 04:44:07 INFO - mozhttpd == 0.7 04:44:07 INFO - mozinfo == 0.10 04:44:07 INFO - mozleak == 0.1 04:44:07 INFO - mozlog == 3.5 04:44:07 INFO - moznetwork == 0.27 04:44:07 INFO - mozprocess == 0.25 04:44:07 INFO - mozprofile == 0.28 04:44:07 INFO - mozrunner == 6.13 04:44:07 INFO - mozscreenshot == 0.1 04:44:07 INFO - mozsystemmonitor == 0.3 04:44:07 INFO - moztest == 0.8 04:44:07 INFO - mozversion == 1.4 04:44:07 INFO - psutil == 3.1.1 04:44:07 INFO - requests == 1.2.3 04:44:07 INFO - wsgiref == 0.1.2 04:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:07 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:44:07 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 04:44:07 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 04:44:07 INFO - Using env: {'DISPLAY': ':0', 04:44:07 INFO - 'HOME': '/home/cltbld', 04:44:07 INFO - 'LANG': 'en_US.UTF-8', 04:44:07 INFO - 'LANGUAGE': 'en_US:en', 04:44:07 INFO - 'LOGNAME': 'cltbld', 04:44:07 INFO - 'MAIL': '/var/mail/cltbld', 04:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:07 INFO - 'MOZ_NO_REMOTE': '1', 04:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:07 INFO - 'NO_EM_RESTART': '1', 04:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:07 INFO - 'PWD': '/builds/slave/test', 04:44:07 INFO - 'SHELL': '/bin/bash', 04:44:07 INFO - 'SHLVL': '1', 04:44:07 INFO - 'TERM': 'linux', 04:44:07 INFO - 'TMOUT': '86400', 04:44:07 INFO - 'USER': 'cltbld', 04:44:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:07 INFO - '_': '/tools/buildbot/bin/python'} 04:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 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)) 04:44:07 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:09 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:44:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:44:09 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 04:44:09 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 04:44:09 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 04:44:09 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 04:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:44:09 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)) 04:44:09 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)) 04:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:44:09 INFO - Installing collected packages: marionette-driver, simplejson 04:44:09 INFO - Running setup.py install for marionette-driver 04:44:09 INFO - Running setup.py install for simplejson 04:44:09 INFO - building 'simplejson._speedups' extension 04:44:09 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 04:44:10 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 04:44:10 INFO - Successfully installed marionette-driver simplejson 04:44:10 INFO - Cleaning up... 04:44:10 INFO - Return code: 0 04:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', '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 04:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:10 INFO - Using env: {'DISPLAY': ':0', 04:44:10 INFO - 'HOME': '/home/cltbld', 04:44:10 INFO - 'LANG': 'en_US.UTF-8', 04:44:10 INFO - 'LANGUAGE': 'en_US:en', 04:44:10 INFO - 'LOGNAME': 'cltbld', 04:44:10 INFO - 'MAIL': '/var/mail/cltbld', 04:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:10 INFO - 'MOZ_NO_REMOTE': '1', 04:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:10 INFO - 'NO_EM_RESTART': '1', 04:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:10 INFO - 'PWD': '/builds/slave/test', 04:44:10 INFO - 'SHELL': '/bin/bash', 04:44:10 INFO - 'SHLVL': '1', 04:44:10 INFO - 'TERM': 'linux', 04:44:10 INFO - 'TMOUT': '86400', 04:44:10 INFO - 'USER': 'cltbld', 04:44:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:10 INFO - '_': '/tools/buildbot/bin/python'} 04:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:10 INFO - Cleaning up... 04:44:10 INFO - Return code: 0 04:44:10 INFO - Running post-action listener: _resource_record_post_action 04:44:10 INFO - Running post-action listener: _start_resource_monitoring 04:44:10 INFO - Starting resource monitoring. 04:44:10 INFO - [mozharness: 2017-07-11 11:44:10.913616Z] Finished create-virtualenv step (success) 04:44:10 INFO - [mozharness: 2017-07-11 11:44:10.914606Z] Running install step. 04:44:10 INFO - Running pre-action listener: _resource_record_pre_action 04:44:10 INFO - Running main action method: install 04:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:11 INFO - Reading from file tmpfile_stdout 04:44:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:11 INFO - Reading from file tmpfile_stdout 04:44:11 INFO - Output received: 04:44:11 INFO - Usage: mozinstall [options] installer 04:44:11 INFO - Options: 04:44:11 INFO - -h, --help show this help message and exit 04:44:11 INFO - -d DEST, --destination=DEST 04:44:11 INFO - Directory to install application into. [default: 04:44:11 INFO - "/builds/slave/test"] 04:44:11 INFO - --app=APP Application being installed. [default: firefox] 04:44:11 INFO - mkdir: /builds/slave/test/build/application 04:44:11 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'] 04:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:44:29 INFO - Reading from file tmpfile_stdout 04:44:29 INFO - Output received: 04:44:29 INFO - /builds/slave/test/build/application/firefox/firefox 04:44:29 INFO - Running post-action listener: _resource_record_post_action 04:44:29 INFO - [mozharness: 2017-07-11 11:44:29.250078Z] Finished install step (success) 04:44:29 INFO - [mozharness: 2017-07-11 11:44:29.250330Z] Running setup-mitmproxy step. 04:44:29 INFO - Running pre-action listener: _resource_record_pre_action 04:44:29 INFO - Running main action method: setup_mitmproxy 04:44:29 INFO - Skipping: mitmproxy is not required 04:44:29 INFO - Running post-action listener: _resource_record_post_action 04:44:29 INFO - [mozharness: 2017-07-11 11:44:29.251524Z] Finished setup-mitmproxy step (success) 04:44:29 INFO - [mozharness: 2017-07-11 11:44:29.251762Z] Running run-tests step. 04:44:29 INFO - Running pre-action listener: _resource_record_pre_action 04:44:29 INFO - Running pre-action listener: _set_gcov_prefix 04:44:29 INFO - Running main action method: run_tests 04:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:29 INFO - Python 2.7.3 04:44:29 INFO - Return code: 0 04:44:29 INFO - grabbing minidump binary from tooltool 04:44:29 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')]} 04:44:29 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 0x1d95980>, '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 0x1d96730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d96bc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:29 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 04:44:29 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 04:44:29 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 04:44:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:29 INFO - Return code: 0 04:44:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:44:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:29 INFO - ENV: RUST_BACKTRACE is now 1 04:44:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:44:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:44:29 INFO - Using env: {'DISPLAY': ':0', 04:44:29 INFO - 'HOME': '/home/cltbld', 04:44:29 INFO - 'LANG': 'en_US.UTF-8', 04:44:29 INFO - 'LANGUAGE': 'en_US:en', 04:44:29 INFO - 'LOGNAME': 'cltbld', 04:44:29 INFO - 'MAIL': '/var/mail/cltbld', 04:44:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:29 INFO - 'MOZ_NO_REMOTE': '1', 04:44:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:29 INFO - 'NO_EM_RESTART': '1', 04:44:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:29 INFO - 'PWD': '/builds/slave/test', 04:44:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:29 INFO - 'RUST_BACKTRACE': '1', 04:44:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:44:29 INFO - 'SHELL': '/bin/bash', 04:44:29 INFO - 'SHLVL': '1', 04:44:29 INFO - 'TERM': 'linux', 04:44:29 INFO - 'TMOUT': '86400', 04:44:29 INFO - 'USER': 'cltbld', 04:44:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308', 04:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:29 INFO - '_': '/tools/buildbot/bin/python'} 04:44:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:44:29 INFO - mozversion application_buildid: 20170711105211 04:44:29 INFO - mozversion application_changeset: b07db5d650b7056c78ba0dbc409d060ec4e922cd 04:44:29 INFO - mozversion application_display_name: Nightly 04:44:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:29 INFO - mozversion application_name: Firefox 04:44:29 INFO - mozversion application_remotingname: firefox 04:44:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:44:29 INFO - mozversion application_vendor: Mozilla 04:44:29 INFO - mozversion application_version: 56.0a1 04:44:29 INFO - mozversion platform_buildid: 20170711105211 04:44:29 INFO - mozversion platform_changeset: b07db5d650b7056c78ba0dbc409d060ec4e922cd 04:44:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:44:29 INFO - mozversion platform_version: 56.0a1 04:44:29 INFO - using testdate: 1499773469 04:44:29 INFO - actual date: 1499773469 04:44:29 INFO - starting webserver on 'localhost:51233' 04:44:29 INFO - SUITE-START | Running 2 tests 04:44:29 INFO - TEST-START | dromaeo_css 04:44:29 INFO - Initialising browser for dromaeo_css test... 04:44:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51233/getInfo.html -profile /tmp/tmp7EByga/profile 04:44:30 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox http://localhost:51233/getInfo.html) 04:44:40 INFO - TEST-INFO | 3312: exit 0 04:44:40 INFO - Browser initialized. 04:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:40 INFO - TEST-INFO | started process 3518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7EByga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:51 INFO - PID 3518 | RSS: Main: 171003904 04:44:51 INFO - PID 3518 | 04:47:52 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51233/tests/dromaeo/cssquery-ext.html) 04:47:54 INFO - PID 3518 | RSS: Main: 177090560 04:47:54 INFO - PID 3518 | 04:50:55 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-ext.html (next: http://localhost:51233/tests/dromaeo/cssquery-jquery.html) 04:50:56 INFO - PID 3518 | RSS: Main: 175362048 04:50:56 INFO - PID 3518 | 04:53:57 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51233/tests/dromaeo/cssquery-mootools.html) 04:53:58 INFO - PID 3518 | RSS: Main: 177078272 04:53:58 INFO - PID 3518 | 04:57:00 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51233/tests/dromaeo/cssquery-prototype.html) 04:57:00 INFO - PID 3518 | RSS: Main: 176185344 04:57:00 INFO - PID 3518 | 05:00:04 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51233/tests/dromaeo/cssquery-yui.html) 05:00:04 INFO - PID 3518 | RSS: Main: 176275456 05:00:04 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:51233/tests/dromaeo/cssquery-yui.html (next: http://localhost:51233/tests/dromaeo/cssquery-dojo.html) 05:03:06 INFO - PID 3518 | RSS: Main: 179638272 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | __start_tp_report 05:03:06 INFO - PID 3518 | _x_x_mozilla_page_load 05:03:06 INFO - PID 3518 | _x_x_mozilla_page_load_details 05:03:06 INFO - PID 3518 | |i|pagename|runs| 05:03:06 INFO - PID 3518 | |0;dojo.html;3121.438141134595;3140.371925614877;3164.825934573599;3167.2240301126226;3191.6808319168085;6035.3964603539625;6055.485283750886;6062.878742425149;6103.786367477139;6144.877102457948;6084.087386891968;6125.66308853014;6128.233970753656;6143.416375444325;6153.384661533855;5564.026295398309;5572.331320241567;5608.46719561641;5618.494335509803;5631.60578759487;5604.495595396414;5611;5614.747336369853;5624.21261023457;5634.098544232924;5614.691191984439;5622.93164298784;5623;5634.521065709419;5644.181593668915;5552.361478429992;5556.111022236463;5559.63862348946;5599.132134519135;5604.943950560483;5541.27963364764;5551.139573366135;5552.500274975231;5567.4432556744405;5651.406602306781;5943.04911214208;6020.6688632125215;6060.515158787286;6084.939150608526;6105.053716673922;6465.030245463218;6466.547341686084;6548.37790409915;6557.967210163966;6565.80302590923;6456.354364563506;6559.6064236145985;6562.770303039419;6563.638999855006;6565.606063636197;6036.547258955552;6082.847928801771;6100.96949515254;6108.816735497942;6113.694315284262;6673.632950187689;6692.397684208445;6695.933040669531;6721;6764.492663050192;6314.463270621956;6359.20509936258;6365.713542890581;6437.710303036374;6439.259485159173;6488.059231411419;6497;6555.836104097436;6559.7376104955265;6569.014647802868;6358.968205158944;6419.80740577774;6454.128692626529;6455.322191169954;6462.127612772216;6308.369163083747;6318.557700960981;6483.546151769425;6491.221053473519;6546.9017964730565;5117.820876269313;5295.4969277918535;5351.464853514617;5376.516113549721;5384.353877534721;4497.6851620386915;4510.954890451119;4546.681732278708;4551.3173024046655;4555.407796986437;5650.124230744241;5652.152177173375;5654;5658.575606829504;5659.292588426447;6538.248101468392;6554.672266386661;6561.934380656132;6562.934370656328;6581.901271480931;5637.295338082739;5689.943100568941;5690.829275121753;5697.857553561194;5702.914456283159;5698.629589076697;5766;5766.654000759884;5783.132530120515;5787.971060144672;5071.670341427869;6250.624962502265;6263.091851681481;6472.255690595548;6478.773242936569;6520.119783829123;6550.115734375799;6564.081028656087;6625.138731964814;6652.800415987528;6335.271443784024;6358.904616430665;6437.742490300336;6449.322821103717;6458.741650333934;6262.937370626418;6385.10608514799;6403.743850245938;6418.229812422353;6504.674766261763;4981.850544483671;6555.639439830855;6574.276829548841;6608.041833934149;6697.497687673542;6326.525510586633;6361.840953976188;6449.5485316027425;6455.096286519797;6482.481401487776;6362.809115726535;6387.616742995435;6449.806505804833;6450.032495125769;6452.516061295328;6173.166622505904;6280.654563998841;6299.811005669837;6313.747450101944;6391.2330520337855;6273.686315684106;6318.905216421849;6324.335944725737;6334.968325158345;6354.52341074412;4985.326980857682;6060.060690592965;6136.877262454636;6241.812745617639;6312.43188113072 05:03:06 INFO - PID 3518 | |1;ext.html;800.9118996910339;852.2925971443701;871.9564021798908;889.5507768576867;1088.6298658456124;29323;40649.3902591461;41259.58740412595;41367.37948930765;41439.17121657565;40728;41132.79433602835;41210;41256.58743412565;41316.76049718506;7511;7600.315971562558;7634.694612215505;7652.04349456318;7661.157272699998;7409.55542667439;7527.849443011164;7642.694292228304;7663.923360766376;7696.846063078735;7639.3124618784295;7651.770446886574;7651.885221721679;7660;7674.347680447168;7557.168711441737;7586.241375862425;7597.886031709529;7602.0877494700435;7613.961930190341;7513;7557;7562.621868906533;7565.432592555525;7617;37369.252614947545;37552.24895502102;37562;37587.24825503502;37640;3505.211327451303;3535.840887160058;3552.413851714464;3558.768680035789;3584.1398064464342;30640.84679576588;30696.693033069605;30761.8461907689;30810.691893081006;30925.690743092506;4610.746408947506;4657.371254880615;4838.637102217348;4938.1111399947995;4973.776180071905;182111;183639;185366;189204.05397973058;189895;48177.518224818006;48370.758146209046;48763.756181218865;48869.755651221516;49126.26310605344;50597.49402506001;50812;50824.491755082716;50943.745281274096;50994.74502627537;16175;16236;16245.756313655069;16438.506844794676;16488.17559122039;13695.794563081561;13715.451381944611;13732.725345493234;13788.93105534486;13826.861731382758;14016;14022.719545609234;14255.714885702228;14339.283035848166;14423.49517766873;5521.972390138024;5637.68992705397;5685.573581981368;5784.913226301609;5799.681017543991;971.4511301114848;977.3659986336896;987.4766373821742;1012.2408193854609;1012.6354512375539;22448.551028979655;22530.098796048303;22636.773632263466;22696.432589185402;29554.261143471584;1086.8152414089623;1098.1215027977587;1109.2290857853875;1109.3343993603935;1119.2780656476689;12401.13192076564;12401.93799030999;12433.254004759743;12439.004879609609;12536.122471427096;224070;226911;227542;228367;228787;52010.479895200566;52286.73856630692;52657;52671.47328526742;52781;1428.5285855667605;1519.620094976256;1531.1808182622244;1535.9001664891746;1548.6747782965704;21728.78271217331;21958.288514402277;22402.66396004094;22646.886765566065;23014.769852301262;38413.2317353657;38618.42072368973;38635.2272954545;38702.2259554813;38738.0315492115;202663;203331;203458;203559;203672;31210.37579248357;31432.214194645316;31602.209944751565;31682;34078.318433631684;41643;43468.782656086514;44017;44393;44715.55284447114;30042.3991520164;30376.696233037386;31337.216569585944;31573.8421307892;32037.35925281528;31398;31586.52620210653;31882.840585796923;32354.83822580872;33683.663163369034;38678.80660596679;38783.224335513696;39047.41428878512;39365.80317098396;39482.60517394789;31020.379592407575;33529.49705754367;33587.83206083954;33989.49015764815;34433.13917152091;23896.40258993539;24058.39854003664;24642.630360544248;24696.382590435383;24710.50578988446 05:03:06 INFO - PID 3518 | |2;jquery.html;551.1457241276021;557.5093917352732;562.2606272751332;587.8001479496971;604.6825416656255;21747.34757957262;22555.887220563916;22579.096836126577;22679.886600566995;22789;24320.27039188823;25680.486390272185;27020.189394318153;27062.323441913963;27062.45875082497;6451.870962580746;6584.934150658504;6592.274849766522;6592.439642630382;6598.571092878971;6539.149910511627;6544.0511125886715;6581.901271480931;6588.670566471681;6599.208095028604;6128.724207410655;6206;6366;6367.4906007519285;6511.055896894947;6399.168108145935;6476.44950179233;6547.5089368297095;6547.672616369163;6568.93431065688;5438.265834112383;5698.259226300595;5930.466258036754;6071.271447426293;6123.142760013558;29444;29997.400051998837;30074.24814379636;30120;30135.095947121623;1977.1004193092108;1999.7700264469627;2009.2867032203649;2010.859239853211;2012.9295474658318;18127.093645317815;18814.623707525774;19308.903455482774;19321;19372.4188274352;2316.501952080294;2361.669366288721;2363.6218205087275;2379.0959435414607;2381.3213234228333;120723;122785.38607306995;122983;123103.76896231013;123492.38253808764;14697.92651036738;15154.848451515565;15214.543563693107;15353.929214157213;15419.92290038565;23514.88366047064;23681.881590591936;23716.52566948686;23788.405289867893;23797.52404951926;10483.528241229164;10543.367397956146;10706.678799636024;10713.578388655666;10877.347359158317;9929.50352482373;9972.301938864355;10082.74793130163;10162.542685579167;10244.053629810312;8996.910030899739;9187.586558604879;9349;9416;9426.717198484057;2602.687677478677;2616.188981415767;2647.2984659065364;2749.3398689221576;2777.250332290644;926.4996901673021;930.8696782450462;947.1806887042659;973.4013581647235;984.0995489127512;18477.90761046186;18718.53203669919;18791;18817.717734233996;18961.146748396357;1004.0812656419295;1016.517154351677;1027.8817935937464;1044.3994703045628;1055.2613170780485;10252.282340236261;10383.688489345332;10397.064264216257;10438.321509101885;10462.68611941643;436244;440166;447145;449387;452570;108955;109377;110378.44810775894;110916;111684;1218.1594699657207;1240.522398876439;1258.4274155259518;1260.5462033667873;1269.6825793551611;16346.754798678267;20840.895795520926;21570;21707.240246591293;21781;52558;55044.44955550393;55699;56477.71761141168;57578.7121064392;62383;63011.36988630055;64296.67851660712;64722.676386617764;64984.67507662431;14701.117932924059;15180.924095379452;15198.848011519744;15225.467108651144;15233.162176079979;22425.887870560542;23469.647955280343;23707.1702490412;23784;24390.634140488262;18431.815681843545;18783.90608046951;18921.148548315636;18957.620847583246;18959.526011849815;14476.203808790196;15063;15507;15601.453949111727;16240.431584894472;18960.52598685044;19094;19266.807331926502;19449.708254375913;19517.34102601295;14878.628034299229;14885;14956.401743930555;14997.250137492863;15065.397384104514;17747.556311092325;18632.906835466278;18645.347412840485;18713.25146994105;18761.530961726065 05:03:06 INFO - PID 3518 | |3;mootools.html;1338.2238301784967;1393.317274535478;1396.2530046425165;1399.6081097292756;1407.2752532445793;12807.295598742065;13409.195448273085;13410.66473338167;13437.664058398545;13455.798163027563;13298.933505332485;13676.52132175374;14022.088564243317;14123.717525649481;14152.92923535381;2630.644862943502;2670.586059160833;2672.2116975492277;2672.7460891215305;2673.438577898634;2544.910928117516;2621.790256779453;2626.9080582179627;2630.539655560279;2632.605109233611;2537.314924970257;2593.2609206376187;2606.609008648699;2635.433381822908;2635.960460593083;2604.6744156980376;2687.5296823055887;2690.5426077566863;2692.6230327754033;2697.878595463209;2554.2848002559313;2598.0517111254258;2602.4534847682007;2613.163787587973;2620.816542842002;13146.737065258641;13369.197848129046;13441.66395840102;13445.19328840263;13480.932595337059;7108.5734855908295;7405.481616286862;7429.331360177556;7435.219301973269;7459.701611935516;4965.553100220997;4994.600431965434;5152.278680984665;5197.0385478686185;5234.162533994542;1808.7558179645712;1812.5649844037337;1847.667419864424;1861.9255229790792;1867.5237814357388;20245.392638220877;20354.389368318974;20505.2823151189;20507.89746051275;20536.486587835276;6168.537359697951;6214.906776398358;6353.936460635335;6373.808785736435;6486.902696459557;14488.85511144875;14514.346854391577;14530.418783248762;14543.200123993282;14552.708945821025;7300.780976570712;7345.412367010626;7384.704611815468;7429.851402972018;7465.477416580896;6866.450683945272;6868.210155832044;6869.278725733826;6918.7232510699005;7007.054047703597;4703.576678098988;4839.951600484021;4907.288443175719;4947.208446648591;4964.826231081895;1458.1032664911004;1462.1165307871759;1468.6181592785952;1473.4990103364694;1479.7780332950144;882.170759486081;899.9595018224196;902.4495058014737;912.3795818843117;930.948797816113;7125.857482850314;7159.212486626467;7297.9635101825215;7299.124105107421;7313.451491138186;676.4926305271047;698.91263592051;972.8200282947678;989.2284018465608;989.7278248481581;4718.292256161603;5079.288899554065;5095.235714642833;5139.794408223704;5171.172612382076;16752.91623541899;17749.822501774815;17807.10964451772;17905.641887162183;18095;16823.41118060862;17262.309507619804;17615.207315670825;17619.207135678924;17729.911350443166;10028.846682631445;10117.342372745601;10343.37939723619;10379.84430233547;10382.3251488653;7344.96327518359;7761.379089672925;7872.448928575174;7880;7978.561179135203;15002.399904003718;15454.381824726885;15669.686606268038;15719.921400393383;15720;15106.018108822891;15457.304421301293;15673;15851.524454266391;15979;10114.140298074746;10191.03185197405;10256.641017564349;10273.9486302568;10297.845532317171;12258.20321679088;12346.814797778221;12386.071044671506;12410.627681169579;12503.749925001632;9430;9634.181094606756;9733.172680322252;9864.654737084455;9910.108090271622;9428.387154835189;9701.6604418845;9841.409515429097;9847.409155450696;9923.950380248052;9024;9076.41003334781;9107.681231156877;9137.954310228672;9159.450432974043;6514.3811337922825;6658.334166583303;6796.218434879855;6818.045473633596;6850.349216824394;6924.238333783179;6982.1272340957385;7040.295970402919;7093.3970612498515;7153.642317884189 05:03:06 INFO - PID 3518 | |4;prototype.html;473.57141786683064;489.6988352163418;508.5677174401758;514.6834696661552;516.9224616307556;6040.607360521563;6094.786682466114;6110.144579758838;6111.144439778429;6143.139960405541;5828.766849326033;5928.6739229342365;5951.821445356635;5967.582269241155;6032.607880487776;4830.347903033098;4831.202851529493;4851.442084160322;4883.755812209393;4926.334944782444;4800.231962885939;4851.951480485185;4853.102176097415;4875.22054450125;4883.365162528867;4811.807527698906;4836.250381190921;4845.854624361257;4847.224444088946;4892.412910450751;4556.2937744649635;4740.620750339982;4787.71273723576;4793.2810078488155;4806.615470762331;4295.613394794453;4309.310510318365;4326.242907491176;4369.781510924473;4387.232234358974;5747.82756517301;5765.423457654243;5795.362510123883;5840.39389167978;5840.445157710011;5475.972620136914;5519.668819870781;5524.58565607581;5587.636803607753;5588.329400471929;6301.369863013708;6306.369363063657;6319.715612797435;6358.491320694333;6361.872762544724;4788.664793464459;4802.35168252285;4807.975960120177;4812.25410061441;4823.983057620071;6659.167604049494;6675.566088204251;6678.632675202862;6729.663516824188;6765.2072200866805;4916.222334381063;4950.975245123751;4953.182724850431;4959.305697202394;4969.35398398206;4995.900081998412;5014.623903207274;5023.572996295356;5025.547700706881;5029.1643550103945;5409.6754194747655;5474.534664553478;5496.450354964471;5496.780128794803;5503.614746967673;6227.598790272153;6328.17733694626;6330.968345158245;6337.397947195009;6338.778142764981;1696.8303169682933;1697.8896371735798;1743.5902562897709;1746.7991181014347;1758.5691505581215;1115.5107930912322;1210.4552951171831;1212.587720175127;1219.3232755820427;1228.2569045727384;5454.645448045864;5522.91715624266;5572.331320241516;5623.746931388097;5631.63394379364;6395.537717978612;6467.482601391877;6563.9169537025855;6595.373439523238;6641.800745977628;5601;5645.407232240637;5652.434756524314;5653.717314134276;5673.276827123004;3452.5339079224486;3476.7740096894127;3477.8608855646;3494.2138018945534;3527.1534831640734;6314.368563143649;6399;6410.455111315498;6418.358164183544;6425.967870160619;6757.290484499155;6781.6609169541325;6782;6799.3200679931615;6801.18385793708;6379.74481020754;6386.137871387396;6415.967920160556;6425.2050358094375;6455.4512866406885;6538.574992625464;6549.934500654933;6583.604983700993;6610.041543976193;6628.469722422098;6439.871202576016;6453.967730161319;6466.219525604036;6482.6434546098535;6509.641969691523;6246.812595622138;6343.9382200784;6348.650824204713;6348.9047664286;6395.706211301276;4864.975675121602;4888.193448081027;4888.462269150319;4895.16782147043;4920.5817505511;6436.549441539048;6482.935170648233;6502.544821862424;6609.669516524251;6627.768028118992;6346.2067241594805;6346.301906790157;6361.427471527585;6366.721138613525;6431;6289.622622642656;6344.333844946214;6372.745090196526;6399.232092148972;6421.614703117828;6200.193974783249;6277.623342599459;6297.4647154992335;6322.715477803418;6332.461740752087;6302.527310451643;6321.841953951188;6322.936770632235;6368.681565921778;6390.329015453496;5920.970395147997;6030.698465076641;6109.236345456818;6109.541784366279;6183.227096612924 05:03:06 INFO - PID 3518 | |5;yui.html;905.6015353244572;908.3232991421388;920.5305294299905;920.903305152959;923.0630909626728;16256;16534;16570.585735356606;16660.916695416538;18223.817761822378;19521.804781952178;20286.087126079325;21120.683189752166;21127.366179014654;21127.683084753742;1018.9847152292722;1038.5741845843206;1047.0158051431667;1047.376810797578;1047.6856942917095;1064.350746044916;1067.1836045425257;1068.9572417103307;1071.3304184884448;1072.0083922371814;779.6062988190984;798.4690181029608;1050.76883085721;1122.2424863217336;1123.5786580032488;1097.8078836203672;1099.4997276239292;1105.4804242006244;1109.0406798119568;1109.916756243277;807.7617102954642;809.9554524501209;814.0028465130227;816.049302562514;819.8934138562008;17471.38850140239;18087.18607662645;19580.412587622395;19794.901025494924;19827;19462.80537194624;19650.606987860163;20015.1993920243;20024.899875500676;20853.68719469209;14601.196934168616;14974.850251497455;15095.169765662884;15121.621959450991;15142.621434464116;3467.289205712823;3477.460993545979;3516.7186625069935;3518.47222916562;3522.7005704515145;109760;111487.44256278747;114547.42726286399;116065.09837254052;116308.99999999916;14471.131732096108;14561.78157327641;14779.482718104815;14843.703125937422;14945.925270373797;25181.99272029135;26269.34326641811;26269.73730262673;26322.078727244836;26578.6013209802;8149.225823546753;8266.917330826614;8274.8345033099;8321.791955201168;8330.62512186953;3712.331780279522;3809.7523660961947;3815.2941705783965;4140.192662430857;4398.868033958986;4825.638077144228;4920.581750551243;4971.577415919687;4971.651984361132;4977.676451030671;860.7934095817084;900.7207765592556;967.4050458967685;984.7981163861391;990.2770977186694;634.9746010159635;672.3948446398281;714.1430283659525;724.2721065329415;734.4344854462034;10988.175886808522;11445.942770286096;12343.506259749689;12749.107562470537;13060.934695326463;651.5108824067376;659.5317324699517;674.3762020131359;675.7702381190419;675.9662016899234;5115.2071428928575;5363.2759577456545;5487.094629386186;5531.280933478622;5568.693721845338;92323.53838230901;96282.0371796287;97108;98863;100833.49583252036;83996.58001710074;84480.89230753873;87745;87847;90603.54698226467;70904;73493;74111;75481.62259188779;77009;11473.36896470702;11707.707307317045;11864.881351186723;11978.401079946143;12222.75554488923;33891.257303073246;35012.82493587516;36449.27101458009;36724;37103.25793484169;62124;64471.677641613365;65089.67455162694;65825;66354.66822665856;17168;17724.734128988333;18066.36767713124;18219.45341639753;18706.812931870507;20136.59726805485;20776.792232077485;20817.479563011046;21000.36998890036;21131.8943405282;18672.439826805217;18728.531786704898;18738.25046998105;18819.623607527497;19039.52401189981;17744.91127544354;18117.637647247244;19262.518437039187;19606.313779017666;19647.214111435384;16819;18318.81681183171;18424.170912309248;18519.44441666752;18574.25702971866;12542.811857821958;13010.349482526026;13364;13463.730725385632;13705;12377.257364558156;13382.799258011333;13507.189568625914;14845;14851.480198193012 05:03:06 INFO - PID 3518 | __end_tp_report 05:03:06 INFO - PID 3518 | __start_cc_report 05:03:06 INFO - PID 3518 | _x_x_mozilla_cycle_collect,352 05:03:06 INFO - PID 3518 | __end_cc_report 05:03:06 INFO - PID 3518 | __startTimestamp1499774586580__endTimestamp 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | ------- Summary: start ------- 05:03:06 INFO - PID 3518 | Number of tests: 6 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#0] dojo.html Cycles:165 Average:5991.07 Median:6250.62 stddev:705.30 (11.3%) stddev-sans-first:670.57 05:03:06 INFO - PID 3518 | Values: 3121.4 3140.4 3164.8 3167.2 3191.7 6035.4 6055.5 6062.9 6103.8 6144.9 6084.1 6125.7 6128.2 6143.4 6153.4 5564.0 5572.3 5608.5 5618.5 5631.6 5604.5 5611.0 5614.7 5624.2 5634.1 5614.7 5622.9 5623.0 5634.5 5644.2 5552.4 5556.1 5559.6 5599.1 5604.9 5541.3 5551.1 5552.5 5567.4 5651.4 5943.0 6020.7 6060.5 6084.9 6105.1 6465.0 6466.5 6548.4 6558.0 6565.8 6456.4 6559.6 6562.8 6563.6 6565.6 6036.5 6082.8 6101.0 6108.8 6113.7 6673.6 6692.4 6695.9 6721.0 6764.5 6314.5 6359.2 6365.7 6437.7 6439.3 6488.1 6497.0 6555.8 6559.7 6569.0 6359.0 6419.8 6454.1 6455.3 6462.1 6308.4 6318.6 6483.5 6491.2 6546.9 5117.8 5295.5 5351.5 5376.5 5384.4 4497.7 4511.0 4546.7 4551.3 4555.4 5650.1 5652.2 5654.0 5658.6 5659.3 6538.2 6554.7 6561.9 6562.9 6581.9 5637.3 5689.9 5690.8 5697.9 5702.9 5698.6 5766.0 5766.7 5783.1 5788.0 5071.7 6250.6 6263.1 6472.3 6478.8 6520.1 6550.1 6564.1 6625.1 6652.8 6335.3 6358.9 6437.7 6449.3 6458.7 6262.9 6385.1 6403.7 6418.2 6504.7 4981.9 6555.6 6574.3 6608.0 6697.5 6326.5 6361.8 6449.5 6455.1 6482.5 6362.8 6387.6 6449.8 6450.0 6452.5 6173.2 6280.7 6299.8 6313.7 6391.2 6273.7 6318.9 6324.3 6335.0 6354.5 4985.3 6060.1 6136.9 6241.8 6312.4 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#1] ext.html Cycles:180 Average:37518.07 Median:3544.13 stddev:53399.81 (1506.7%) stddev-sans-first:53478.44 05:03:06 INFO - PID 3518 | Values: 800.9 852.3 872.0 889.6 1088.6 29323.0 40649.4 41259.6 41367.4 41439.2 40728.0 41132.8 41210.0 41256.6 41316.8 7511.0 7600.3 7634.7 7652.0 7661.2 7409.6 7527.8 7642.7 7663.9 7696.8 7639.3 7651.8 7651.9 7660.0 7674.3 7557.2 7586.2 7597.9 7602.1 7614.0 7513.0 7557.0 7562.6 7565.4 7617.0 37369.3 37552.2 37562.0 37587.2 37640.0 3505.2 3535.8 3552.4 3558.8 3584.1 30640.8 30696.7 30761.8 30810.7 30925.7 4610.7 4657.4 4838.6 4938.1 4973.8 182111.0 183639.0 185366.0 189204.1 189895.0 48177.5 48370.8 48763.8 48869.8 49126.3 50597.5 50812.0 50824.5 50943.7 50994.7 16175.0 16236.0 16245.8 16438.5 16488.2 13695.8 13715.5 13732.7 13788.9 13826.9 14016.0 14022.7 14255.7 14339.3 14423.5 5522.0 5637.7 5685.6 5784.9 5799.7 971.5 977.4 987.5 1012.2 1012.6 22448.6 22530.1 22636.8 22696.4 29554.3 1086.8 1098.1 1109.2 1109.3 1119.3 12401.1 12401.9 12433.3 12439.0 12536.1 224070.0 226911.0 227542.0 228367.0 228787.0 52010.5 52286.7 52657.0 52671.5 52781.0 1428.5 1519.6 1531.2 1535.9 1548.7 21728.8 21958.3 22402.7 22646.9 23014.8 38413.2 38618.4 38635.2 38702.2 38738.0 202663.0 203331.0 203458.0 203559.0 203672.0 31210.4 31432.2 31602.2 31682.0 34078.3 41643.0 43468.8 44017.0 44393.0 44715.6 30042.4 30376.7 31337.2 31573.8 32037.4 31398.0 31586.5 31882.8 32354.8 33683.7 38678.8 38783.2 39047.4 39365.8 39482.6 31020.4 33529.5 33587.8 33989.5 34433.1 23896.4 24058.4 24642.6 24696.4 24710.5 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#2] jquery.html Cycles:180 Average:32824.26 Median:22567.49 stddev:74871.12 (331.8%) stddev-sans-first:75041.94 05:03:06 INFO - PID 3518 | Values: 551.1 557.5 562.3 587.8 604.7 21747.3 22555.9 22579.1 22679.9 22789.0 24320.3 25680.5 27020.2 27062.3 27062.5 6451.9 6584.9 6592.3 6592.4 6598.6 6539.1 6544.1 6581.9 6588.7 6599.2 6128.7 6206.0 6366.0 6367.5 6511.1 6399.2 6476.4 6547.5 6547.7 6568.9 5438.3 5698.3 5930.5 6071.3 6123.1 29444.0 29997.4 30074.2 30120.0 30135.1 1977.1 1999.8 2009.3 2010.9 2012.9 18127.1 18814.6 19308.9 19321.0 19372.4 2316.5 2361.7 2363.6 2379.1 2381.3 120723.0 122785.4 122983.0 123103.8 123492.4 14697.9 15154.8 15214.5 15353.9 15419.9 23514.9 23681.9 23716.5 23788.4 23797.5 10483.5 10543.4 10706.7 10713.6 10877.3 9929.5 9972.3 10082.7 10162.5 10244.1 8996.9 9187.6 9349.0 9416.0 9426.7 2602.7 2616.2 2647.3 2749.3 2777.3 926.5 930.9 947.2 973.4 984.1 18477.9 18718.5 18791.0 18817.7 18961.1 1004.1 1016.5 1027.9 1044.4 1055.3 10252.3 10383.7 10397.1 10438.3 10462.7 436244.0 440166.0 447145.0 449387.0 452570.0 108955.0 109377.0 110378.4 110916.0 111684.0 1218.2 1240.5 1258.4 1260.5 1269.7 16346.8 20840.9 21570.0 21707.2 21781.0 52558.0 55044.4 55699.0 56477.7 57578.7 62383.0 63011.4 64296.7 64722.7 64984.7 14701.1 15180.9 15198.8 15225.5 15233.2 22425.9 23469.6 23707.2 23784.0 24390.6 18431.8 18783.9 18921.1 18957.6 18959.5 14476.2 15063.0 15507.0 15601.5 16240.4 18960.5 19094.0 19266.8 19449.7 19517.3 14878.6 14885.0 14956.4 14997.3 15065.4 17747.6 18632.9 18645.3 18713.3 18761.5 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#3] mootools.html Cycles:180 Average:8180.59 Median:2635.70 stddev:5352.41 (203.1%) stddev-sans-first:5342.72 05:03:06 INFO - PID 3518 | Values: 1338.2 1393.3 1396.3 1399.6 1407.3 12807.3 13409.2 13410.7 13437.7 13455.8 13298.9 13676.5 14022.1 14123.7 14152.9 2630.6 2670.6 2672.2 2672.7 2673.4 2544.9 2621.8 2626.9 2630.5 2632.6 2537.3 2593.3 2606.6 2635.4 2636.0 2604.7 2687.5 2690.5 2692.6 2697.9 2554.3 2598.1 2602.5 2613.2 2620.8 13146.7 13369.2 13441.7 13445.2 13480.9 7108.6 7405.5 7429.3 7435.2 7459.7 4965.6 4994.6 5152.3 5197.0 5234.2 1808.8 1812.6 1847.7 1861.9 1867.5 20245.4 20354.4 20505.3 20507.9 20536.5 6168.5 6214.9 6353.9 6373.8 6486.9 14488.9 14514.3 14530.4 14543.2 14552.7 7300.8 7345.4 7384.7 7429.9 7465.5 6866.5 6868.2 6869.3 6918.7 7007.1 4703.6 4840.0 4907.3 4947.2 4964.8 1458.1 1462.1 1468.6 1473.5 1479.8 882.2 900.0 902.4 912.4 930.9 7125.9 7159.2 7298.0 7299.1 7313.5 676.5 698.9 972.8 989.2 989.7 4718.3 5079.3 5095.2 5139.8 5171.2 16752.9 17749.8 17807.1 17905.6 18095.0 16823.4 17262.3 17615.2 17619.2 17729.9 10028.8 10117.3 10343.4 10379.8 10382.3 7345.0 7761.4 7872.4 7880.0 7978.6 15002.4 15454.4 15669.7 15719.9 15720.0 15106.0 15457.3 15673.0 15851.5 15979.0 10114.1 10191.0 10256.6 10273.9 10297.8 12258.2 12346.8 12386.1 12410.6 12503.7 9430.0 9634.2 9733.2 9864.7 9910.1 9428.4 9701.7 9841.4 9847.4 9924.0 9024.0 9076.4 9107.7 9138.0 9159.5 6514.4 6658.3 6796.2 6818.0 6850.3 6924.2 6982.1 7040.3 7093.4 7153.6 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#4] prototype.html Cycles:180 Average:5363.91 Median:5880.71 stddev:1500.52 (25.5%) stddev-sans-first:1459.14 05:03:06 INFO - PID 3518 | Values: 473.6 489.7 508.6 514.7 516.9 6040.6 6094.8 6110.1 6111.1 6143.1 5828.8 5928.7 5951.8 5967.6 6032.6 4830.3 4831.2 4851.4 4883.8 4926.3 4800.2 4852.0 4853.1 4875.2 4883.4 4811.8 4836.3 4845.9 4847.2 4892.4 4556.3 4740.6 4787.7 4793.3 4806.6 4295.6 4309.3 4326.2 4369.8 4387.2 5747.8 5765.4 5795.4 5840.4 5840.4 5476.0 5519.7 5524.6 5587.6 5588.3 6301.4 6306.4 6319.7 6358.5 6361.9 4788.7 4802.4 4808.0 4812.3 4824.0 6659.2 6675.6 6678.6 6729.7 6765.2 4916.2 4951.0 4953.2 4959.3 4969.4 4995.9 5014.6 5023.6 5025.5 5029.2 5409.7 5474.5 5496.5 5496.8 5503.6 6227.6 6328.2 6331.0 6337.4 6338.8 1696.8 1697.9 1743.6 1746.8 1758.6 1115.5 1210.5 1212.6 1219.3 1228.3 5454.6 5522.9 5572.3 5623.7 5631.6 6395.5 6467.5 6563.9 6595.4 6641.8 5601.0 5645.4 5652.4 5653.7 5673.3 3452.5 3476.8 3477.9 3494.2 3527.2 6314.4 6399.0 6410.5 6418.4 6426.0 6757.3 6781.7 6782.0 6799.3 6801.2 6379.7 6386.1 6416.0 6425.2 6455.5 6538.6 6549.9 6583.6 6610.0 6628.5 6439.9 6454.0 6466.2 6482.6 6509.6 6246.8 6343.9 6348.7 6348.9 6395.7 4865.0 4888.2 4888.5 4895.2 4920.6 6436.5 6482.9 6502.5 6609.7 6627.8 6346.2 6346.3 6361.4 6366.7 6431.0 6289.6 6344.3 6372.7 6399.2 6421.6 6200.2 6277.6 6297.5 6322.7 6332.5 6302.5 6321.8 6322.9 6368.7 6390.3 5921.0 6030.7 6109.2 6109.5 6183.2 05:03:06 INFO - PID 3518 | 05:03:06 INFO - PID 3518 | [#5] yui.html Cycles:180 Average:21793.78 Median:20531.44 stddev:28467.27 (138.7%) stddev-sans-first:28503.92 05:03:06 INFO - PID 3518 | Values: 905.6 908.3 920.5 920.9 923.1 16256.0 16534.0 16570.6 16660.9 18223.8 19521.8 20286.1 21120.7 21127.4 21127.7 1019.0 1038.6 1047.0 1047.4 1047.7 1064.4 1067.2 1069.0 1071.3 1072.0 779.6 798.5 1050.8 1122.2 1123.6 1097.8 1099.5 1105.5 1109.0 1109.9 807.8 810.0 814.0 816.0 819.9 17471.4 18087.2 19580.4 19794.9 19827.0 19462.8 19650.6 20015.2 20024.9 20853.7 14601.2 14974.9 15095.2 15121.6 15142.6 3467.3 3477.5 3516.7 3518.5 3522.7 109760.0 111487.4 114547.4 116065.1 116309.0 14471.1 14561.8 14779.5 14843.7 14945.9 25182.0 26269.3 26269.7 26322.1 26578.6 8149.2 8266.9 8274.8 8321.8 8330.6 3712.3 3809.8 3815.3 4140.2 4398.9 4825.6 4920.6 4971.6 4971.7 4977.7 860.8 900.7 967.4 984.8 990.3 635.0 672.4 714.1 724.3 734.4 10988.2 11445.9 12343.5 12749.1 13060.9 651.5 659.5 674.4 675.8 676.0 5115.2 5363.3 5487.1 5531.3 5568.7 92323.5 96282.0 97108.0 98863.0 100833.5 83996.6 84480.9 87745.0 87847.0 90603.5 70904.0 73493.0 74111.0 75481.6 77009.0 11473.4 11707.7 11864.9 11978.4 12222.8 33891.3 35012.8 36449.3 36724.0 37103.3 62124.0 64471.7 65089.7 65825.0 66354.7 17168.0 17724.7 18066.4 18219.5 18706.8 20136.6 20776.8 20817.5 21000.4 21131.9 18672.4 18728.5 18738.3 18819.6 19039.5 17744.9 18117.6 19262.5 19606.3 19647.2 16819.0 18318.8 18424.2 18519.4 18574.3 12542.8 13010.3 13364.0 13463.7 13705.0 12377.3 13382.8 13507.2 14845.0 14851.5 05:03:06 INFO - PID 3518 | -------- Summary: end -------- 05:03:06 INFO - PID 3518 | 05:03:07 INFO - TEST-INFO | 3518: exit 0 05:03:07 INFO - TEST-OK | dromaeo_css | took 1117559ms 05:03:07 INFO - TEST-START | kraken 05:03:07 INFO - Initialising browser for kraken test... 05:03:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51233/getInfo.html -profile /tmp/tmp5MLdK0/profile 05:03:07 INFO - TEST-INFO | started process 3925 (/builds/slave/test/build/application/firefox/firefox http://localhost:51233/getInfo.html) 05:03:13 INFO - TEST-INFO | 3925: exit 0 05:03:13 INFO - Browser initialized. 05:03:13 INFO - Running cycle 1/1 for kraken test... 05:03:13 INFO - TEST-INFO | started process 4131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MLdK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:25 INFO - PID 4131 | RSS: Main: 170934272 05:03:25 INFO - PID 4131 | 05:03:27 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51233/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:28 INFO - PID 4131 | RSS: Main: 175816704 05:03:28 INFO - PID 4131 | 05:03:31 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51233/tests/kraken/driver.html?testName=audio-dft) 05:03:31 INFO - PID 4131 | RSS: Main: 175783936 05:03:31 INFO - PID 4131 | 05:03:34 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51233/tests/kraken/driver.html?testName=audio-fft) 05:03:35 INFO - PID 4131 | RSS: Main: 170016768 05:03:35 INFO - PID 4131 | 05:03:37 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51233/tests/kraken/driver.html?testName=audio-oscillator) 05:03:38 INFO - PID 4131 | RSS: Main: 171114496 05:03:38 INFO - PID 4131 | 05:03:40 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:40 INFO - PID 4131 | RSS: Main: 170799104 05:03:40 INFO - PID 4131 | 05:03:43 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51233/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:44 INFO - PID 4131 | RSS: Main: 174587904 05:03:44 INFO - PID 4131 | 05:03:47 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51233/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:48 INFO - PID 4131 | RSS: Main: 175951872 05:03:48 INFO - PID 4131 | 05:03:51 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51233/tests/kraken/driver.html?testName=json-parse-financial) 05:03:51 INFO - PID 4131 | RSS: Main: 175378432 05:03:51 INFO - PID 4131 | 05:03:53 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:54 INFO - PID 4131 | RSS: Main: 175185920 05:03:54 INFO - PID 4131 | 05:03:55 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:56 INFO - PID 4131 | RSS: Main: 174915584 05:03:56 INFO - PID 4131 | 05:03:58 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:59 INFO - PID 4131 | RSS: Main: 174694400 05:03:59 INFO - PID 4131 | 05:04:01 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:02 INFO - PID 4131 | RSS: Main: 174596096 05:04:02 INFO - PID 4131 | 05:04:05 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:06 INFO - PID 4131 | RSS: Main: 174571520 05:04:06 INFO - PID 4131 | 05:04:07 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:51233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51233/tests/kraken/driver.html?testName=ai-astar) 05:04:08 INFO - PID 4131 | RSS: Main: 175824896 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | __start_tp_report 05:04:08 INFO - PID 4131 | _x_x_mozilla_page_load 05:04:08 INFO - PID 4131 | _x_x_mozilla_page_load_details 05:04:08 INFO - PID 4131 | |i|pagename|runs| 05:04:08 INFO - PID 4131 | |0;ai-astar;101;110;109;108;111;109;108;110;110;112 05:04:08 INFO - PID 4131 | |1;audio-beat-detection;144;124;147;180;120;151;152;120;171;120 05:04:08 INFO - PID 4131 | |2;audio-dft;164;163;163;162;161;160;165;167;182;171 05:04:08 INFO - PID 4131 | |3;audio-fft;76;76;75;162;75;75;74;76;95;75 05:04:08 INFO - PID 4131 | |4;audio-oscillator;81;82;133;81;82;82;126;82;81;129 05:04:08 INFO - PID 4131 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;115;114;114 05:04:08 INFO - PID 4131 | |6;imaging-darkroom;150;150;150;151;150;150;149;151;149;149 05:04:08 INFO - PID 4131 | |7;imaging-desaturate;95;95;95;94;95;94;94;94;95;94 05:04:08 INFO - PID 4131 | |8;json-parse-financial;55;59;54;54;54;54;59;53;54;55 05:04:08 INFO - PID 4131 | |9;json-stringify-tinderbox;54;54;54;54;54;53;54;55;55;54 05:04:08 INFO - PID 4131 | |10;stanford-crypto-aes;76;90;77;76;79;76;76;76;76;77 05:04:08 INFO - PID 4131 | |11;stanford-crypto-ccm;126;128;132;133;129;126;130;132;130;160 05:04:08 INFO - PID 4131 | |12;stanford-crypto-pbkdf2;177;191;177;181;189;180;177;183;179;176 05:04:08 INFO - PID 4131 | |13;stanford-crypto-sha256-iterative;75;73;70;70;71;67;65;68;68;66 05:04:08 INFO - PID 4131 | __end_tp_report 05:04:08 INFO - PID 4131 | __start_cc_report 05:04:08 INFO - PID 4131 | _x_x_mozilla_cycle_collect,952 05:04:08 INFO - PID 4131 | __end_cc_report 05:04:08 INFO - PID 4131 | __startTimestamp1499774648131__endTimestamp 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | ------- Summary: start ------- 05:04:08 INFO - PID 4131 | Number of tests: 14 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.01 (2.7%) stddev-sans-first:1.32 05:04:08 INFO - PID 4131 | Values: 101.0 110.0 109.0 108.0 111.0 109.0 108.0 110.0 110.0 112.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.00 stddev:21.76 (14.6%) stddev-sans-first:23.08 05:04:08 INFO - PID 4131 | Values: 144.0 124.0 147.0 180.0 120.0 151.0 152.0 120.0 171.0 120.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#2] audio-dft Cycles:10 Average:165.80 Median:164.50 stddev:6.51 (4.0%) stddev-sans-first:6.87 05:04:08 INFO - PID 4131 | Values: 164.0 163.0 163.0 162.0 161.0 160.0 165.0 167.0 182.0 171.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.50 stddev:27.46 (36.4%) stddev-sans-first:28.89 05:04:08 INFO - PID 4131 | Values: 76.0 76.0 75.0 162.0 75.0 75.0 74.0 76.0 95.0 75.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.50 stddev:23.13 (28.4%) stddev-sans-first:23.90 05:04:08 INFO - PID 4131 | Values: 81.0 82.0 133.0 81.0 82.0 82.0 126.0 82.0 81.0 129.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:04:08 INFO - PID 4131 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:04:08 INFO - PID 4131 | Values: 150.0 150.0 150.0 151.0 150.0 150.0 149.0 151.0 149.0 149.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:04:08 INFO - PID 4131 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:2.13 (3.9%) stddev-sans-first:2.26 05:04:08 INFO - PID 4131 | Values: 55.0 59.0 54.0 54.0 54.0 54.0 59.0 53.0 54.0 55.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 05:04:08 INFO - PID 4131 | Values: 54.0 54.0 54.0 54.0 54.0 53.0 54.0 55.0 55.0 54.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:76.50 stddev:4.36 (5.7%) stddev-sans-first:4.57 05:04:08 INFO - PID 4131 | Values: 76.0 90.0 77.0 76.0 79.0 76.0 76.0 76.0 76.0 77.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:131.00 stddev:9.92 (7.6%) stddev-sans-first:10.23 05:04:08 INFO - PID 4131 | Values: 126.0 128.0 132.0 133.0 129.0 126.0 130.0 132.0 130.0 160.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:180.50 stddev:5.23 (2.9%) stddev-sans-first:5.34 05:04:08 INFO - PID 4131 | Values: 177.0 191.0 177.0 181.0 189.0 180.0 177.0 183.0 179.0 176.0 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:3.13 (4.5%) stddev-sans-first:2.55 05:04:08 INFO - PID 4131 | Values: 75.0 73.0 70.0 70.0 71.0 67.0 65.0 68.0 68.0 66.0 05:04:08 INFO - PID 4131 | -------- Summary: end -------- 05:04:08 INFO - PID 4131 | 05:04:08 INFO - PID 4131 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:04:08 INFO - TEST-INFO | 4131: exit 0 05:04:08 INFO - TEST-OK | kraken | took 61664ms 05:04:08 INFO - SUITE-END | took 1179s 05:04:09 INFO - Completed test suite (00:19:39) 05:04:09 INFO - javascript benchmark 05:04:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8269.208660697763, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.438141134595, 3140.371925614877, 3164.825934573599, 3167.2240301126226, 3191.6808319168085, 6035.3964603539625, 6055.485283750886, 6062.878742425149, 6103.786367477139, 6144.877102457948, 6084.087386891968, 6125.66308853014, 6128.233970753656, 6143.416375444325, 6153.384661533855, 5564.026295398309, 5572.331320241567, 5608.46719561641, 5618.494335509803, 5631.60578759487, 5604.495595396414, 5611.0, 5614.747336369853, 5624.21261023457, 5634.098544232924, 5614.691191984439, 5622.93164298784, 5623.0, 5634.521065709419, 5644.181593668915, 5552.361478429992, 5556.111022236463, 5559.63862348946, 5599.132134519135, 5604.943950560483, 5541.27963364764, 5551.139573366135, 5552.500274975231, 5567.4432556744405, 5651.406602306781, 5943.04911214208, 6020.6688632125215, 6060.515158787286, 6084.939150608526, 6105.053716673922, 6465.030245463218, 6466.547341686084, 6548.37790409915, 6557.967210163966, 6565.80302590923, 6456.354364563506, 6559.6064236145985, 6562.770303039419, 6563.638999855006, 6565.606063636197, 6036.547258955552, 6082.847928801771, 6100.96949515254, 6108.816735497942, 6113.694315284262, 6673.632950187689, 6692.397684208445, 6695.933040669531, 6721.0, 6764.492663050192, 6314.463270621956, 6359.20509936258, 6365.713542890581, 6437.710303036374, 6439.259485159173, 6488.059231411419, 6497.0, 6555.836104097436, 6559.7376104955265, 6569.014647802868, 6358.968205158944, 6419.80740577774, 6454.128692626529, 6455.322191169954, 6462.127612772216, 6308.369163083747, 6318.557700960981, 6483.546151769425, 6491.221053473519, 6546.9017964730565, 5117.820876269313, 5295.4969277918535, 5351.464853514617, 5376.516113549721, 5384.353877534721, 4497.6851620386915, 4510.954890451119, 4546.681732278708, 4551.3173024046655, 4555.407796986437, 5650.124230744241, 5652.152177173375, 5654.0, 5658.575606829504, 5659.292588426447, 6538.248101468392, 6554.672266386661, 6561.934380656132, 6562.934370656328, 6581.901271480931, 5637.295338082739, 5689.943100568941, 5690.829275121753, 5697.857553561194, 5702.914456283159, 5698.629589076697, 5766.0, 5766.654000759884, 5783.132530120515, 5787.971060144672, 5071.670341427869, 6250.624962502265, 6263.091851681481, 6472.255690595548, 6478.773242936569, 6520.119783829123, 6550.115734375799, 6564.081028656087, 6625.138731964814, 6652.800415987528, 6335.271443784024, 6358.904616430665, 6437.742490300336, 6449.322821103717, 6458.741650333934, 6262.937370626418, 6385.10608514799, 6403.743850245938, 6418.229812422353, 6504.674766261763, 4981.850544483671, 6555.639439830855, 6574.276829548841, 6608.041833934149, 6697.497687673542, 6326.525510586633, 6361.840953976188, 6449.5485316027425, 6455.096286519797, 6482.481401487776, 6362.809115726535, 6387.616742995435, 6449.806505804833, 6450.032495125769, 6452.516061295328, 6173.166622505904, 6280.654563998841, 6299.811005669837, 6313.747450101944, 6391.2330520337855, 6273.686315684106, 6318.905216421849, 6324.335944725737, 6334.968325158345, 6354.52341074412, 4985.326980857682, 6060.060690592965, 6136.877262454636, 6241.812745617639, 6312.43188113072], "value": 5941.652350189514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.9118996910339, 852.2925971443701, 871.9564021798908, 889.5507768576867, 1088.6298658456124, 29323.0, 40649.3902591461, 41259.58740412595, 41367.37948930765, 41439.17121657565, 40728.0, 41132.79433602835, 41210.0, 41256.58743412565, 41316.76049718506, 7511.0, 7600.315971562558, 7634.694612215505, 7652.04349456318, 7661.157272699998, 7409.55542667439, 7527.849443011164, 7642.694292228304, 7663.923360766376, 7696.846063078735, 7639.3124618784295, 7651.770446886574, 7651.885221721679, 7660.0, 7674.347680447168, 7557.168711441737, 7586.241375862425, 7597.886031709529, 7602.0877494700435, 7613.961930190341, 7513.0, 7557.0, 7562.621868906533, 7565.432592555525, 7617.0, 37369.252614947545, 37552.24895502102, 37562.0, 37587.24825503502, 37640.0, 3505.211327451303, 3535.840887160058, 3552.413851714464, 3558.768680035789, 3584.1398064464342, 30640.84679576588, 30696.693033069605, 30761.8461907689, 30810.691893081006, 30925.690743092506, 4610.746408947506, 4657.371254880615, 4838.637102217348, 4938.1111399947995, 4973.776180071905, 182111.0, 183639.0, 185366.0, 189204.05397973058, 189895.0, 48177.518224818006, 48370.758146209046, 48763.756181218865, 48869.755651221516, 49126.26310605344, 50597.49402506001, 50812.0, 50824.491755082716, 50943.745281274096, 50994.74502627537, 16175.0, 16236.0, 16245.756313655069, 16438.506844794676, 16488.17559122039, 13695.794563081561, 13715.451381944611, 13732.725345493234, 13788.93105534486, 13826.861731382758, 14016.0, 14022.719545609234, 14255.714885702228, 14339.283035848166, 14423.49517766873, 5521.972390138024, 5637.68992705397, 5685.573581981368, 5784.913226301609, 5799.681017543991, 971.4511301114848, 977.3659986336896, 987.4766373821742, 1012.2408193854609, 1012.6354512375539, 22448.551028979655, 22530.098796048303, 22636.773632263466, 22696.432589185402, 29554.261143471584, 1086.8152414089623, 1098.1215027977587, 1109.2290857853875, 1109.3343993603935, 1119.2780656476689, 12401.13192076564, 12401.93799030999, 12433.254004759743, 12439.004879609609, 12536.122471427096, 224070.0, 226911.0, 227542.0, 228367.0, 228787.0, 52010.479895200566, 52286.73856630692, 52657.0, 52671.47328526742, 52781.0, 1428.5285855667605, 1519.620094976256, 1531.1808182622244, 1535.9001664891746, 1548.6747782965704, 21728.78271217331, 21958.288514402277, 22402.66396004094, 22646.886765566065, 23014.769852301262, 38413.2317353657, 38618.42072368973, 38635.2272954545, 38702.2259554813, 38738.0315492115, 202663.0, 203331.0, 203458.0, 203559.0, 203672.0, 31210.37579248357, 31432.214194645316, 31602.209944751565, 31682.0, 34078.318433631684, 41643.0, 43468.782656086514, 44017.0, 44393.0, 44715.55284447114, 30042.3991520164, 30376.696233037386, 31337.216569585944, 31573.8421307892, 32037.35925281528, 31398.0, 31586.52620210653, 31882.840585796923, 32354.83822580872, 33683.663163369034, 38678.80660596679, 38783.224335513696, 39047.41428878512, 39365.80317098396, 39482.60517394789, 31020.379592407575, 33529.49705754367, 33587.83206083954, 33989.49015764815, 34433.13917152091, 23896.40258993539, 24058.39854003664, 24642.630360544248, 24696.382590435383, 24710.50578988446], "value": 17158.369829146373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1457241276021, 557.5093917352732, 562.2606272751332, 587.8001479496971, 604.6825416656255, 21747.34757957262, 22555.887220563916, 22579.096836126577, 22679.886600566995, 22789.0, 24320.27039188823, 25680.486390272185, 27020.189394318153, 27062.323441913963, 27062.45875082497, 6451.870962580746, 6584.934150658504, 6592.274849766522, 6592.439642630382, 6598.571092878971, 6539.149910511627, 6544.0511125886715, 6581.901271480931, 6588.670566471681, 6599.208095028604, 6128.724207410655, 6206.0, 6366.0, 6367.4906007519285, 6511.055896894947, 6399.168108145935, 6476.44950179233, 6547.5089368297095, 6547.672616369163, 6568.93431065688, 5438.265834112383, 5698.259226300595, 5930.466258036754, 6071.271447426293, 6123.142760013558, 29444.0, 29997.400051998837, 30074.24814379636, 30120.0, 30135.095947121623, 1977.1004193092108, 1999.7700264469627, 2009.2867032203649, 2010.859239853211, 2012.9295474658318, 18127.093645317815, 18814.623707525774, 19308.903455482774, 19321.0, 19372.4188274352, 2316.501952080294, 2361.669366288721, 2363.6218205087275, 2379.0959435414607, 2381.3213234228333, 120723.0, 122785.38607306995, 122983.0, 123103.76896231013, 123492.38253808764, 14697.92651036738, 15154.848451515565, 15214.543563693107, 15353.929214157213, 15419.92290038565, 23514.88366047064, 23681.881590591936, 23716.52566948686, 23788.405289867893, 23797.52404951926, 10483.528241229164, 10543.367397956146, 10706.678799636024, 10713.578388655666, 10877.347359158317, 9929.50352482373, 9972.301938864355, 10082.74793130163, 10162.542685579167, 10244.053629810312, 8996.910030899739, 9187.586558604879, 9349.0, 9416.0, 9426.717198484057, 2602.687677478677, 2616.188981415767, 2647.2984659065364, 2749.3398689221576, 2777.250332290644, 926.4996901673021, 930.8696782450462, 947.1806887042659, 973.4013581647235, 984.0995489127512, 18477.90761046186, 18718.53203669919, 18791.0, 18817.717734233996, 18961.146748396357, 1004.0812656419295, 1016.517154351677, 1027.8817935937464, 1044.3994703045628, 1055.2613170780485, 10252.282340236261, 10383.688489345332, 10397.064264216257, 10438.321509101885, 10462.68611941643, 436244.0, 440166.0, 447145.0, 449387.0, 452570.0, 108955.0, 109377.0, 110378.44810775894, 110916.0, 111684.0, 1218.1594699657207, 1240.522398876439, 1258.4274155259518, 1260.5462033667873, 1269.6825793551611, 16346.754798678267, 20840.895795520926, 21570.0, 21707.240246591293, 21781.0, 52558.0, 55044.44955550393, 55699.0, 56477.71761141168, 57578.7121064392, 62383.0, 63011.36988630055, 64296.67851660712, 64722.676386617764, 64984.67507662431, 14701.117932924059, 15180.924095379452, 15198.848011519744, 15225.467108651144, 15233.162176079979, 22425.887870560542, 23469.647955280343, 23707.1702490412, 23784.0, 24390.634140488262, 18431.815681843545, 18783.90608046951, 18921.148548315636, 18957.620847583246, 18959.526011849815, 14476.203808790196, 15063.0, 15507.0, 15601.453949111727, 16240.431584894472, 18960.52598685044, 19094.0, 19266.807331926502, 19449.708254375913, 19517.34102601295, 14878.628034299229, 14885.0, 14956.401743930555, 14997.250137492863, 15065.397384104514, 17747.556311092325, 18632.906835466278, 18645.347412840485, 18713.25146994105, 18761.530961726065], "value": 11896.111634218087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.2238301784967, 1393.317274535478, 1396.2530046425165, 1399.6081097292756, 1407.2752532445793, 12807.295598742065, 13409.195448273085, 13410.66473338167, 13437.664058398545, 13455.798163027563, 13298.933505332485, 13676.52132175374, 14022.088564243317, 14123.717525649481, 14152.92923535381, 2630.644862943502, 2670.586059160833, 2672.2116975492277, 2672.7460891215305, 2673.438577898634, 2544.910928117516, 2621.790256779453, 2626.9080582179627, 2630.539655560279, 2632.605109233611, 2537.314924970257, 2593.2609206376187, 2606.609008648699, 2635.433381822908, 2635.960460593083, 2604.6744156980376, 2687.5296823055887, 2690.5426077566863, 2692.6230327754033, 2697.878595463209, 2554.2848002559313, 2598.0517111254258, 2602.4534847682007, 2613.163787587973, 2620.816542842002, 13146.737065258641, 13369.197848129046, 13441.66395840102, 13445.19328840263, 13480.932595337059, 7108.5734855908295, 7405.481616286862, 7429.331360177556, 7435.219301973269, 7459.701611935516, 4965.553100220997, 4994.600431965434, 5152.278680984665, 5197.0385478686185, 5234.162533994542, 1808.7558179645712, 1812.5649844037337, 1847.667419864424, 1861.9255229790792, 1867.5237814357388, 20245.392638220877, 20354.389368318974, 20505.2823151189, 20507.89746051275, 20536.486587835276, 6168.537359697951, 6214.906776398358, 6353.936460635335, 6373.808785736435, 6486.902696459557, 14488.85511144875, 14514.346854391577, 14530.418783248762, 14543.200123993282, 14552.708945821025, 7300.780976570712, 7345.412367010626, 7384.704611815468, 7429.851402972018, 7465.477416580896, 6866.450683945272, 6868.210155832044, 6869.278725733826, 6918.7232510699005, 7007.054047703597, 4703.576678098988, 4839.951600484021, 4907.288443175719, 4947.208446648591, 4964.826231081895, 1458.1032664911004, 1462.1165307871759, 1468.6181592785952, 1473.4990103364694, 1479.7780332950144, 882.170759486081, 899.9595018224196, 902.4495058014737, 912.3795818843117, 930.948797816113, 7125.857482850314, 7159.212486626467, 7297.9635101825215, 7299.124105107421, 7313.451491138186, 676.4926305271047, 698.91263592051, 972.8200282947678, 989.2284018465608, 989.7278248481581, 4718.292256161603, 5079.288899554065, 5095.235714642833, 5139.794408223704, 5171.172612382076, 16752.91623541899, 17749.822501774815, 17807.10964451772, 17905.641887162183, 18095.0, 16823.41118060862, 17262.309507619804, 17615.207315670825, 17619.207135678924, 17729.911350443166, 10028.846682631445, 10117.342372745601, 10343.37939723619, 10379.84430233547, 10382.3251488653, 7344.96327518359, 7761.379089672925, 7872.448928575174, 7880.0, 7978.561179135203, 15002.399904003718, 15454.381824726885, 15669.686606268038, 15719.921400393383, 15720.0, 15106.018108822891, 15457.304421301293, 15673.0, 15851.524454266391, 15979.0, 10114.140298074746, 10191.03185197405, 10256.641017564349, 10273.9486302568, 10297.845532317171, 12258.20321679088, 12346.814797778221, 12386.071044671506, 12410.627681169579, 12503.749925001632, 9430.0, 9634.181094606756, 9733.172680322252, 9864.654737084455, 9910.108090271622, 9428.387154835189, 9701.6604418845, 9841.409515429097, 9847.409155450696, 9923.950380248052, 9024.0, 9076.41003334781, 9107.681231156877, 9137.954310228672, 9159.450432974043, 6514.3811337922825, 6658.334166583303, 6796.218434879855, 6818.045473633596, 6850.349216824394, 6924.238333783179, 6982.1272340957385, 7040.295970402919, 7093.3970612498515, 7153.642317884189], "value": 6092.731912045735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.57141786683064, 489.6988352163418, 508.5677174401758, 514.6834696661552, 516.9224616307556, 6040.607360521563, 6094.786682466114, 6110.144579758838, 6111.144439778429, 6143.139960405541, 5828.766849326033, 5928.6739229342365, 5951.821445356635, 5967.582269241155, 6032.607880487776, 4830.347903033098, 4831.202851529493, 4851.442084160322, 4883.755812209393, 4926.334944782444, 4800.231962885939, 4851.951480485185, 4853.102176097415, 4875.22054450125, 4883.365162528867, 4811.807527698906, 4836.250381190921, 4845.854624361257, 4847.224444088946, 4892.412910450751, 4556.2937744649635, 4740.620750339982, 4787.71273723576, 4793.2810078488155, 4806.615470762331, 4295.613394794453, 4309.310510318365, 4326.242907491176, 4369.781510924473, 4387.232234358974, 5747.82756517301, 5765.423457654243, 5795.362510123883, 5840.39389167978, 5840.445157710011, 5475.972620136914, 5519.668819870781, 5524.58565607581, 5587.636803607753, 5588.329400471929, 6301.369863013708, 6306.369363063657, 6319.715612797435, 6358.491320694333, 6361.872762544724, 4788.664793464459, 4802.35168252285, 4807.975960120177, 4812.25410061441, 4823.983057620071, 6659.167604049494, 6675.566088204251, 6678.632675202862, 6729.663516824188, 6765.2072200866805, 4916.222334381063, 4950.975245123751, 4953.182724850431, 4959.305697202394, 4969.35398398206, 4995.900081998412, 5014.623903207274, 5023.572996295356, 5025.547700706881, 5029.1643550103945, 5409.6754194747655, 5474.534664553478, 5496.450354964471, 5496.780128794803, 5503.614746967673, 6227.598790272153, 6328.17733694626, 6330.968345158245, 6337.397947195009, 6338.778142764981, 1696.8303169682933, 1697.8896371735798, 1743.5902562897709, 1746.7991181014347, 1758.5691505581215, 1115.5107930912322, 1210.4552951171831, 1212.587720175127, 1219.3232755820427, 1228.2569045727384, 5454.645448045864, 5522.91715624266, 5572.331320241516, 5623.746931388097, 5631.63394379364, 6395.537717978612, 6467.482601391877, 6563.9169537025855, 6595.373439523238, 6641.800745977628, 5601.0, 5645.407232240637, 5652.434756524314, 5653.717314134276, 5673.276827123004, 3452.5339079224486, 3476.7740096894127, 3477.8608855646, 3494.2138018945534, 3527.1534831640734, 6314.368563143649, 6399.0, 6410.455111315498, 6418.358164183544, 6425.967870160619, 6757.290484499155, 6781.6609169541325, 6782.0, 6799.3200679931615, 6801.18385793708, 6379.74481020754, 6386.137871387396, 6415.967920160556, 6425.2050358094375, 6455.4512866406885, 6538.574992625464, 6549.934500654933, 6583.604983700993, 6610.041543976193, 6628.469722422098, 6439.871202576016, 6453.967730161319, 6466.219525604036, 6482.6434546098535, 6509.641969691523, 6246.812595622138, 6343.9382200784, 6348.650824204713, 6348.9047664286, 6395.706211301276, 4864.975675121602, 4888.193448081027, 4888.462269150319, 4895.16782147043, 4920.5817505511, 6436.549441539048, 6482.935170648233, 6502.544821862424, 6609.669516524251, 6627.768028118992, 6346.2067241594805, 6346.301906790157, 6361.427471527585, 6366.721138613525, 6431.0, 6289.622622642656, 6344.333844946214, 6372.745090196526, 6399.232092148972, 6421.614703117828, 6200.193974783249, 6277.623342599459, 6297.4647154992335, 6322.715477803418, 6332.461740752087, 6302.527310451643, 6321.841953951188, 6322.936770632235, 6368.681565921778, 6390.329015453496, 5920.970395147997, 6030.698465076641, 6109.236345456818, 6109.541784366279, 6183.227096612924], "value": 4923.765264312279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.6015353244572, 908.3232991421388, 920.5305294299905, 920.903305152959, 923.0630909626728, 16256.0, 16534.0, 16570.585735356606, 16660.916695416538, 18223.817761822378, 19521.804781952178, 20286.087126079325, 21120.683189752166, 21127.366179014654, 21127.683084753742, 1018.9847152292722, 1038.5741845843206, 1047.0158051431667, 1047.376810797578, 1047.6856942917095, 1064.350746044916, 1067.1836045425257, 1068.9572417103307, 1071.3304184884448, 1072.0083922371814, 779.6062988190984, 798.4690181029608, 1050.76883085721, 1122.2424863217336, 1123.5786580032488, 1097.8078836203672, 1099.4997276239292, 1105.4804242006244, 1109.0406798119568, 1109.916756243277, 807.7617102954642, 809.9554524501209, 814.0028465130227, 816.049302562514, 819.8934138562008, 17471.38850140239, 18087.18607662645, 19580.412587622395, 19794.901025494924, 19827.0, 19462.80537194624, 19650.606987860163, 20015.1993920243, 20024.899875500676, 20853.68719469209, 14601.196934168616, 14974.850251497455, 15095.169765662884, 15121.621959450991, 15142.621434464116, 3467.289205712823, 3477.460993545979, 3516.7186625069935, 3518.47222916562, 3522.7005704515145, 109760.0, 111487.44256278747, 114547.42726286399, 116065.09837254052, 116308.99999999916, 14471.131732096108, 14561.78157327641, 14779.482718104815, 14843.703125937422, 14945.925270373797, 25181.99272029135, 26269.34326641811, 26269.73730262673, 26322.078727244836, 26578.6013209802, 8149.225823546753, 8266.917330826614, 8274.8345033099, 8321.791955201168, 8330.62512186953, 3712.331780279522, 3809.7523660961947, 3815.2941705783965, 4140.192662430857, 4398.868033958986, 4825.638077144228, 4920.581750551243, 4971.577415919687, 4971.651984361132, 4977.676451030671, 860.7934095817084, 900.7207765592556, 967.4050458967685, 984.7981163861391, 990.2770977186694, 634.9746010159635, 672.3948446398281, 714.1430283659525, 724.2721065329415, 734.4344854462034, 10988.175886808522, 11445.942770286096, 12343.506259749689, 12749.107562470537, 13060.934695326463, 651.5108824067376, 659.5317324699517, 674.3762020131359, 675.7702381190419, 675.9662016899234, 5115.2071428928575, 5363.2759577456545, 5487.094629386186, 5531.280933478622, 5568.693721845338, 92323.53838230901, 96282.0371796287, 97108.0, 98863.0, 100833.49583252036, 83996.58001710074, 84480.89230753873, 87745.0, 87847.0, 90603.54698226467, 70904.0, 73493.0, 74111.0, 75481.62259188779, 77009.0, 11473.36896470702, 11707.707307317045, 11864.881351186723, 11978.401079946143, 12222.75554488923, 33891.257303073246, 35012.82493587516, 36449.27101458009, 36724.0, 37103.25793484169, 62124.0, 64471.677641613365, 65089.67455162694, 65825.0, 66354.66822665856, 17168.0, 17724.734128988333, 18066.36767713124, 18219.45341639753, 18706.812931870507, 20136.59726805485, 20776.792232077485, 20817.479563011046, 21000.36998890036, 21131.8943405282, 18672.439826805217, 18728.531786704898, 18738.25046998105, 18819.623607527497, 19039.52401189981, 17744.91127544354, 18117.637647247244, 19262.518437039187, 19606.313779017666, 19647.214111435384, 16819.0, 18318.81681183171, 18424.170912309248, 18519.44441666752, 18574.25702971866, 12542.811857821958, 13010.349482526026, 13364.0, 13463.730725385632, 13705.0, 12377.257364558156, 13382.799258011333, 13507.189568625914, 14845.0, 14851.480198193012], "value": 8787.33752562699, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 108.0, 111.0, 109.0, 108.0, 110.0, 110.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 147.0, 180.0, 120.0, 151.0, 152.0, 120.0, 171.0, 120.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 161.0, 160.0, 165.0, 167.0, 182.0, 171.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 162.0, 75.0, 75.0, 74.0, 76.0, 95.0, 75.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 133.0, 81.0, 82.0, 82.0, 126.0, 82.0, 81.0, 129.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 150.0, 149.0, 151.0, 149.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 54.0, 54.0, 54.0, 54.0, 59.0, 53.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 90.0, 77.0, 76.0, 79.0, 76.0, 76.0, 76.0, 76.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 132.0, 133.0, 129.0, 126.0, 130.0, 132.0, 130.0, 160.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 191.0, 177.0, 181.0, 189.0, 180.0, 177.0, 183.0, 179.0, 176.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 70.0, 70.0, 71.0, 67.0, 65.0, 68.0, 68.0, 66.0], "value": 69.3, "unit": "score"}]}]} 05:04:09 INFO - Return code: 0 05:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:09 INFO - # TBPL SUCCESS # 05:04:09 INFO - Running post-action listener: _package_coverage_data 05:04:09 INFO - Running post-action listener: _resource_record_post_action 05:04:09 INFO - [mozharness: 2017-07-11 12:04:09.433930Z] Finished run-tests step (success) 05:04:09 INFO - Running post-run listener: _resource_record_post_run 05:04:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 5361664; Write bytes: 436056064; Read time: 1872; Write time: 524688 05:04:09 INFO - TinderboxPrint: CPU usage
13.1% 05:04:09 INFO - TinderboxPrint: I/O read bytes / time
5,361,664 / 1,872 05:04:09 INFO - TinderboxPrint: I/O write bytes / time
436,056,064 / 524,688 05:04:09 INFO - TinderboxPrint: CPU idle
8,299.0 (86.9%) 05:04:09 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 05:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:04:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107704320; Read time: 176; Write time: 105660 05:04:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:04:09 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 3203072; Write bytes: 320417792; Read time: 1548; Write time: 417128 05:04:10 INFO - Running post-run listener: _upload_blobber_files 05:04:10 INFO - Blob upload gear active. 05:04:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:10 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 05:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:14 INFO - (blobuploader) - INFO - Done attempting. 05:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:15 INFO - (blobuploader) - INFO - Done attempting. 05:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:15 INFO - (blobuploader) - INFO - Done attempting. 05:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:16 INFO - (blobuploader) - INFO - Done attempting. 05:04:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:16 INFO - Return code: 0 05:04:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4720a1df724df5c284eead44fcec69252a1d3abec9f55cb8e9861167a8cf85b1f289d1444e85ee1b8a513997c4212a9518815973fcff69d60fcfce6a4dd7c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/946624512decc39ba3ca86f14f4b7cdcdc77c8538bba61ea05c80b4c43d3d05a401ea3a339fb43ea88d6b91c0b72718364393ba8058fcc73b52fad2f70fcc3cc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f728ebdd6b0869276d0c9c1487f8d480c94ecffe14e369a47024ae2ed577d57eb73b89f147267cfd91aa29e2cfa6c12587c9b45ef5e87229fbe0c13509869448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dec4d5b6a95f447561266a7b3a9507df9d40d3cd4af3b671801525043075fef6b3cd52a0ce1230b6dda32ab0280577bbfff41dfcb98fbbbaa28aa09de14a442e"} 05:04:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:16 INFO - Contents: 05:04:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4720a1df724df5c284eead44fcec69252a1d3abec9f55cb8e9861167a8cf85b1f289d1444e85ee1b8a513997c4212a9518815973fcff69d60fcfce6a4dd7c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/946624512decc39ba3ca86f14f4b7cdcdc77c8538bba61ea05c80b4c43d3d05a401ea3a339fb43ea88d6b91c0b72718364393ba8058fcc73b52fad2f70fcc3cc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f728ebdd6b0869276d0c9c1487f8d480c94ecffe14e369a47024ae2ed577d57eb73b89f147267cfd91aa29e2cfa6c12587c9b45ef5e87229fbe0c13509869448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dec4d5b6a95f447561266a7b3a9507df9d40d3cd4af3b671801525043075fef6b3cd52a0ce1230b6dda32ab0280577bbfff41dfcb98fbbbaa28aa09de14a442e"} 05:04:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:16 INFO - Copying logs to upload dir... 05:04:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.096522 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-11 05:04:16.711548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-11 05:04:16.719166) ========= 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=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4720a1df724df5c284eead44fcec69252a1d3abec9f55cb8e9861167a8cf85b1f289d1444e85ee1b8a513997c4212a9518815973fcff69d60fcfce6a4dd7c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/946624512decc39ba3ca86f14f4b7cdcdc77c8538bba61ea05c80b4c43d3d05a401ea3a339fb43ea88d6b91c0b72718364393ba8058fcc73b52fad2f70fcc3cc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f728ebdd6b0869276d0c9c1487f8d480c94ecffe14e369a47024ae2ed577d57eb73b89f147267cfd91aa29e2cfa6c12587c9b45ef5e87229fbe0c13509869448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dec4d5b6a95f447561266a7b3a9507df9d40d3cd4af3b671801525043075fef6b3cd52a0ce1230b6dda32ab0280577bbfff41dfcb98fbbbaa28aa09de14a442e"} build_url:https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/D9Mb_MqLSoCn5HSfVGmfbA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4720a1df724df5c284eead44fcec69252a1d3abec9f55cb8e9861167a8cf85b1f289d1444e85ee1b8a513997c4212a9518815973fcff69d60fcfce6a4dd7c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/946624512decc39ba3ca86f14f4b7cdcdc77c8538bba61ea05c80b4c43d3d05a401ea3a339fb43ea88d6b91c0b72718364393ba8058fcc73b52fad2f70fcc3cc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f728ebdd6b0869276d0c9c1487f8d480c94ecffe14e369a47024ae2ed577d57eb73b89f147267cfd91aa29e2cfa6c12587c9b45ef5e87229fbe0c13509869448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dec4d5b6a95f447561266a7b3a9507df9d40d3cd4af3b671801525043075fef6b3cd52a0ce1230b6dda32ab0280577bbfff41dfcb98fbbbaa28aa09de14a442e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-11 05:04:16.746198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 05:04:16.746557) ========= 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=eca2ab57546de7b41f256b19000001ef-1499773391.5435-590378308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 05:04:16.827535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-11 05:04:16.830865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-11 05:04:16.831159) ========= ========= Total master_lag: 0.16 =========