builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1499773240.97 results: success (0) revision: b07db5d650b7056c78ba0dbc409d060ec4e922cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:40.970215) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:40.970725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-07-11 04:40:40.971026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-07-11 04:40:44.631588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:44.631843) ========= 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=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-11 04:40:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-11 04:40:45 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.690751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:45.335778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:45.336115) ========= 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=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013899 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:45.386182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-07-11 04:40:45.386518) ========= 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=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-11 04:40:46,108 truncating revision to first 12 chars 2017-07-11 04:40:46,108 Setting DEBUG logging. 2017-07-11 04:40:46,108 attempt 1/10 2017-07-11 04:40:46,108 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:40:48,199 unpacking tar archive at: mozilla-central-b07db5d650b7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.386801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-07-11 04:40:47.787368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:47.787887) ========= script_repo_revision: b07db5d650b7056c78ba0dbc409d060ec4e922cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:47.788440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:47.788732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-11 04:40:47.798725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-11 04:40:47.799227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:48 INFO - MultiFileLogger online at 20170711 04:40:48 in /builds/slave/test 04:40:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:40:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:48 INFO - {'append_to_log': False, 04:40:48 INFO - 'base_work_dir': '/builds/slave/test', 04:40:48 INFO - 'blob_upload_branch': 'Firefox', 04:40:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:48 INFO - 'branch': 'Firefox', 04:40:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:48 INFO - 'code_coverage': False, 04:40:48 INFO - 'config_files': ('talos/linux_config.py',), 04:40:48 INFO - 'default_actions': ('clobber', 04:40:48 INFO - 'read-buildbot-config', 04:40:48 INFO - 'download-and-extract', 04:40:48 INFO - 'populate-webroot', 04:40:48 INFO - 'create-virtualenv', 04:40:48 INFO - 'install', 04:40:48 INFO - 'setup-mitmproxy', 04:40:48 INFO - 'run-tests'), 04:40:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:48 INFO - 'disable_ccov_upload': False, 04:40:48 INFO - 'download_minidump_stackwalk': True, 04:40:48 INFO - 'download_symbols': 'ondemand', 04:40:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:48 INFO - 'gecko_profile': False, 04:40:48 INFO - 'gecko_profile_interval': 0, 04:40:48 INFO - 'installer_path': 'installer.exe', 04:40:48 INFO - 'log_level': 'info', 04:40:48 INFO - 'log_name': 'talos', 04:40:48 INFO - 'log_to_console': True, 04:40:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:48 INFO - 'opt_config_files': (), 04:40:48 INFO - 'pip_index': False, 04:40:48 INFO - 'suite': 'dromaeojs-e10s', 04:40:48 INFO - 'system_bits': '32', 04:40:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:48 INFO - 'title': 'talos-linux64-ix-054', 04:40:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:48 INFO - 'use_talos_json': True, 04:40:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:48 INFO - 'work_dir': 'build'} 04:40:48 INFO - [mozharness: 2017-07-11 11:40:48.630487Z] Running clobber step. 04:40:48 INFO - Running pre-action listener: _resource_record_pre_action 04:40:48 INFO - Running main action method: clobber 04:40:48 INFO - rmtree: /builds/slave/test/build 04:40:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:50 INFO - Running post-action listener: _resource_record_post_action 04:40:50 INFO - [mozharness: 2017-07-11 11:40:50.179633Z] Finished clobber step (success) 04:40:50 INFO - [mozharness: 2017-07-11 11:40:50.179734Z] Running read-buildbot-config step. 04:40:50 INFO - Running pre-action listener: _resource_record_pre_action 04:40:50 INFO - Running main action method: read_buildbot_config 04:40:50 INFO - Using buildbot properties: 04:40:50 INFO - { 04:40:50 INFO - "project": "", 04:40:50 INFO - "product": "firefox", 04:40:50 INFO - "who": "cbook@mozilla.com", 04:40:50 INFO - "installer_path": "public/build/target.tar.bz2", 04:40:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:40:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:40:50 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:40:50 INFO - "stage_platform": "linux64-stylo", 04:40:50 INFO - "basedir": "/builds/slave/test", 04:40:50 INFO - "buildnumber": 202, 04:40:50 INFO - "platform": "ubuntu64_hw_stylo", 04:40:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:40:50 INFO - "slavebuilddir": "test", 04:40:50 INFO - "taskId": "aKZiLNLRTyOabXFcnNcyNQ", 04:40:50 INFO - "branch": "mozilla-central", 04:40:50 INFO - "script_repo_revision": "production", 04:40:50 INFO - "revision": "b07db5d650b7056c78ba0dbc409d060ec4e922cd", 04:40:50 INFO - "slavename": "talos-linux64-ix-054", 04:40:50 INFO - "repo_path": "mozilla-central" 04:40:50 INFO - } 04:40:50 INFO - Finding installer, test and symbols from parent task. 04:40:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKZiLNLRTyOabXFcnNcyNQ'}, attempt #1 04:40:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKZiLNLRTyOabXFcnNcyNQ'}, attempt #1 04:40:51 INFO - Task dependencies: WVdPpzIcS7G9M8yUkSwEXA 04:40:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA'}, attempt #1 04:40:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 04:40:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/test_packages.json 04:40:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.crashreporter-symbols.zip 04:40:52 INFO - Running post-action listener: _resource_record_post_action 04:40:52 INFO - [mozharness: 2017-07-11 11:40:52.690024Z] Finished read-buildbot-config step (success) 04:40:52 INFO - [mozharness: 2017-07-11 11:40:52.690248Z] Running download-and-extract step. 04:40:52 INFO - Running pre-action listener: _resource_record_pre_action 04:40:52 INFO - Running main action method: download_and_extract 04:40:52 INFO - mkdir: /builds/slave/test/build/tests 04:40:52 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:40:52 INFO - trying https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.test_packages.json 04:40:52 INFO - Downloading https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:40:53 INFO - Downloaded 989 bytes. 04:40:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:40:53 INFO - Using the following test package requirements: 04:40:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:40:53 INFO - u'common': [u'target.common.tests.zip'], 04:40:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:40:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:40:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:40:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:40:53 INFO - u'mozbase': [u'target.common.tests.zip'], 04:40:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:40:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:40:53 INFO - u'web-platform': [u'target.common.tests.zip', 04:40:53 INFO - u'target.web-platform.tests.tar.gz'], 04:40:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:40:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:40:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip 04:40:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:40:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip into memory 04:40:56 INFO - Content-Length response header: 67426973 04:40:56 INFO - Bytes received: 67426973 04:41:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:41:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip 04:41:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:41:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.common.tests.zip into memory 04:41:08 INFO - Content-Length response header: 67426973 04:41:08 INFO - Bytes received: 67426973 04:41:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.talos.tests.zip 04:41:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:41:20 INFO - Fetch https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.talos.tests.zip into memory 04:41:21 INFO - Content-Length response header: 14474423 04:41:21 INFO - Bytes received: 14474423 04:41:21 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:41:21 INFO - trying https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 04:41:21 INFO - Downloading https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:41:22 INFO - Downloaded 62241638 bytes. 04:41:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 04:41:22 INFO - mkdir: /builds/slave/test/properties 04:41:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:22 INFO - Contents: 04:41:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 04:41:22 INFO - Running post-action listener: _resource_record_post_action 04:41:22 INFO - Running post-action listener: set_extra_try_arguments 04:41:22 INFO - [mozharness: 2017-07-11 11:41:22.994576Z] Finished download-and-extract step (success) 04:41:22 INFO - [mozharness: 2017-07-11 11:41:22.994673Z] Running populate-webroot step. 04:41:22 INFO - Running pre-action listener: _resource_record_pre_action 04:41:22 INFO - Running main action method: populate_webroot 04:41:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:23 INFO - '--tppagecycles', 04:41:23 INFO - '7'], 04:41:23 INFO - 'tests': ['tsvgm']}}, 04:41:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:41:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:41:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:41:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['damp', 'tps']}, 04:41:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'tests': ['damp', 'tps']}, 04:41:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['dromaeo_dom']}, 04:41:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:41:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:41:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:41:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_many_windows', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_many_windows', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_many_windows', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['a11yr', 04:41:23 INFO - 'ts_paint', 04:41:23 INFO - 'tpaint', 04:41:23 INFO - 'sessionrestore', 04:41:23 INFO - 'sessionrestore_no_auto_restore', 04:41:23 INFO - 'tabpaint']}, 04:41:23 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 04:41:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:41:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:41:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:41:23 INFO - 'talos_options': ['--mitmproxy', 04:41:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:41:23 INFO - '--firstNonBlankPaint'], 04:41:23 INFO - 'tests': ['quantum_pageload_google', 04:41:23 INFO - 'quantum_pageload_youtube', 04:41:23 INFO - 'quantum_pageload_amazon', 04:41:23 INFO - 'quantum_pageload_facebook']}, 04:41:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['tsvgx', 04:41:23 INFO - 'tsvgr_opacity', 04:41:23 INFO - 'tart', 04:41:23 INFO - 'tscrollx', 04:41:23 INFO - 'cart', 04:41:23 INFO - 'tsvg_static']}, 04:41:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:41:23 INFO - 'tsvgr_opacity', 04:41:23 INFO - 'tart', 04:41:23 INFO - 'tscrollx', 04:41:23 INFO - 'cart', 04:41:23 INFO - 'tsvg_static']}, 04:41:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'talos_options': ['--disable-e10s'], 04:41:23 INFO - 'tests': ['tp5o']}, 04:41:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:41:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'talos_options': ['--disable-e10s', 04:41:23 INFO - '--xperf_path', 04:41:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:23 INFO - 'tests': ['tp5n']}, 04:41:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:41:23 INFO - 'talos_options': ['--xperf_path', 04:41:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:23 INFO - 'tests': ['tp5n']}}, 04:41:23 INFO - 'talos.zip': {'path': '', 04:41:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:23 INFO - Running post-action listener: _resource_record_post_action 04:41:23 INFO - [mozharness: 2017-07-11 11:41:23.010121Z] Finished populate-webroot step (success) 04:41:23 INFO - [mozharness: 2017-07-11 11:41:23.010212Z] Running create-virtualenv step. 04:41:23 INFO - Running pre-action listener: _resource_record_pre_action 04:41:23 INFO - Running main action method: create_virtualenv 04:41:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:23 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:41:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:41:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:23 INFO - Using real prefix '/usr' 04:41:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:25 INFO - Installing pip.................done. 04:41:25 INFO - Return code: 0 04:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:41:25 INFO - Reading from file tmpfile_stdout 04:41:25 INFO - Output received: 04:41:25 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:41:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:25 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:25 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:41:25 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:41:25 INFO - Using env: {'DISPLAY': ':0', 04:41:25 INFO - 'HOME': '/home/cltbld', 04:41:25 INFO - 'LANG': 'en_US.UTF-8', 04:41:25 INFO - 'LANGUAGE': 'en_US:en', 04:41:25 INFO - 'LOGNAME': 'cltbld', 04:41:25 INFO - 'MAIL': '/var/mail/cltbld', 04:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:25 INFO - 'MOZ_NO_REMOTE': '1', 04:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:25 INFO - 'NO_EM_RESTART': '1', 04:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:25 INFO - 'PWD': '/builds/slave/test', 04:41:25 INFO - 'SHELL': '/bin/bash', 04:41:25 INFO - 'SHLVL': '1', 04:41:25 INFO - 'TERM': 'linux', 04:41:25 INFO - 'TMOUT': '86400', 04:41:25 INFO - 'USER': 'cltbld', 04:41:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:25 INFO - '_': '/tools/buildbot/bin/python'} 04:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:26 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:41:26 INFO - Cleaning up... 04:41:26 INFO - Return code: 0 04:41:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:41:26 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:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:26 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:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:26 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:26 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:41:26 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:41:26 INFO - Using env: {'DISPLAY': ':0', 04:41:26 INFO - 'HOME': '/home/cltbld', 04:41:26 INFO - 'LANG': 'en_US.UTF-8', 04:41:26 INFO - 'LANGUAGE': 'en_US:en', 04:41:26 INFO - 'LOGNAME': 'cltbld', 04:41:26 INFO - 'MAIL': '/var/mail/cltbld', 04:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:26 INFO - 'MOZ_NO_REMOTE': '1', 04:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:26 INFO - 'NO_EM_RESTART': '1', 04:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:26 INFO - 'PWD': '/builds/slave/test', 04:41:26 INFO - 'SHELL': '/bin/bash', 04:41:26 INFO - 'SHLVL': '1', 04:41:26 INFO - 'TERM': 'linux', 04:41:26 INFO - 'TMOUT': '86400', 04:41:26 INFO - 'USER': 'cltbld', 04:41:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:26 INFO - '_': '/tools/buildbot/bin/python'} 04:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:26 INFO - Downloading/unpacking psutil>=3.1.1 04:41:26 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:41:26 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:41:26 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:41:26 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:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:27 INFO - Installing collected packages: psutil 04:41:27 INFO - Running setup.py install for psutil 04:41:27 INFO - building 'psutil._psutil_linux' extension 04:41:27 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:41:27 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:41:27 INFO - building 'psutil._psutil_posix' extension 04:41:27 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:41:27 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:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:27 INFO - Successfully installed psutil 04:41:27 INFO - Cleaning up... 04:41:27 INFO - Return code: 0 04:41:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:28 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:28 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:41:28 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:41:28 INFO - Using env: {'DISPLAY': ':0', 04:41:28 INFO - 'HOME': '/home/cltbld', 04:41:28 INFO - 'LANG': 'en_US.UTF-8', 04:41:28 INFO - 'LANGUAGE': 'en_US:en', 04:41:28 INFO - 'LOGNAME': 'cltbld', 04:41:28 INFO - 'MAIL': '/var/mail/cltbld', 04:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:28 INFO - 'MOZ_NO_REMOTE': '1', 04:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:28 INFO - 'NO_EM_RESTART': '1', 04:41:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:28 INFO - 'PWD': '/builds/slave/test', 04:41:28 INFO - 'SHELL': '/bin/bash', 04:41:28 INFO - 'SHLVL': '1', 04:41:28 INFO - 'TERM': 'linux', 04:41:28 INFO - 'TMOUT': '86400', 04:41:28 INFO - 'USER': 'cltbld', 04:41:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:28 INFO - '_': '/tools/buildbot/bin/python'} 04:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:41:28 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:41:28 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:41:28 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:41:28 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:41:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:41:29 INFO - Installing collected packages: mozsystemmonitor 04:41:29 INFO - Running setup.py install for mozsystemmonitor 04:41:29 INFO - Successfully installed mozsystemmonitor 04:41:29 INFO - Cleaning up... 04:41:29 INFO - Return code: 0 04:41:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:41: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:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41: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:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:29 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:29 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:41:29 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:41:29 INFO - Using env: {'DISPLAY': ':0', 04:41:29 INFO - 'HOME': '/home/cltbld', 04:41:29 INFO - 'LANG': 'en_US.UTF-8', 04:41:29 INFO - 'LANGUAGE': 'en_US:en', 04:41:29 INFO - 'LOGNAME': 'cltbld', 04:41:29 INFO - 'MAIL': '/var/mail/cltbld', 04:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:29 INFO - 'MOZ_NO_REMOTE': '1', 04:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:29 INFO - 'NO_EM_RESTART': '1', 04:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:29 INFO - 'PWD': '/builds/slave/test', 04:41:29 INFO - 'SHELL': '/bin/bash', 04:41:29 INFO - 'SHLVL': '1', 04:41:29 INFO - 'TERM': 'linux', 04:41:29 INFO - 'TMOUT': '86400', 04:41:29 INFO - 'USER': 'cltbld', 04:41:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:29 INFO - '_': '/tools/buildbot/bin/python'} 04:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:29 INFO - Downloading/unpacking jsonschema==2.5.1 04:41:29 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:41:29 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:41:29 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:41:29 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:41:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:41:30 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:41:30 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:41:30 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:41:30 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:41:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:30 INFO - warning: no files found matching '*.txt' 04:41:30 INFO - no previously-included directories found matching 'build' 04:41:30 INFO - no previously-included directories found matching 'dist' 04:41:30 INFO - no previously-included directories found matching '.git*' 04:41:30 INFO - Installing collected packages: jsonschema, functools32 04:41:31 INFO - Running setup.py install for functools32 04:41:31 INFO - warning: no files found matching '*.txt' 04:41:31 INFO - no previously-included directories found matching 'build' 04:41:31 INFO - no previously-included directories found matching 'dist' 04:41:31 INFO - no previously-included directories found matching '.git*' 04:41:31 INFO - Successfully installed jsonschema functools32 04:41:31 INFO - Cleaning up... 04:41:31 INFO - Return code: 0 04:41:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:41:31 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:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:31 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:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:31 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:31 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:41:31 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:41:31 INFO - Using env: {'DISPLAY': ':0', 04:41:31 INFO - 'HOME': '/home/cltbld', 04:41:31 INFO - 'LANG': 'en_US.UTF-8', 04:41:31 INFO - 'LANGUAGE': 'en_US:en', 04:41:31 INFO - 'LOGNAME': 'cltbld', 04:41:31 INFO - 'MAIL': '/var/mail/cltbld', 04:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:31 INFO - 'MOZ_NO_REMOTE': '1', 04:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:31 INFO - 'NO_EM_RESTART': '1', 04:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:31 INFO - 'PWD': '/builds/slave/test', 04:41:31 INFO - 'SHELL': '/bin/bash', 04:41:31 INFO - 'SHLVL': '1', 04:41:31 INFO - 'TERM': 'linux', 04:41:31 INFO - 'TMOUT': '86400', 04:41:31 INFO - 'USER': 'cltbld', 04:41:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:31 INFO - '_': '/tools/buildbot/bin/python'} 04:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:41:31 INFO - Cleaning up... 04:41:31 INFO - Return code: 0 04:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:31 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:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:31 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:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:31 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:31 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:41:31 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:41:31 INFO - Using env: {'DISPLAY': ':0', 04:41:31 INFO - 'HOME': '/home/cltbld', 04:41:31 INFO - 'LANG': 'en_US.UTF-8', 04:41:31 INFO - 'LANGUAGE': 'en_US:en', 04:41:31 INFO - 'LOGNAME': 'cltbld', 04:41:31 INFO - 'MAIL': '/var/mail/cltbld', 04:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:31 INFO - 'MOZ_NO_REMOTE': '1', 04:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:31 INFO - 'NO_EM_RESTART': '1', 04:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:31 INFO - 'PWD': '/builds/slave/test', 04:41:31 INFO - 'SHELL': '/bin/bash', 04:41:31 INFO - 'SHLVL': '1', 04:41:31 INFO - 'TERM': 'linux', 04:41:31 INFO - 'TMOUT': '86400', 04:41:31 INFO - 'USER': 'cltbld', 04:41:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:31 INFO - '_': '/tools/buildbot/bin/python'} 04:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:41:31 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:41:31 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:41:31 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:41:31 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:41:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41:32 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:41:32 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:41:32 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:41:32 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:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:33 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:41:33 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:41:33 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:41:33 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:41:33 INFO - Downloading docopt-0.6.1.tar.gz 04:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:33 INFO - Running setup.py install for blobuploader 04:41:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:33 INFO - Running setup.py install for requests 04:41:33 INFO - Running setup.py install for docopt 04:41:33 INFO - Successfully installed blobuploader requests docopt 04:41:33 INFO - Cleaning up... 04:41:33 INFO - Return code: 0 04:41:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:33 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:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:33 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:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:33 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:33 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:41:33 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:41:33 INFO - Using env: {'DISPLAY': ':0', 04:41:33 INFO - 'HOME': '/home/cltbld', 04:41:33 INFO - 'LANG': 'en_US.UTF-8', 04:41:33 INFO - 'LANGUAGE': 'en_US:en', 04:41:33 INFO - 'LOGNAME': 'cltbld', 04:41:33 INFO - 'MAIL': '/var/mail/cltbld', 04:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:33 INFO - 'MOZ_NO_REMOTE': '1', 04:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:33 INFO - 'NO_EM_RESTART': '1', 04:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:33 INFO - 'PWD': '/builds/slave/test', 04:41:33 INFO - 'SHELL': '/bin/bash', 04:41:33 INFO - 'SHLVL': '1', 04:41:33 INFO - 'TERM': 'linux', 04:41:33 INFO - 'TMOUT': '86400', 04:41:33 INFO - 'USER': 'cltbld', 04:41:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:33 INFO - '_': '/tools/buildbot/bin/python'} 04:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:34 INFO - Running setup.py (path:/tmp/pip-9D1mbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:34 INFO - Running setup.py (path:/tmp/pip-xOfzlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:34 INFO - Running setup.py (path:/tmp/pip-xMSoEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:34 INFO - Running setup.py (path:/tmp/pip-0CpNHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:34 INFO - Running setup.py (path:/tmp/pip-hc6l8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:34 INFO - Running setup.py (path:/tmp/pip-3s4l0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:34 INFO - Running setup.py (path:/tmp/pip-wNZulF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:34 INFO - Running setup.py (path:/tmp/pip-WBOu20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:34 INFO - Running setup.py (path:/tmp/pip-xW_eA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:34 INFO - Running setup.py (path:/tmp/pip-Dn7BmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:34 INFO - Running setup.py (path:/tmp/pip-cvLLXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:34 INFO - Running setup.py (path:/tmp/pip-6Ary0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:34 INFO - Running setup.py (path:/tmp/pip-4kLmWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:35 INFO - Running setup.py (path:/tmp/pip-0bngAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:35 INFO - Running setup.py (path:/tmp/pip-nqTlJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:35 INFO - Running setup.py (path:/tmp/pip-9d5K4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:35 INFO - Running setup.py (path:/tmp/pip-IraqYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:35 INFO - Running setup.py install for manifestparser 04:41:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:35 INFO - Running setup.py install for mozcrash 04:41:35 INFO - Running setup.py install for mozdebug 04:41:35 INFO - Running setup.py install for mozdevice 04:41:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:35 INFO - Running setup.py install for mozfile 04:41:35 INFO - Running setup.py install for mozhttpd 04:41:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:35 INFO - Running setup.py install for mozinfo 04:41:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:35 INFO - Running setup.py install for mozInstall 04:41:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Running setup.py install for mozleak 04:41:36 INFO - Running setup.py install for mozlog 04:41:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Running setup.py install for moznetwork 04:41:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Running setup.py install for mozprocess 04:41:36 INFO - Running setup.py install for mozprofile 04:41:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Running setup.py install for mozrunner 04:41:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:36 INFO - Running setup.py install for mozscreenshot 04:41:36 INFO - Running setup.py install for moztest 04:41:36 INFO - Running setup.py install for mozversion 04:41:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:37 INFO - Cleaning up... 04:41:37 INFO - Return code: 0 04:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:37 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:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:37 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:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:37 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:37 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:41:37 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:41:37 INFO - Using env: {'DISPLAY': ':0', 04:41:37 INFO - 'HOME': '/home/cltbld', 04:41:37 INFO - 'LANG': 'en_US.UTF-8', 04:41:37 INFO - 'LANGUAGE': 'en_US:en', 04:41:37 INFO - 'LOGNAME': 'cltbld', 04:41:37 INFO - 'MAIL': '/var/mail/cltbld', 04:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:37 INFO - 'MOZ_NO_REMOTE': '1', 04:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:37 INFO - 'NO_EM_RESTART': '1', 04:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:37 INFO - 'PWD': '/builds/slave/test', 04:41:37 INFO - 'SHELL': '/bin/bash', 04:41:37 INFO - 'SHLVL': '1', 04:41:37 INFO - 'TERM': 'linux', 04:41:37 INFO - 'TMOUT': '86400', 04:41:37 INFO - 'USER': 'cltbld', 04:41:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:37 INFO - '_': '/tools/buildbot/bin/python'} 04:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:37 INFO - Running setup.py (path:/tmp/pip-FZrIQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:37 INFO - Running setup.py (path:/tmp/pip-I5ZyyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:37 INFO - Running setup.py (path:/tmp/pip-bLrNZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:37 INFO - Running setup.py (path:/tmp/pip-YZ2SEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:37 INFO - Running setup.py (path:/tmp/pip-iB2_GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:37 INFO - Running setup.py (path:/tmp/pip-MinChq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:37 INFO - Running setup.py (path:/tmp/pip-N_NhCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:37 INFO - Running setup.py (path:/tmp/pip-3D2Kwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:37 INFO - Running setup.py (path:/tmp/pip-BkuLxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:37 INFO - Running setup.py (path:/tmp/pip-dUbcxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:37 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:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:37 INFO - Running setup.py (path:/tmp/pip-SdIAAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:38 INFO - Running setup.py (path:/tmp/pip-Mhdvjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:38 INFO - Running setup.py (path:/tmp/pip-yjJrQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:38 INFO - Running setup.py (path:/tmp/pip-p7eM_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:38 INFO - Running setup.py (path:/tmp/pip-Q9tKM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:38 INFO - Running setup.py (path:/tmp/pip-jAjcRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:38 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:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:38 INFO - Running setup.py (path:/tmp/pip-4VhVYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:38 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:41:38 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:41:38 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:41:38 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:41:38 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:41:38 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:41:38 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:41:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:38 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:41:38 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:41:38 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:41:38 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:41:39 INFO - Downloading blessings-1.6.tar.gz 04:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:39 INFO - Installing collected packages: blessings 04:41:39 INFO - Running setup.py install for blessings 04:41:39 INFO - Successfully installed blessings 04:41:39 INFO - Cleaning up... 04:41:39 INFO - Return code: 0 04:41:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:40 INFO - Reading from file tmpfile_stdout 04:41:40 INFO - Current package versions: 04:41:40 INFO - argparse == 1.2.1 04:41:40 INFO - blessings == 1.6 04:41:40 INFO - blobuploader == 1.2.4 04:41:40 INFO - docopt == 0.6.1 04:41:40 INFO - functools32 == 3.2.3-2 04:41:40 INFO - jsonschema == 2.5.1 04:41:40 INFO - manifestparser == 1.1 04:41:40 INFO - mozInstall == 1.13 04:41:40 INFO - mozcrash == 1.0 04:41:40 INFO - mozdebug == 0.1 04:41:40 INFO - mozdevice == 0.51 04:41:40 INFO - mozfile == 1.2 04:41:40 INFO - mozhttpd == 0.7 04:41:40 INFO - mozinfo == 0.10 04:41:40 INFO - mozleak == 0.1 04:41:40 INFO - mozlog == 3.5 04:41:40 INFO - moznetwork == 0.27 04:41:40 INFO - mozprocess == 0.25 04:41:40 INFO - mozprofile == 0.28 04:41:40 INFO - mozrunner == 6.13 04:41:40 INFO - mozscreenshot == 0.1 04:41:40 INFO - mozsystemmonitor == 0.3 04:41:40 INFO - moztest == 0.8 04:41:40 INFO - mozversion == 1.4 04:41:40 INFO - psutil == 3.1.1 04:41:40 INFO - requests == 1.2.3 04:41:40 INFO - wsgiref == 0.1.2 04:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:40 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 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:40 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:41:40 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:41:40 INFO - Using env: {'DISPLAY': ':0', 04:41:40 INFO - 'HOME': '/home/cltbld', 04:41:40 INFO - 'LANG': 'en_US.UTF-8', 04:41:40 INFO - 'LANGUAGE': 'en_US:en', 04:41:40 INFO - 'LOGNAME': 'cltbld', 04:41:40 INFO - 'MAIL': '/var/mail/cltbld', 04:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:40 INFO - 'MOZ_NO_REMOTE': '1', 04:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:40 INFO - 'NO_EM_RESTART': '1', 04:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:40 INFO - 'PWD': '/builds/slave/test', 04:41:40 INFO - 'SHELL': '/bin/bash', 04:41:40 INFO - 'SHLVL': '1', 04:41:40 INFO - 'TERM': 'linux', 04:41:40 INFO - 'TMOUT': '86400', 04:41:40 INFO - 'USER': 'cltbld', 04:41:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:40 INFO - '_': '/tools/buildbot/bin/python'} 04:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:40 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:41:40 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:41:40 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:41:40 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:41:40 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:41:40 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:41:40 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:41:40 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:41:40 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:41:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:41:40 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:41:40 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:41:40 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:41:40 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:41:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:41:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:41:41 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:41:41 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:41:41 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:41:41 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:41:41 INFO - Installing collected packages: marionette-driver, simplejson 04:41:41 INFO - Running setup.py install for marionette-driver 04:41:41 INFO - Running setup.py install for simplejson 04:41:41 INFO - building 'simplejson._speedups' extension 04:41:41 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:41:42 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:41:42 INFO - Successfully installed marionette-driver simplejson 04:41:42 INFO - Cleaning up... 04:41:42 INFO - Return code: 0 04:41:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', '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:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:41:42 INFO - Using env: {'DISPLAY': ':0', 04:41:42 INFO - 'HOME': '/home/cltbld', 04:41:42 INFO - 'LANG': 'en_US.UTF-8', 04:41:42 INFO - 'LANGUAGE': 'en_US:en', 04:41:42 INFO - 'LOGNAME': 'cltbld', 04:41:42 INFO - 'MAIL': '/var/mail/cltbld', 04:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:42 INFO - 'MOZ_NO_REMOTE': '1', 04:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:42 INFO - 'NO_EM_RESTART': '1', 04:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:42 INFO - 'PWD': '/builds/slave/test', 04:41:42 INFO - 'SHELL': '/bin/bash', 04:41:42 INFO - 'SHLVL': '1', 04:41:42 INFO - 'TERM': 'linux', 04:41:42 INFO - 'TMOUT': '86400', 04:41:42 INFO - 'USER': 'cltbld', 04:41:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:42 INFO - '_': '/tools/buildbot/bin/python'} 04:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:41:43 INFO - Cleaning up... 04:41:43 INFO - Return code: 0 04:41:43 INFO - Running post-action listener: _resource_record_post_action 04:41:43 INFO - Running post-action listener: _start_resource_monitoring 04:41:43 INFO - Starting resource monitoring. 04:41:43 INFO - [mozharness: 2017-07-11 11:41:43.102611Z] Finished create-virtualenv step (success) 04:41:43 INFO - [mozharness: 2017-07-11 11:41:43.103137Z] Running install step. 04:41:43 INFO - Running pre-action listener: _resource_record_pre_action 04:41:43 INFO - Running main action method: install 04:41:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:43 INFO - Reading from file tmpfile_stdout 04:41:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:43 INFO - Reading from file tmpfile_stdout 04:41:43 INFO - Output received: 04:41:43 INFO - Usage: mozinstall [options] installer 04:41:43 INFO - Options: 04:41:43 INFO - -h, --help show this help message and exit 04:41:43 INFO - -d DEST, --destination=DEST 04:41:43 INFO - Directory to install application into. [default: 04:41:43 INFO - "/builds/slave/test"] 04:41:43 INFO - --app=APP Application being installed. [default: firefox] 04:41:43 INFO - mkdir: /builds/slave/test/build/application 04:41:43 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:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:42:01 INFO - Reading from file tmpfile_stdout 04:42:01 INFO - Output received: 04:42:01 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:01 INFO - Running post-action listener: _resource_record_post_action 04:42:01 INFO - [mozharness: 2017-07-11 11:42:01.493286Z] Finished install step (success) 04:42:01 INFO - [mozharness: 2017-07-11 11:42:01.493587Z] Running setup-mitmproxy step. 04:42:01 INFO - Running pre-action listener: _resource_record_pre_action 04:42:01 INFO - Running main action method: setup_mitmproxy 04:42:01 INFO - Skipping: mitmproxy is not required 04:42:01 INFO - Running post-action listener: _resource_record_post_action 04:42:01 INFO - [mozharness: 2017-07-11 11:42:01.494736Z] Finished setup-mitmproxy step (success) 04:42:01 INFO - [mozharness: 2017-07-11 11:42:01.494975Z] Running run-tests step. 04:42:01 INFO - Running pre-action listener: _resource_record_pre_action 04:42:01 INFO - Running pre-action listener: _set_gcov_prefix 04:42:01 INFO - Running main action method: run_tests 04:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:01 INFO - Python 2.7.3 04:42:01 INFO - Return code: 0 04:42:01 INFO - grabbing minidump binary from tooltool 04:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:01 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 0xd3d2a0>, '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 0xd3e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd384d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:01 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:42:01 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:42:01 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:42:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:01 INFO - Return code: 0 04:42:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:01 INFO - ENV: RUST_BACKTRACE is now 1 04:42:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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:42:01 INFO - Using env: {'DISPLAY': ':0', 04:42:01 INFO - 'HOME': '/home/cltbld', 04:42:01 INFO - 'LANG': 'en_US.UTF-8', 04:42:01 INFO - 'LANGUAGE': 'en_US:en', 04:42:01 INFO - 'LOGNAME': 'cltbld', 04:42:01 INFO - 'MAIL': '/var/mail/cltbld', 04:42:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:01 INFO - 'MOZ_NO_REMOTE': '1', 04:42:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:01 INFO - 'NO_EM_RESTART': '1', 04:42:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:01 INFO - 'PWD': '/builds/slave/test', 04:42:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:01 INFO - 'RUST_BACKTRACE': '1', 04:42:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:42:01 INFO - 'SHELL': '/bin/bash', 04:42:01 INFO - 'SHLVL': '1', 04:42:01 INFO - 'TERM': 'linux', 04:42:01 INFO - 'TMOUT': '86400', 04:42:01 INFO - 'USER': 'cltbld', 04:42:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471', 04:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:01 INFO - '_': '/tools/buildbot/bin/python'} 04:42:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:42:01 INFO - mozversion application_buildid: 20170711105211 04:42:01 INFO - mozversion application_changeset: b07db5d650b7056c78ba0dbc409d060ec4e922cd 04:42:01 INFO - mozversion application_display_name: Nightly 04:42:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:01 INFO - mozversion application_name: Firefox 04:42:01 INFO - mozversion application_remotingname: firefox 04:42:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:42:01 INFO - mozversion application_vendor: Mozilla 04:42:01 INFO - mozversion application_version: 56.0a1 04:42:01 INFO - mozversion platform_buildid: 20170711105211 04:42:01 INFO - mozversion platform_changeset: b07db5d650b7056c78ba0dbc409d060ec4e922cd 04:42:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:42:01 INFO - mozversion platform_version: 56.0a1 04:42:01 INFO - using testdate: 1499773321 04:42:01 INFO - actual date: 1499773321 04:42:01 INFO - starting webserver on 'localhost:40396' 04:42:01 INFO - SUITE-START | Running 2 tests 04:42:01 INFO - TEST-START | dromaeo_css 04:42:01 INFO - Initialising browser for dromaeo_css test... 04:42:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40396/getInfo.html -profile /tmp/tmpFjuNPb/profile 04:42:01 INFO - TEST-INFO | started process 5517 (/builds/slave/test/build/application/firefox/firefox http://localhost:40396/getInfo.html) 04:42:08 INFO - TEST-INFO | 5517: exit 0 04:42:08 INFO - Browser initialized. 04:42:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:08 INFO - TEST-INFO | started process 5737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFjuNPb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:19 INFO - PID 5737 | RSS: Main: 174370816 04:42:19 INFO - PID 5737 | 04:45:19 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40396/tests/dromaeo/cssquery-ext.html) 04:45:21 INFO - PID 5737 | RSS: Main: 180129792 04:45:21 INFO - PID 5737 | 04:48:23 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-ext.html (next: http://localhost:40396/tests/dromaeo/cssquery-jquery.html) 04:48:24 INFO - PID 5737 | RSS: Main: 178622464 04:48:24 INFO - PID 5737 | 04:51:25 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40396/tests/dromaeo/cssquery-mootools.html) 04:51:26 INFO - PID 5737 | RSS: Main: 179503104 04:51:26 INFO - PID 5737 | 04:54:28 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40396/tests/dromaeo/cssquery-prototype.html) 04:54:28 INFO - PID 5737 | RSS: Main: 177631232 04:54:28 INFO - PID 5737 | 04:57:32 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40396/tests/dromaeo/cssquery-yui.html) 04:57:32 INFO - PID 5737 | RSS: Main: 178462720 04:57:32 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | Cycle 1(1): loaded http://localhost:40396/tests/dromaeo/cssquery-yui.html (next: http://localhost:40396/tests/dromaeo/cssquery-dojo.html) 05:00:34 INFO - PID 5737 | RSS: Main: 183009280 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | __start_tp_report 05:00:34 INFO - PID 5737 | _x_x_mozilla_page_load 05:00:34 INFO - PID 5737 | _x_x_mozilla_page_load_details 05:00:34 INFO - PID 5737 | |i|pagename|runs| 05:00:34 INFO - PID 5737 | |0;dojo.html;3119.5476655884895;3121.859516321765;3150.5431712401687;3163.114327988164;3189.840507974601;5951.315598706145;6018.6689732064715;6035.969820150898;6041.516678665713;6087.939120608793;6039.335673075969;6050.455459008688;6065.8180254592435;6108.419700128492;6108.725107370168;5543.501084902358;5556.083246264372;5580.972095139539;5591.440855914397;5604.103343465046;5575.2473416088715;5575.414581468948;5581.302337207849;5591.580631452637;5592.189132575774;5589.580781441387;5600.52395546379;5602.411746766592;5602.859928501779;5611.410801865806;5600.915986260209;5602.691851948141;5603.803866864681;5609.747561359749;5610.915836262459;5399.082156033483;5466.453354664542;5521.503064724154;5583.022970980103;5587.8603034924045;6029.60807547508;6033.637981721067;6120.724567394478;6123.969380153116;6133.264008318985;6271.529635277372;6336.936630633681;6466.95339857235;6591.307912669148;6602.1747281589805;6507.93492065078;6551.344865513458;6556.836079098013;6565.310642382577;6568.540202185849;6026.96986515069;6031.819045428644;6056.06131049688;6063.0299152135885;6068.6358818471035;5220.477952204825;6665.633390163491;6694.062831203635;6712.160979877515;6797.830054248584;6198.907016394758;6383.170187875547;6445.516586255956;6462.998235273541;6470.935290647128;6446.161998940202;6451.1936007999;6521.380468855451;6537.5096867734155;6548.443382312556;6396.744130234832;6400.871982560323;6438.581492202992;6472.3204063573585;6488.7728929488185;5020.49795020495;6368.91728406172;6528;6531.150950376421;6612.801615951529;5140.1004824155625;5228.189630607262;5284.583302115286;5367.651102678314;5369.812056578001;4505.7296562206375;4523.705959112647;4535.591796738309;4536.56902594253;4537.977310113494;5628.127640215773;5640.689762063043;5640.8871822563315;5643.984082865041;5648.85877853057;6490.740370385226;6491.967540162364;6495.220573531112;6513.641749703812;6520.804375868732;5537.501624853782;5592.5246354059545;5631.549476041907;5636.85907852307;5682.40334764852;5643.943560564342;5663.32040155184;5685.260916080883;5710.628809127394;5721.256236689287;6219.191505104308;6246.15676883624;6246.219222597176;6258.030005349269;6259.467945224706;6428.8071357859335;6463.062855885776;6482.546221764431;6484.70818813164;6491.642959637265;6211.751529938932;6285.905711414241;6297.527685423704;6299.811005669837;6304.65324407162;6236.719347629459;6295.433410993032;6308.589941653778;6400.135981642418;6405.231372235362;6441.742330306735;6456.483481321577;6514.218293804774;6531.150950376421;6545.247296560957;6102.298235702773;6249.093881387264;6249.218847644044;6321.652309123042;6352.618842869442;6196;6216.160818289654;6235.906461402992;6237.875242495215;6242.375762423721;6108.75564977396;6138.600990935575;6148.385161483816;6162.075688646739;6194.0708893666315;5029.64792464524;6412.198475190601;6465.450436712932;6479.416852483299;6489.837754055998;6167.352427994996;6186.969065154645;6253.874922501615;6269;6289.685515724104 05:00:34 INFO - PID 5737 | |1;ext.html;799.1968072087551;814.9551774652392;854.5897968974892;886.2245535156737;891.9108089191081;40680.79659601702;41840.58159418405;41889.58110418903;41967.901604919745;42298.154036919244;39976;40490.19019619606;43377.566224337745;43426.56573434265;43590.56409435905;7615.16233214346;7750;7753.534787912743;7757.612119394036;7770.0287464067;7583.734569290076;7622.390208783312;7655.387568994467;7710.228977102301;7723.111842138142;7705.383569314469;7718;7745.380369570421;7746.573938433384;7765;7676.884846727247;7682.1549629540705;7698.730544430946;7728.845423091563;7743.26438988298;7536.434767392413;7585.62071896403;7599.164091949881;7614.124375696755;7634.770956871303;37197.07007324811;37512;37659.43510847339;37703.622963770285;37724.24551508982;3527.94708079379;3532.1522834519787;3568.50040994261;3571.8928432147077;3577.373959557067;30782.846085769652;30931.536026959613;30971.535426968614;31080.222994425094;31175.53236701451;4533.093381323715;4651.116287905287;4721.929171062437;4842.491538388454;4872.1473742094995;174380;174593.1270343653;174672.12663936726;175286;176188;45717.771411143396;46081;46084.5391546087;46213.76893115513;46379;48036.5196348039;48257;48314.5168548317;48348.51651483511;48400.757996209795;16475.58811029734;16623.750643740354;16688.6662266754;16711.749323760152;16782;13815.378307976165;13865.792013119812;13866.376013079436;13878.514252001132;13895.096818706752;12981.935090324678;13401.128926619738;13500.257485838372;13556.728865422636;13605.115667481581;4947.356843610308;4963.925541116886;4996.7501624918605;5072.467390923974;5119.48805119485;971.795922856194;982.6904525074578;993.2699465892563;1004.1514919892679;1013.8023085498257;22650.773492265194;22717.432064198198;22895.427614309443;23148.768512314997;29762.553561696594;1077.504347999913;1104.5250542266901;1106.4578356605205;1109.4896347680158;1120.4789772755707;12617;12666.936665316798;12899;12915.031372647089;12929.806052909214;217131;222557;224778;225600;229724;57701.422985769605;57757;58219.70890145607;58326.41673583295;58390.12414813781;1436.3392839294042;1452.8765054970233;1457.5918742752258;1463.4512057978259;1471.5364660132238;26278.080267190555;27206.606636486064;27543.724562754116;27635.861820690767;27780.8610956952;34071.82964085164;34164;35492.82253588819;38354.42468363033;38384.808075959445;194609;195233;195883;195936;197423;35134.297314054085;35325.64674353327;35359.292814144086;35449;35686.28627427489;42844.35733464063;44027.57848318373;44312.11375772531;44447.33329000132;44730;29391.706082939752;31759.52360714545;31762.52356214705;32249.51625725569;32461.675383245863;25684.229473115836;26375.60436593414;34199.14502137367;34335.484967725;35289;37798;38029.80985095168;38035.04912377213;38103;38325.808370957966;33580.496292555144;34296.31407371889;34383.65616343805;34713.30573388569;34716.826415867756;23627.40931476727;24895.75104249007;24928.50142997166;25121.371965701004;25439.87280063588 05:00:34 INFO - PID 5737 | |2;jquery.html;567.2172402085122;567.8410045187347;571.7084287013622;574.4427904932217;603.767549493445;16248.18759062048;21787;22576.774232257692;22742.88628556859;22743.97652105655;19288.421347359566;19627.11677974491;19664.60670786587;22545;24727.75272247277;6351.682415879211;6659.167604049494;6666.500012499057;6671.399574038335;6680.031395447657;6502.642354670491;6591.209054913417;6609.239937407187;6610.900836487456;6624.105745724314;3771.7925514096714;4379.474463064421;6566.113574667431;6584.242812076601;6649.135612370385;6549.148610680605;6618.07346971422;6652.268250492442;6659.9001014984815;6663.36698013688;6171;6176.69116544171;6189.752409903598;6200.131981522591;6206.472449841769;26923;27868.30329241785;27981.72018279832;28007.159785206273;28036.439271214665;1932.120884997323;1964.489232799468;1967.2131147540954;1973.3783858084657;1981.5343394302326;18199;18840;18856.34002809895;18890.433287001273;18895.055247237582;2329.23135365329;2349.6475528670667;2389.0563227525204;2391.5456063348083;2404.350825277183;134750;140299;141648;141758;142144;13841.377138028813;14436.927815360856;14538.563843084725;14928.62678433048;14997.250137493082;23266;23388.883055584953;23481.647775283385;23520.64719029216;23521.529569408514;9888.802223955481;9980.850287245697;10212.336198147097;10240.897591024144;10333.379997200193;9255.722328330161;9342.532873356306;9354.532273386303;9419.576119074658;9434.245260379153;8977.865332020025;9054.547272636473;9278.860817087749;9304.209142222851;9358.672446464341;2317.351141680332;2751;2762.4337010912714;2837.5743638453982;2841.971580284212;968.8256113899565;971.0915807157609;984.7692923924652;998.4209158688088;1001.3591301567003;18826.246950122117;19012.23951041943;19313.613727725366;22027.559448810935;23505.412364690677;1030.2221822523945;1031.633770011635;1034.3225187502048;1035.0787798859021;1048.6434612231878;10821.9458902705;10825.133989280996;10846.240763146505;10956.945215273872;11013.449327533592;426284;444889;457325;461318;462280;111906.44046779715;112352.43823780828;113175;114178.42910785392;116437;1236.449779847959;1285.042643230799;1301.102239454773;1310.5282098444552;1315.3817705678507;16725.146198830313;17458.55801877382;17760;17940.820591794436;18053.458396248134;55693.44306556883;56659;57710.845783084944;58991.41008589859;60541;72415.63792181005;72741;72946;74397;74397.62801185959;14051.36768845384;14419.567412977627;14572.708545829237;14606.561803145923;14607;20908.895455522626;22564.435889102904;22615.88692056529;22666.433339165993;22877.19929802449;17806.732899006784;17959.73060404121;17960;18093.638127237118;18107;14733.926330368708;15058.6988260232;15255.313510892258;15411.998220115656;15820.129892856003;16997.830021699625;18100.909495452437;18206.180721867284;18544.331010209145;18833.340833070775;14313.141211526925;14368.13791172533;14418.279086045866;14428;14453.349599267847;18194.818051819842;18201.81798182001;18225.90887045556;18226.17982190831;19145.617087658447 05:00:34 INFO - PID 5737 | |3;mootools.html;1359.286374653307;1415.0377743134663;1423.651205454663;1426.678997225625;1437.3531910640208;12586.049162379823;12918.224906505617;13236.272005039731;13278.66803329916;13281.136726112796;12916.677083072927;13552.525661601845;13573.321333933312;13671;13672.589822305346;2637.0902038796585;2677.799165062618;2688.892444302235;2692.9461410771773;2697.4335389568214;2470.4318006858434;2559.25781523358;2562.9359266018405;2562.9615555766677;2565.050931155475;2498.150628786212;2513.773760361567;2528.835625684334;2549.8852551635127;2555;2581.90963316284;2671.3588738702765;2673.5722284434496;2682.4232789950156;2682.543967525525;2514.4719608882156;2532.518821423942;2535.239428171541;2535.9239222823344;2541.6568763216915;13082.411291491906;13120.278384688838;13183.538576149884;13190.07669463138;13207.009474289467;7074.610896400696;7326.413886889036;7379.8155046124275;7417.777466676009;7421.998030265899;4739.786709598076;4793.544613261734;5025.949740502621;5032.119379108642;5045.117104506733;1640.261882153024;1657.9253933573018;1736.3749050341867;1738.8695847811339;1739.9652006959916;20165.79834201654;20365.49086272855;20386.898065509577;20488.590228195502;20559.38321850347;5970.910436343458;6219;6246.843828904223;6395.584287021329;6425.453836423862;15343.156126413154;15344.769828452581;15357.692846143014;15372.461963831436;15441.613959650875;6971.965140174267;7296.379807716404;7320.67056982437;7337.779866604011;7358.816029599303;6640;6763.966180169166;6809.080774095532;6819.965900170567;6871.862562748717;4692.6245900327895;4806.663533552618;4809.302651115639;4880.1215781159735;4901.044296362246;1428.8285405751376;1432.1621851217155;1434.1323499282785;1445.104035497998;1465.1282486920265;900.4597241654955;911.4075850696968;927.420362273579;929.2008872369756;942.0767647705287;7036.718531258794;7103.715851365991;7131.072960515204;7154.39187669054;7198.316159964795;682.3108660253081;708.6173466328228;976.2190247801731;1018.399144504731;1020.1634659579222;4735.147673418749;5016.072026675077;5035.949640503548;5080.034793389318;5167.121589329823;16841.157942102847;17930.641387172185;17954.5511362217;18136.18387172554;18192.727109093375;16711.498655040366;17006.744898826528;17371;17443.825561744474;17854;9984.750381240672;10188.083072523508;10338.896611033944;10491.632792852213;10518.684439466828;7867.370610351272;8147.714829980922;8218.424710270463;8226.794330141554;8304.169583041648;14425.278736062945;15269.541913742605;15459.536213913601;15636.843631563539;15829;14831.851681483047;15315.770263445835;15675.686486270439;15716.528504144893;15953.521394358188;10918.617848375268;11474.598389056342;11492.195546311677;11619.825702614298;11665.533378664759;12857.742845143232;12956.222626642431;13031.218126912416;13072.477100915858;13076.476940922257;10178.62794745996;10205.489725513844;10336.844947325646;10408.843867341844;10423.791524169626;9587.424754514752;9839.655612053544;10125.949370253102;10159.695209143738;10162;9476.005019473132;9494.762630934281;9498.382605130644;9540.904590954002;9621.230301575997;6707.826130427058;6848.383645471931;6974.302569743188;6985.231624521401;7138.964305178441;7021.43828493709;7115.466340024623;7189.137303523611;7227.7831665050135;7230.45771567124 05:00:34 INFO - PID 5737 | |4;prototype.html;491.79836267130463;493.8049470459168;513.6994858008065;520.4483247757378;530.7956436771842;6016.51867850572;6055.971249631373;6061.939380606193;6094.451499365056;6107.083937409391;5749.856253593663;5853.209816674747;5887.352391236971;5922.170896074542;5997.6701281429505;4854.417469903617;4856.660033797635;4871.878203044926;4918.483559226283;4940.505949405048;4842.806287748486;4844.397822069031;4879.194932836078;4908.282101264546;4911.852644420655;4819.277108433728;4853.8543843684565;4860.003699241647;4873.707577545341;4880.8047678092835;4574.199515084863;4825.734584597846;4849.345338379327;4871.780769865364;4875.268709693539;4324.610785029331;4332.458442694663;4336.544662810391;4362.302031674949;4405.713628614162;5786.594938354275;5797.478226959552;5806.390329015477;5834.883302333929;5850.210221620069;5532.474414930575;5543.722813859331;5566.332040155207;5582.91625625616;5602.691851948141;6291.622502649856;6303.842403939892;6311.779087731953;6342.714577843962;6438;4758.690685105457;4825.396825396825;4835.395575553056;4858.392700912386;4871.512848715136;6769.120014398146;6771.476417805954;6792.830179245509;6826.180858296986;6855;4993.67793975803;4997.375328083989;4997.75056235941;5006.74966251686;5015.3730783652045;4920.458749537548;4964.007198560303;5018.498150185025;5024.598032157419;5035.84892453227;5550.611457197957;5559;5569.610127291051;5571.1086226203615;5586.636868603528;6365.427111559982;6416.807495775134;6461.386168314003;6482.870342593122;6484.077133334359;1724.0862342958253;1744.6946784312947;1748.4667176511286;1758.0945812906364;1763.8236176382259;1121.4448847820381;1195.8086706126978;1214.6477521518661;1215.2404747033104;1215.6778453709774;5461.869870750411;5520.613557050968;5527.917081243784;5546.611737178358;5697;6463;6496.740130394825;6523.575967562093;6585.242697089896;6597.505187110986;5636.605437619327;5647.858803529863;5668.829935101953;5686.630369026083;5689.857753556194;3430.382531144418;3457.913552161216;3465.151037995707;3496.2133519958315;3509.859605615798;6386.329435409308;6410.1154480483965;6465.64438955862;6492.253390860017;6500.837479063061;6746.190457145076;6764.936694308283;6766.830829229309;6776.898346524806;6789.93210067893;6354.936450635527;6360.459360954278;6374.521910856612;6448.290688024314;6475.449586785082;6495.350464953467;6549.279579246184;6562.737490500326;6573.769918052845;6598.637074960923;6351.396617321347;6439.935600643934;6493.6687978963255;6494.447971922439;6531.379518945692;6201.689915504297;6234.906476402948;6340.682965851781;6361.93638063632;6369.522285828489;5264.815731449381;5326.414094449685;5355;5365.3293338332705;5391.2182733504205;6537.477001839747;6537.542372033912;6571.638559879252;6585.440237579859;6608.4052435281055;6340.270868850142;6380.808575742735;6401.93598064032;6414.839629009312;6418.1656384669695;6377.553571250153;6398.872022559616;6403.079076277191;6446.484281257394;6457.967710161419;6272.839524687947;6297.2128483939505;6305.779297724557;6323.73525294952;6365.331640177715;6347.428731414195;6354.142190804368;6366.236051673829;6398.200224971879;6409.9679501602195;5627.718614069362;6064.666443345482;6085.208922840003;6143.539234557516;6151.231096112986 05:00:34 INFO - PID 5737 | |5;yui.html;918.5636822509309;920.714578480671;932.5244125495999;935.8642996765474;946.1201082992816;16872.746908796362;17180.570485737862;18022.99999999998;18552.350667726598;18613.906930465328;15355.769663455028;15788.84211157888;15873.126978016204;15999.200039998012;18358.816411835876;1005.6982905128468;1032.4424810602266;1036.7097212780434;1041.1670663469195;1041.4792603698152;1035.3529044347283;1038.3043360948184;1044.7492601775596;1046.1160319530022;1050.1861057680283;1104.828751543512;1106.0985296982974;1106.1758989552795;1110.0730889707063;1118.0049755717419;1018.231235417259;1070.0583486531802;1077.4720387010386;1083.9187060970419;1101.5703875488566;792.4254915186501;795.308081968691;801.4069588504465;802.3661307567073;802.7190483330846;17989.190486428142;18119.36582219629;18119.818801811944;18162.364317248965;18245.908770456062;18823.34118305853;19030.809691903043;19509.80490195094;19578.412647620593;19606.50983725404;15329.233538323038;15368.462103826425;15469.994450360691;15483;15570.610734731723;3386.86452541898;3399.932001359959;3418.8461519231446;3419.709324707378;3436.3642726095504;101422;102319.48840255826;105551.47224263907;107243.46378268058;108015;16059.357625695075;16063.036217826968;16516.17419129039;16702.415415460644;16708.916455417646;28385;28599.428011439653;28844.711552884204;29024.41951161007;29068.563971540443;8632;8648.091950345122;8650.740477785677;8659.52372619512;8676.1323867614;3626.6917312028245;3682.815859207029;3736.626337366242;3737.4020156775327;3744.26986737589;4946.258061290835;4956.405231372186;4959.7272150032095;5002.699838009731;5026.698398096126;915.3455279475074;938.8497840345512;942.8067246214509;955.8661787349777;956.3257903178243;594.3877805859971;678.9171271821436;702.3503259485058;707.7098389660215;730.5726150202084;11492.94253528727;11638.94180529109;11728.76542469163;11730.061595072544;11797.351145686898;650.456868514786;652.1489456259532;669.3641041011059;677.9254282028973;678.5588324416705;5451.509364157245;5481.725913704378;5486.451354864482;5520.227168196456;5598.21624972496;98456.50771746096;100926.49536752269;102068.48965755272;102535;104292.47853760683;90162.54918725364;91032;91465;92828;94929;73112;75002.62498687471;75871.9999999989;77156;78939;10443.425611591436;10675.51960161779;10851.891481085404;10855.240133190917;10879.782404352027;33622;33749.156271093416;34269.657303427644;34572;35834.4624830633;43302.56697432986;43485.782571086944;44599.10801784011;44750.77624611856;45912.31131533097;14753.336099875745;15083.095014299177;15356.155411452477;15383.1539265337;15387.076775393512;16200.351985920432;16629.417970370978;16898;16943.23755430984;17105.144742762564;14939.17834519112;14971.700565988402;15125.773113403528;15290.61773455628;15305.923470382577;13940.30298485092;13980;14001;14094.436222550983;14163.150210987375;14725.190114543375;14830.703385932437;14971.401143954556;14976;15079.170645614158;10948.726281843017;12934.611961641165;12967.675808104495;13254.602361929157;13361.331933403486;12956.222626642431;13472.191668499921;13493.98071432851;13515.59453216405;13812.309384530934 05:00:34 INFO - PID 5737 | __end_tp_report 05:00:34 INFO - PID 5737 | __start_cc_report 05:00:34 INFO - PID 5737 | _x_x_mozilla_cycle_collect,353 05:00:34 INFO - PID 5737 | __end_cc_report 05:00:34 INFO - PID 5737 | __startTimestamp1499774434578__endTimestamp 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | ------- Summary: start ------- 05:00:34 INFO - PID 5737 | Number of tests: 6 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#0] dojo.html Cycles:165 Average:5949.83 Median:6162.08 stddev:691.31 (11.2%) stddev-sans-first:656.80 05:00:34 INFO - PID 5737 | Values: 3119.5 3121.9 3150.5 3163.1 3189.8 5951.3 6018.7 6036.0 6041.5 6087.9 6039.3 6050.5 6065.8 6108.4 6108.7 5543.5 5556.1 5581.0 5591.4 5604.1 5575.2 5575.4 5581.3 5591.6 5592.2 5589.6 5600.5 5602.4 5602.9 5611.4 5600.9 5602.7 5603.8 5609.7 5610.9 5399.1 5466.5 5521.5 5583.0 5587.9 6029.6 6033.6 6120.7 6124.0 6133.3 6271.5 6336.9 6467.0 6591.3 6602.2 6507.9 6551.3 6556.8 6565.3 6568.5 6027.0 6031.8 6056.1 6063.0 6068.6 5220.5 6665.6 6694.1 6712.2 6797.8 6198.9 6383.2 6445.5 6463.0 6470.9 6446.2 6451.2 6521.4 6537.5 6548.4 6396.7 6400.9 6438.6 6472.3 6488.8 5020.5 6368.9 6528.0 6531.2 6612.8 5140.1 5228.2 5284.6 5367.7 5369.8 4505.7 4523.7 4535.6 4536.6 4538.0 5628.1 5640.7 5640.9 5644.0 5648.9 6490.7 6492.0 6495.2 6513.6 6520.8 5537.5 5592.5 5631.5 5636.9 5682.4 5643.9 5663.3 5685.3 5710.6 5721.3 6219.2 6246.2 6246.2 6258.0 6259.5 6428.8 6463.1 6482.5 6484.7 6491.6 6211.8 6285.9 6297.5 6299.8 6304.7 6236.7 6295.4 6308.6 6400.1 6405.2 6441.7 6456.5 6514.2 6531.2 6545.2 6102.3 6249.1 6249.2 6321.7 6352.6 6196.0 6216.2 6235.9 6237.9 6242.4 6108.8 6138.6 6148.4 6162.1 6194.1 5029.6 6412.2 6465.5 6479.4 6489.8 6167.4 6187.0 6253.9 6269.0 6289.7 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#1] ext.html Cycles:180 Average:37209.52 Median:19530.66 stddev:51588.13 (264.1%) stddev-sans-first:51660.40 05:00:34 INFO - PID 5737 | Values: 799.2 815.0 854.6 886.2 891.9 40680.8 41840.6 41889.6 41967.9 42298.2 39976.0 40490.2 43377.6 43426.6 43590.6 7615.2 7750.0 7753.5 7757.6 7770.0 7583.7 7622.4 7655.4 7710.2 7723.1 7705.4 7718.0 7745.4 7746.6 7765.0 7676.9 7682.2 7698.7 7728.8 7743.3 7536.4 7585.6 7599.2 7614.1 7634.8 37197.1 37512.0 37659.4 37703.6 37724.2 3527.9 3532.2 3568.5 3571.9 3577.4 30782.8 30931.5 30971.5 31080.2 31175.5 4533.1 4651.1 4721.9 4842.5 4872.1 174380.0 174593.1 174672.1 175286.0 176188.0 45717.8 46081.0 46084.5 46213.8 46379.0 48036.5 48257.0 48314.5 48348.5 48400.8 16475.6 16623.8 16688.7 16711.7 16782.0 13815.4 13865.8 13866.4 13878.5 13895.1 12981.9 13401.1 13500.3 13556.7 13605.1 4947.4 4963.9 4996.8 5072.5 5119.5 971.8 982.7 993.3 1004.2 1013.8 22650.8 22717.4 22895.4 23148.8 29762.6 1077.5 1104.5 1106.5 1109.5 1120.5 12617.0 12666.9 12899.0 12915.0 12929.8 217131.0 222557.0 224778.0 225600.0 229724.0 57701.4 57757.0 58219.7 58326.4 58390.1 1436.3 1452.9 1457.6 1463.5 1471.5 26278.1 27206.6 27543.7 27635.9 27780.9 34071.8 34164.0 35492.8 38354.4 38384.8 194609.0 195233.0 195883.0 195936.0 197423.0 35134.3 35325.6 35359.3 35449.0 35686.3 42844.4 44027.6 44312.1 44447.3 44730.0 29391.7 31759.5 31762.5 32249.5 32461.7 25684.2 26375.6 34199.1 34335.5 35289.0 37798.0 38029.8 38035.0 38103.0 38325.8 33580.5 34296.3 34383.7 34713.3 34716.8 23627.4 24895.8 24928.5 25121.4 25439.9 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#2] jquery.html Cycles:180 Average:33430.68 Median:22570.61 stddev:76663.06 (339.7%) stddev-sans-first:76838.41 05:00:34 INFO - PID 5737 | Values: 567.2 567.8 571.7 574.4 603.8 16248.2 21787.0 22576.8 22742.9 22744.0 19288.4 19627.1 19664.6 22545.0 24727.8 6351.7 6659.2 6666.5 6671.4 6680.0 6502.6 6591.2 6609.2 6610.9 6624.1 3771.8 4379.5 6566.1 6584.2 6649.1 6549.1 6618.1 6652.3 6659.9 6663.4 6171.0 6176.7 6189.8 6200.1 6206.5 26923.0 27868.3 27981.7 28007.2 28036.4 1932.1 1964.5 1967.2 1973.4 1981.5 18199.0 18840.0 18856.3 18890.4 18895.1 2329.2 2349.6 2389.1 2391.5 2404.4 134750.0 140299.0 141648.0 141758.0 142144.0 13841.4 14436.9 14538.6 14928.6 14997.3 23266.0 23388.9 23481.6 23520.6 23521.5 9888.8 9980.9 10212.3 10240.9 10333.4 9255.7 9342.5 9354.5 9419.6 9434.2 8977.9 9054.5 9278.9 9304.2 9358.7 2317.4 2751.0 2762.4 2837.6 2842.0 968.8 971.1 984.8 998.4 1001.4 18826.2 19012.2 19313.6 22027.6 23505.4 1030.2 1031.6 1034.3 1035.1 1048.6 10821.9 10825.1 10846.2 10956.9 11013.4 426284.0 444889.0 457325.0 461318.0 462280.0 111906.4 112352.4 113175.0 114178.4 116437.0 1236.4 1285.0 1301.1 1310.5 1315.4 16725.1 17458.6 17760.0 17940.8 18053.5 55693.4 56659.0 57710.8 58991.4 60541.0 72415.6 72741.0 72946.0 74397.0 74397.6 14051.4 14419.6 14572.7 14606.6 14607.0 20908.9 22564.4 22615.9 22666.4 22877.2 17806.7 17959.7 17960.0 18093.6 18107.0 14733.9 15058.7 15255.3 15412.0 15820.1 16997.8 18100.9 18206.2 18544.3 18833.3 14313.1 14368.1 14418.3 14428.0 14453.3 18194.8 18201.8 18225.9 18226.2 19145.6 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#3] mootools.html Cycles:180 Average:8248.69 Median:2535.58 stddev:5403.09 (213.1%) stddev-sans-first:5393.44 05:00:34 INFO - PID 5737 | Values: 1359.3 1415.0 1423.7 1426.7 1437.4 12586.0 12918.2 13236.3 13278.7 13281.1 12916.7 13552.5 13573.3 13671.0 13672.6 2637.1 2677.8 2688.9 2692.9 2697.4 2470.4 2559.3 2562.9 2563.0 2565.1 2498.2 2513.8 2528.8 2549.9 2555.0 2581.9 2671.4 2673.6 2682.4 2682.5 2514.5 2532.5 2535.2 2535.9 2541.7 13082.4 13120.3 13183.5 13190.1 13207.0 7074.6 7326.4 7379.8 7417.8 7422.0 4739.8 4793.5 5025.9 5032.1 5045.1 1640.3 1657.9 1736.4 1738.9 1740.0 20165.8 20365.5 20386.9 20488.6 20559.4 5970.9 6219.0 6246.8 6395.6 6425.5 15343.2 15344.8 15357.7 15372.5 15441.6 6972.0 7296.4 7320.7 7337.8 7358.8 6640.0 6764.0 6809.1 6820.0 6871.9 4692.6 4806.7 4809.3 4880.1 4901.0 1428.8 1432.2 1434.1 1445.1 1465.1 900.5 911.4 927.4 929.2 942.1 7036.7 7103.7 7131.1 7154.4 7198.3 682.3 708.6 976.2 1018.4 1020.2 4735.1 5016.1 5035.9 5080.0 5167.1 16841.2 17930.6 17954.6 18136.2 18192.7 16711.5 17006.7 17371.0 17443.8 17854.0 9984.8 10188.1 10338.9 10491.6 10518.7 7867.4 8147.7 8218.4 8226.8 8304.2 14425.3 15269.5 15459.5 15636.8 15829.0 14831.9 15315.8 15675.7 15716.5 15953.5 10918.6 11474.6 11492.2 11619.8 11665.5 12857.7 12956.2 13031.2 13072.5 13076.5 10178.6 10205.5 10336.8 10408.8 10423.8 9587.4 9839.7 10125.9 10159.7 10162.0 9476.0 9494.8 9498.4 9540.9 9621.2 6707.8 6848.4 6974.3 6985.2 7139.0 7021.4 7115.5 7189.1 7227.8 7230.5 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#4] prototype.html Cycles:180 Average:5392.05 Median:5842.55 stddev:1501.71 (25.7%) stddev-sans-first:1460.19 05:00:34 INFO - PID 5737 | Values: 491.8 493.8 513.7 520.4 530.8 6016.5 6056.0 6061.9 6094.5 6107.1 5749.9 5853.2 5887.4 5922.2 5997.7 4854.4 4856.7 4871.9 4918.5 4940.5 4842.8 4844.4 4879.2 4908.3 4911.9 4819.3 4853.9 4860.0 4873.7 4880.8 4574.2 4825.7 4849.3 4871.8 4875.3 4324.6 4332.5 4336.5 4362.3 4405.7 5786.6 5797.5 5806.4 5834.9 5850.2 5532.5 5543.7 5566.3 5582.9 5602.7 6291.6 6303.8 6311.8 6342.7 6438.0 4758.7 4825.4 4835.4 4858.4 4871.5 6769.1 6771.5 6792.8 6826.2 6855.0 4993.7 4997.4 4997.8 5006.7 5015.4 4920.5 4964.0 5018.5 5024.6 5035.8 5550.6 5559.0 5569.6 5571.1 5586.6 6365.4 6416.8 6461.4 6482.9 6484.1 1724.1 1744.7 1748.5 1758.1 1763.8 1121.4 1195.8 1214.6 1215.2 1215.7 5461.9 5520.6 5527.9 5546.6 5697.0 6463.0 6496.7 6523.6 6585.2 6597.5 5636.6 5647.9 5668.8 5686.6 5689.9 3430.4 3457.9 3465.2 3496.2 3509.9 6386.3 6410.1 6465.6 6492.3 6500.8 6746.2 6764.9 6766.8 6776.9 6789.9 6354.9 6360.5 6374.5 6448.3 6475.4 6495.4 6549.3 6562.7 6573.8 6598.6 6351.4 6439.9 6493.7 6494.4 6531.4 6201.7 6234.9 6340.7 6361.9 6369.5 5264.8 5326.4 5355.0 5365.3 5391.2 6537.5 6537.5 6571.6 6585.4 6608.4 6340.3 6380.8 6401.9 6414.8 6418.2 6377.6 6398.9 6403.1 6446.5 6458.0 6272.8 6297.2 6305.8 6323.7 6365.3 6347.4 6354.1 6366.2 6398.2 6410.0 5627.7 6064.7 6085.2 6143.5 6151.2 05:00:34 INFO - PID 5737 | 05:00:34 INFO - PID 5737 | [#5] yui.html Cycles:180 Average:20689.01 Median:18006.10 stddev:27918.87 (155.1%) stddev-sans-first:27957.72 05:00:34 INFO - PID 5737 | Values: 918.6 920.7 932.5 935.9 946.1 16872.7 17180.6 18023.0 18552.4 18613.9 15355.8 15788.8 15873.1 15999.2 18358.8 1005.7 1032.4 1036.7 1041.2 1041.5 1035.4 1038.3 1044.7 1046.1 1050.2 1104.8 1106.1 1106.2 1110.1 1118.0 1018.2 1070.1 1077.5 1083.9 1101.6 792.4 795.3 801.4 802.4 802.7 17989.2 18119.4 18119.8 18162.4 18245.9 18823.3 19030.8 19509.8 19578.4 19606.5 15329.2 15368.5 15470.0 15483.0 15570.6 3386.9 3399.9 3418.8 3419.7 3436.4 101422.0 102319.5 105551.5 107243.5 108015.0 16059.4 16063.0 16516.2 16702.4 16708.9 28385.0 28599.4 28844.7 29024.4 29068.6 8632.0 8648.1 8650.7 8659.5 8676.1 3626.7 3682.8 3736.6 3737.4 3744.3 4946.3 4956.4 4959.7 5002.7 5026.7 915.3 938.8 942.8 955.9 956.3 594.4 678.9 702.4 707.7 730.6 11492.9 11638.9 11728.8 11730.1 11797.4 650.5 652.1 669.4 677.9 678.6 5451.5 5481.7 5486.5 5520.2 5598.2 98456.5 100926.5 102068.5 102535.0 104292.5 90162.5 91032.0 91465.0 92828.0 94929.0 73112.0 75002.6 75872.0 77156.0 78939.0 10443.4 10675.5 10851.9 10855.2 10879.8 33622.0 33749.2 34269.7 34572.0 35834.5 43302.6 43485.8 44599.1 44750.8 45912.3 14753.3 15083.1 15356.2 15383.2 15387.1 16200.4 16629.4 16898.0 16943.2 17105.1 14939.2 14971.7 15125.8 15290.6 15305.9 13940.3 13980.0 14001.0 14094.4 14163.2 14725.2 14830.7 14971.4 14976.0 15079.2 10948.7 12934.6 12967.7 13254.6 13361.3 12956.2 13472.2 13494.0 13515.6 13812.3 05:00:34 INFO - PID 5737 | -------- Summary: end -------- 05:00:34 INFO - PID 5737 | 05:00:35 INFO - TEST-INFO | 5737: exit 0 05:00:35 INFO - TEST-OK | dromaeo_css | took 1113264ms 05:00:35 INFO - TEST-START | kraken 05:00:35 INFO - Initialising browser for kraken test... 05:00:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40396/getInfo.html -profile /tmp/tmp1NU2Af/profile 05:00:35 INFO - TEST-INFO | started process 6151 (/builds/slave/test/build/application/firefox/firefox http://localhost:40396/getInfo.html) 05:00:41 INFO - TEST-INFO | 6151: exit 0 05:00:41 INFO - Browser initialized. 05:00:41 INFO - Running cycle 1/1 for kraken test... 05:00:41 INFO - TEST-INFO | started process 6369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1NU2Af/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:52 INFO - PID 6369 | RSS: Main: 174350336 05:00:52 INFO - PID 6369 | 05:00:55 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40396/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:56 INFO - PID 6369 | RSS: Main: 178212864 05:00:56 INFO - PID 6369 | 05:00:58 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40396/tests/kraken/driver.html?testName=audio-dft) 05:00:59 INFO - PID 6369 | RSS: Main: 178749440 05:00:59 INFO - PID 6369 | 05:01:02 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40396/tests/kraken/driver.html?testName=audio-fft) 05:01:03 INFO - PID 6369 | RSS: Main: 173342720 05:01:03 INFO - PID 6369 | 05:01:05 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40396/tests/kraken/driver.html?testName=audio-oscillator) 05:01:05 INFO - PID 6369 | RSS: Main: 173314048 05:01:05 INFO - PID 6369 | 05:01:07 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:08 INFO - PID 6369 | RSS: Main: 173228032 05:01:08 INFO - PID 6369 | 05:01:11 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40396/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:12 INFO - PID 6369 | RSS: Main: 176549888 05:01:12 INFO - PID 6369 | 05:01:15 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40396/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:16 INFO - PID 6369 | RSS: Main: 178548736 05:01:16 INFO - PID 6369 | 05:01:19 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40396/tests/kraken/driver.html?testName=json-parse-financial) 05:01:19 INFO - PID 6369 | RSS: Main: 177397760 05:01:19 INFO - PID 6369 | 05:01:21 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:21 INFO - PID 6369 | RSS: Main: 177090560 05:01:21 INFO - PID 6369 | 05:01:23 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:24 INFO - PID 6369 | RSS: Main: 177745920 05:01:24 INFO - PID 6369 | 05:01:26 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:27 INFO - PID 6369 | RSS: Main: 178311168 05:01:27 INFO - PID 6369 | 05:01:29 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:30 INFO - PID 6369 | RSS: Main: 177983488 05:01:30 INFO - PID 6369 | 05:01:33 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:34 INFO - PID 6369 | RSS: Main: 177688576 05:01:34 INFO - PID 6369 | 05:01:35 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:40396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40396/tests/kraken/driver.html?testName=ai-astar) 05:01:36 INFO - PID 6369 | RSS: Main: 179105792 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | __start_tp_report 05:01:36 INFO - PID 6369 | _x_x_mozilla_page_load 05:01:36 INFO - PID 6369 | _x_x_mozilla_page_load_details 05:01:36 INFO - PID 6369 | |i|pagename|runs| 05:01:36 INFO - PID 6369 | |0;ai-astar;100;108;109;111;112;113;109;109;109;110 05:01:36 INFO - PID 6369 | |1;audio-beat-detection;147;120;154;191;120;142;152;126;175;123 05:01:36 INFO - PID 6369 | |2;audio-dft;163;163;162;162;162;162;165;167;179;164 05:01:36 INFO - PID 6369 | |3;audio-fft;75;75;75;190;76;76;75;76;100;76 05:01:36 INFO - PID 6369 | |4;audio-oscillator;83;82;128;82;81;82;136;82;81;141 05:01:36 INFO - PID 6369 | |5;imaging-gaussian-blur;114;114;114;113;113;114;113;114;113;114 05:01:36 INFO - PID 6369 | |6;imaging-darkroom;151;149;151;151;152;150;148;150;150;151 05:01:36 INFO - PID 6369 | |7;imaging-desaturate;94;95;94;94;95;94;94;95;95;95 05:01:36 INFO - PID 6369 | |8;json-parse-financial;55;55;55;55;55;54;55;53;56;54 05:01:36 INFO - PID 6369 | |9;json-stringify-tinderbox;55;54;55;54;54;54;54;54;57;56 05:01:36 INFO - PID 6369 | |10;stanford-crypto-aes;86;76;79;78;78;86;77;77;77;80 05:01:36 INFO - PID 6369 | |11;stanford-crypto-ccm;129;130;137;130;127;131;132;124;124;152 05:01:36 INFO - PID 6369 | |12;stanford-crypto-pbkdf2;182;181;183;181;184;179;182;196;182;181 05:01:36 INFO - PID 6369 | |13;stanford-crypto-sha256-iterative;72;71;75;69;72;72;69;78;70;69 05:01:36 INFO - PID 6369 | __end_tp_report 05:01:36 INFO - PID 6369 | __start_cc_report 05:01:36 INFO - PID 6369 | _x_x_mozilla_cycle_collect,985 05:01:36 INFO - PID 6369 | __end_cc_report 05:01:36 INFO - PID 6369 | __startTimestamp1499774496064__endTimestamp 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | ------- Summary: start ------- 05:01:36 INFO - PID 6369 | Number of tests: 14 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:3.53 (3.2%) stddev-sans-first:1.66 05:01:36 INFO - PID 6369 | Values: 100.0 108.0 109.0 111.0 112.0 113.0 109.0 109.0 109.0 110.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:149.50 stddev:24.16 (16.2%) stddev-sans-first:25.62 05:01:36 INFO - PID 6369 | Values: 147.0 120.0 154.0 191.0 120.0 142.0 152.0 126.0 175.0 123.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.50 stddev:5.22 (3.2%) stddev-sans-first:5.49 05:01:36 INFO - PID 6369 | Values: 163.0 163.0 162.0 162.0 162.0 162.0 165.0 167.0 179.0 164.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#3] audio-fft Cycles:10 Average:89.40 Median:75.50 stddev:36.18 (47.9%) stddev-sans-first:38.00 05:01:36 INFO - PID 6369 | Values: 75.0 75.0 75.0 190.0 76.0 76.0 75.0 76.0 100.0 76.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:82.00 stddev:25.86 (31.5%) stddev-sans-first:26.87 05:01:36 INFO - PID 6369 | Values: 83.0 82.0 128.0 82.0 81.0 82.0 136.0 82.0 81.0 141.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:01:36 INFO - PID 6369 | Values: 114.0 114.0 114.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:151.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 05:01:36 INFO - PID 6369 | Values: 151.0 149.0 151.0 151.0 152.0 150.0 148.0 150.0 150.0 151.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:01:36 INFO - PID 6369 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:01:36 INFO - PID 6369 | Values: 55.0 55.0 55.0 55.0 55.0 54.0 55.0 53.0 56.0 54.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.50 stddev:1.06 (1.9%) stddev-sans-first:1.12 05:01:36 INFO - PID 6369 | Values: 55.0 54.0 55.0 54.0 54.0 54.0 54.0 54.0 57.0 56.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.50 stddev:3.66 (4.7%) stddev-sans-first:3.00 05:01:36 INFO - PID 6369 | Values: 86.0 76.0 79.0 78.0 78.0 86.0 77.0 77.0 77.0 80.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.50 stddev:8.13 (6.2%) stddev-sans-first:8.57 05:01:36 INFO - PID 6369 | Values: 129.0 130.0 137.0 130.0 127.0 131.0 132.0 124.0 124.0 152.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:182.00 stddev:4.72 (2.6%) stddev-sans-first:4.99 05:01:36 INFO - PID 6369 | Values: 182.0 181.0 183.0 181.0 184.0 179.0 182.0 196.0 182.0 181.0 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:2.91 (4.0%) stddev-sans-first:3.08 05:01:36 INFO - PID 6369 | Values: 72.0 71.0 75.0 69.0 72.0 72.0 69.0 78.0 70.0 69.0 05:01:36 INFO - PID 6369 | -------- Summary: end -------- 05:01:36 INFO - PID 6369 | 05:01:36 INFO - PID 6369 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:01:36 INFO - TEST-INFO | 6369: exit 0 05:01:36 INFO - TEST-OK | kraken | took 61666ms 05:01:36 INFO - SUITE-END | took 1174s 05:01:37 INFO - Completed test suite (00:19:35) 05:01:37 INFO - javascript benchmark 05:01:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8195.112473164847, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.5476655884895, 3121.859516321765, 3150.5431712401687, 3163.114327988164, 3189.840507974601, 5951.315598706145, 6018.6689732064715, 6035.969820150898, 6041.516678665713, 6087.939120608793, 6039.335673075969, 6050.455459008688, 6065.8180254592435, 6108.419700128492, 6108.725107370168, 5543.501084902358, 5556.083246264372, 5580.972095139539, 5591.440855914397, 5604.103343465046, 5575.2473416088715, 5575.414581468948, 5581.302337207849, 5591.580631452637, 5592.189132575774, 5589.580781441387, 5600.52395546379, 5602.411746766592, 5602.859928501779, 5611.410801865806, 5600.915986260209, 5602.691851948141, 5603.803866864681, 5609.747561359749, 5610.915836262459, 5399.082156033483, 5466.453354664542, 5521.503064724154, 5583.022970980103, 5587.8603034924045, 6029.60807547508, 6033.637981721067, 6120.724567394478, 6123.969380153116, 6133.264008318985, 6271.529635277372, 6336.936630633681, 6466.95339857235, 6591.307912669148, 6602.1747281589805, 6507.93492065078, 6551.344865513458, 6556.836079098013, 6565.310642382577, 6568.540202185849, 6026.96986515069, 6031.819045428644, 6056.06131049688, 6063.0299152135885, 6068.6358818471035, 5220.477952204825, 6665.633390163491, 6694.062831203635, 6712.160979877515, 6797.830054248584, 6198.907016394758, 6383.170187875547, 6445.516586255956, 6462.998235273541, 6470.935290647128, 6446.161998940202, 6451.1936007999, 6521.380468855451, 6537.5096867734155, 6548.443382312556, 6396.744130234832, 6400.871982560323, 6438.581492202992, 6472.3204063573585, 6488.7728929488185, 5020.49795020495, 6368.91728406172, 6528.0, 6531.150950376421, 6612.801615951529, 5140.1004824155625, 5228.189630607262, 5284.583302115286, 5367.651102678314, 5369.812056578001, 4505.7296562206375, 4523.705959112647, 4535.591796738309, 4536.56902594253, 4537.977310113494, 5628.127640215773, 5640.689762063043, 5640.8871822563315, 5643.984082865041, 5648.85877853057, 6490.740370385226, 6491.967540162364, 6495.220573531112, 6513.641749703812, 6520.804375868732, 5537.501624853782, 5592.5246354059545, 5631.549476041907, 5636.85907852307, 5682.40334764852, 5643.943560564342, 5663.32040155184, 5685.260916080883, 5710.628809127394, 5721.256236689287, 6219.191505104308, 6246.15676883624, 6246.219222597176, 6258.030005349269, 6259.467945224706, 6428.8071357859335, 6463.062855885776, 6482.546221764431, 6484.70818813164, 6491.642959637265, 6211.751529938932, 6285.905711414241, 6297.527685423704, 6299.811005669837, 6304.65324407162, 6236.719347629459, 6295.433410993032, 6308.589941653778, 6400.135981642418, 6405.231372235362, 6441.742330306735, 6456.483481321577, 6514.218293804774, 6531.150950376421, 6545.247296560957, 6102.298235702773, 6249.093881387264, 6249.218847644044, 6321.652309123042, 6352.618842869442, 6196.0, 6216.160818289654, 6235.906461402992, 6237.875242495215, 6242.375762423721, 6108.75564977396, 6138.600990935575, 6148.385161483816, 6162.075688646739, 6194.0708893666315, 5029.64792464524, 6412.198475190601, 6465.450436712932, 6479.416852483299, 6489.837754055998, 6167.352427994996, 6186.969065154645, 6253.874922501615, 6269.0, 6289.685515724104], "value": 5902.315112485291, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.1968072087551, 814.9551774652392, 854.5897968974892, 886.2245535156737, 891.9108089191081, 40680.79659601702, 41840.58159418405, 41889.58110418903, 41967.901604919745, 42298.154036919244, 39976.0, 40490.19019619606, 43377.566224337745, 43426.56573434265, 43590.56409435905, 7615.16233214346, 7750.0, 7753.534787912743, 7757.612119394036, 7770.0287464067, 7583.734569290076, 7622.390208783312, 7655.387568994467, 7710.228977102301, 7723.111842138142, 7705.383569314469, 7718.0, 7745.380369570421, 7746.573938433384, 7765.0, 7676.884846727247, 7682.1549629540705, 7698.730544430946, 7728.845423091563, 7743.26438988298, 7536.434767392413, 7585.62071896403, 7599.164091949881, 7614.124375696755, 7634.770956871303, 37197.07007324811, 37512.0, 37659.43510847339, 37703.622963770285, 37724.24551508982, 3527.94708079379, 3532.1522834519787, 3568.50040994261, 3571.8928432147077, 3577.373959557067, 30782.846085769652, 30931.536026959613, 30971.535426968614, 31080.222994425094, 31175.53236701451, 4533.093381323715, 4651.116287905287, 4721.929171062437, 4842.491538388454, 4872.1473742094995, 174380.0, 174593.1270343653, 174672.12663936726, 175286.0, 176188.0, 45717.771411143396, 46081.0, 46084.5391546087, 46213.76893115513, 46379.0, 48036.5196348039, 48257.0, 48314.5168548317, 48348.51651483511, 48400.757996209795, 16475.58811029734, 16623.750643740354, 16688.6662266754, 16711.749323760152, 16782.0, 13815.378307976165, 13865.792013119812, 13866.376013079436, 13878.514252001132, 13895.096818706752, 12981.935090324678, 13401.128926619738, 13500.257485838372, 13556.728865422636, 13605.115667481581, 4947.356843610308, 4963.925541116886, 4996.7501624918605, 5072.467390923974, 5119.48805119485, 971.795922856194, 982.6904525074578, 993.2699465892563, 1004.1514919892679, 1013.8023085498257, 22650.773492265194, 22717.432064198198, 22895.427614309443, 23148.768512314997, 29762.553561696594, 1077.504347999913, 1104.5250542266901, 1106.4578356605205, 1109.4896347680158, 1120.4789772755707, 12617.0, 12666.936665316798, 12899.0, 12915.031372647089, 12929.806052909214, 217131.0, 222557.0, 224778.0, 225600.0, 229724.0, 57701.422985769605, 57757.0, 58219.70890145607, 58326.41673583295, 58390.12414813781, 1436.3392839294042, 1452.8765054970233, 1457.5918742752258, 1463.4512057978259, 1471.5364660132238, 26278.080267190555, 27206.606636486064, 27543.724562754116, 27635.861820690767, 27780.8610956952, 34071.82964085164, 34164.0, 35492.82253588819, 38354.42468363033, 38384.808075959445, 194609.0, 195233.0, 195883.0, 195936.0, 197423.0, 35134.297314054085, 35325.64674353327, 35359.292814144086, 35449.0, 35686.28627427489, 42844.35733464063, 44027.57848318373, 44312.11375772531, 44447.33329000132, 44730.0, 29391.706082939752, 31759.52360714545, 31762.52356214705, 32249.51625725569, 32461.675383245863, 25684.229473115836, 26375.60436593414, 34199.14502137367, 34335.484967725, 35289.0, 37798.0, 38029.80985095168, 38035.04912377213, 38103.0, 38325.808370957966, 33580.496292555144, 34296.31407371889, 34383.65616343805, 34713.30573388569, 34716.826415867756, 23627.40931476727, 24895.75104249007, 24928.50142997166, 25121.371965701004, 25439.87280063588], "value": 17188.171290167127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2172402085122, 567.8410045187347, 571.7084287013622, 574.4427904932217, 603.767549493445, 16248.18759062048, 21787.0, 22576.774232257692, 22742.88628556859, 22743.97652105655, 19288.421347359566, 19627.11677974491, 19664.60670786587, 22545.0, 24727.75272247277, 6351.682415879211, 6659.167604049494, 6666.500012499057, 6671.399574038335, 6680.031395447657, 6502.642354670491, 6591.209054913417, 6609.239937407187, 6610.900836487456, 6624.105745724314, 3771.7925514096714, 4379.474463064421, 6566.113574667431, 6584.242812076601, 6649.135612370385, 6549.148610680605, 6618.07346971422, 6652.268250492442, 6659.9001014984815, 6663.36698013688, 6171.0, 6176.69116544171, 6189.752409903598, 6200.131981522591, 6206.472449841769, 26923.0, 27868.30329241785, 27981.72018279832, 28007.159785206273, 28036.439271214665, 1932.120884997323, 1964.489232799468, 1967.2131147540954, 1973.3783858084657, 1981.5343394302326, 18199.0, 18840.0, 18856.34002809895, 18890.433287001273, 18895.055247237582, 2329.23135365329, 2349.6475528670667, 2389.0563227525204, 2391.5456063348083, 2404.350825277183, 134750.0, 140299.0, 141648.0, 141758.0, 142144.0, 13841.377138028813, 14436.927815360856, 14538.563843084725, 14928.62678433048, 14997.250137493082, 23266.0, 23388.883055584953, 23481.647775283385, 23520.64719029216, 23521.529569408514, 9888.802223955481, 9980.850287245697, 10212.336198147097, 10240.897591024144, 10333.379997200193, 9255.722328330161, 9342.532873356306, 9354.532273386303, 9419.576119074658, 9434.245260379153, 8977.865332020025, 9054.547272636473, 9278.860817087749, 9304.209142222851, 9358.672446464341, 2317.351141680332, 2751.0, 2762.4337010912714, 2837.5743638453982, 2841.971580284212, 968.8256113899565, 971.0915807157609, 984.7692923924652, 998.4209158688088, 1001.3591301567003, 18826.246950122117, 19012.23951041943, 19313.613727725366, 22027.559448810935, 23505.412364690677, 1030.2221822523945, 1031.633770011635, 1034.3225187502048, 1035.0787798859021, 1048.6434612231878, 10821.9458902705, 10825.133989280996, 10846.240763146505, 10956.945215273872, 11013.449327533592, 426284.0, 444889.0, 457325.0, 461318.0, 462280.0, 111906.44046779715, 112352.43823780828, 113175.0, 114178.42910785392, 116437.0, 1236.449779847959, 1285.042643230799, 1301.102239454773, 1310.5282098444552, 1315.3817705678507, 16725.146198830313, 17458.55801877382, 17760.0, 17940.820591794436, 18053.458396248134, 55693.44306556883, 56659.0, 57710.845783084944, 58991.41008589859, 60541.0, 72415.63792181005, 72741.0, 72946.0, 74397.0, 74397.62801185959, 14051.36768845384, 14419.567412977627, 14572.708545829237, 14606.561803145923, 14607.0, 20908.895455522626, 22564.435889102904, 22615.88692056529, 22666.433339165993, 22877.19929802449, 17806.732899006784, 17959.73060404121, 17960.0, 18093.638127237118, 18107.0, 14733.926330368708, 15058.6988260232, 15255.313510892258, 15411.998220115656, 15820.129892856003, 16997.830021699625, 18100.909495452437, 18206.180721867284, 18544.331010209145, 18833.340833070775, 14313.141211526925, 14368.13791172533, 14418.279086045866, 14428.0, 14453.349599267847, 18194.818051819842, 18201.81798182001, 18225.90887045556, 18226.17982190831, 19145.617087658447], "value": 11757.23271600928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.286374653307, 1415.0377743134663, 1423.651205454663, 1426.678997225625, 1437.3531910640208, 12586.049162379823, 12918.224906505617, 13236.272005039731, 13278.66803329916, 13281.136726112796, 12916.677083072927, 13552.525661601845, 13573.321333933312, 13671.0, 13672.589822305346, 2637.0902038796585, 2677.799165062618, 2688.892444302235, 2692.9461410771773, 2697.4335389568214, 2470.4318006858434, 2559.25781523358, 2562.9359266018405, 2562.9615555766677, 2565.050931155475, 2498.150628786212, 2513.773760361567, 2528.835625684334, 2549.8852551635127, 2555.0, 2581.90963316284, 2671.3588738702765, 2673.5722284434496, 2682.4232789950156, 2682.543967525525, 2514.4719608882156, 2532.518821423942, 2535.239428171541, 2535.9239222823344, 2541.6568763216915, 13082.411291491906, 13120.278384688838, 13183.538576149884, 13190.07669463138, 13207.009474289467, 7074.610896400696, 7326.413886889036, 7379.8155046124275, 7417.777466676009, 7421.998030265899, 4739.786709598076, 4793.544613261734, 5025.949740502621, 5032.119379108642, 5045.117104506733, 1640.261882153024, 1657.9253933573018, 1736.3749050341867, 1738.8695847811339, 1739.9652006959916, 20165.79834201654, 20365.49086272855, 20386.898065509577, 20488.590228195502, 20559.38321850347, 5970.910436343458, 6219.0, 6246.843828904223, 6395.584287021329, 6425.453836423862, 15343.156126413154, 15344.769828452581, 15357.692846143014, 15372.461963831436, 15441.613959650875, 6971.965140174267, 7296.379807716404, 7320.67056982437, 7337.779866604011, 7358.816029599303, 6640.0, 6763.966180169166, 6809.080774095532, 6819.965900170567, 6871.862562748717, 4692.6245900327895, 4806.663533552618, 4809.302651115639, 4880.1215781159735, 4901.044296362246, 1428.8285405751376, 1432.1621851217155, 1434.1323499282785, 1445.104035497998, 1465.1282486920265, 900.4597241654955, 911.4075850696968, 927.420362273579, 929.2008872369756, 942.0767647705287, 7036.718531258794, 7103.715851365991, 7131.072960515204, 7154.39187669054, 7198.316159964795, 682.3108660253081, 708.6173466328228, 976.2190247801731, 1018.399144504731, 1020.1634659579222, 4735.147673418749, 5016.072026675077, 5035.949640503548, 5080.034793389318, 5167.121589329823, 16841.157942102847, 17930.641387172185, 17954.5511362217, 18136.18387172554, 18192.727109093375, 16711.498655040366, 17006.744898826528, 17371.0, 17443.825561744474, 17854.0, 9984.750381240672, 10188.083072523508, 10338.896611033944, 10491.632792852213, 10518.684439466828, 7867.370610351272, 8147.714829980922, 8218.424710270463, 8226.794330141554, 8304.169583041648, 14425.278736062945, 15269.541913742605, 15459.536213913601, 15636.843631563539, 15829.0, 14831.851681483047, 15315.770263445835, 15675.686486270439, 15716.528504144893, 15953.521394358188, 10918.617848375268, 11474.598389056342, 11492.195546311677, 11619.825702614298, 11665.533378664759, 12857.742845143232, 12956.222626642431, 13031.218126912416, 13072.477100915858, 13076.476940922257, 10178.62794745996, 10205.489725513844, 10336.844947325646, 10408.843867341844, 10423.791524169626, 9587.424754514752, 9839.655612053544, 10125.949370253102, 10159.695209143738, 10162.0, 9476.005019473132, 9494.762630934281, 9498.382605130644, 9540.904590954002, 9621.230301575997, 6707.826130427058, 6848.383645471931, 6974.302569743188, 6985.231624521401, 7138.964305178441, 7021.43828493709, 7115.466340024623, 7189.137303523611, 7227.7831665050135, 7230.45771567124], "value": 6112.520216050797, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.79836267130463, 493.8049470459168, 513.6994858008065, 520.4483247757378, 530.7956436771842, 6016.51867850572, 6055.971249631373, 6061.939380606193, 6094.451499365056, 6107.083937409391, 5749.856253593663, 5853.209816674747, 5887.352391236971, 5922.170896074542, 5997.6701281429505, 4854.417469903617, 4856.660033797635, 4871.878203044926, 4918.483559226283, 4940.505949405048, 4842.806287748486, 4844.397822069031, 4879.194932836078, 4908.282101264546, 4911.852644420655, 4819.277108433728, 4853.8543843684565, 4860.003699241647, 4873.707577545341, 4880.8047678092835, 4574.199515084863, 4825.734584597846, 4849.345338379327, 4871.780769865364, 4875.268709693539, 4324.610785029331, 4332.458442694663, 4336.544662810391, 4362.302031674949, 4405.713628614162, 5786.594938354275, 5797.478226959552, 5806.390329015477, 5834.883302333929, 5850.210221620069, 5532.474414930575, 5543.722813859331, 5566.332040155207, 5582.91625625616, 5602.691851948141, 6291.622502649856, 6303.842403939892, 6311.779087731953, 6342.714577843962, 6438.0, 4758.690685105457, 4825.396825396825, 4835.395575553056, 4858.392700912386, 4871.512848715136, 6769.120014398146, 6771.476417805954, 6792.830179245509, 6826.180858296986, 6855.0, 4993.67793975803, 4997.375328083989, 4997.75056235941, 5006.74966251686, 5015.3730783652045, 4920.458749537548, 4964.007198560303, 5018.498150185025, 5024.598032157419, 5035.84892453227, 5550.611457197957, 5559.0, 5569.610127291051, 5571.1086226203615, 5586.636868603528, 6365.427111559982, 6416.807495775134, 6461.386168314003, 6482.870342593122, 6484.077133334359, 1724.0862342958253, 1744.6946784312947, 1748.4667176511286, 1758.0945812906364, 1763.8236176382259, 1121.4448847820381, 1195.8086706126978, 1214.6477521518661, 1215.2404747033104, 1215.6778453709774, 5461.869870750411, 5520.613557050968, 5527.917081243784, 5546.611737178358, 5697.0, 6463.0, 6496.740130394825, 6523.575967562093, 6585.242697089896, 6597.505187110986, 5636.605437619327, 5647.858803529863, 5668.829935101953, 5686.630369026083, 5689.857753556194, 3430.382531144418, 3457.913552161216, 3465.151037995707, 3496.2133519958315, 3509.859605615798, 6386.329435409308, 6410.1154480483965, 6465.64438955862, 6492.253390860017, 6500.837479063061, 6746.190457145076, 6764.936694308283, 6766.830829229309, 6776.898346524806, 6789.93210067893, 6354.936450635527, 6360.459360954278, 6374.521910856612, 6448.290688024314, 6475.449586785082, 6495.350464953467, 6549.279579246184, 6562.737490500326, 6573.769918052845, 6598.637074960923, 6351.396617321347, 6439.935600643934, 6493.6687978963255, 6494.447971922439, 6531.379518945692, 6201.689915504297, 6234.906476402948, 6340.682965851781, 6361.93638063632, 6369.522285828489, 5264.815731449381, 5326.414094449685, 5355.0, 5365.3293338332705, 5391.2182733504205, 6537.477001839747, 6537.542372033912, 6571.638559879252, 6585.440237579859, 6608.4052435281055, 6340.270868850142, 6380.808575742735, 6401.93598064032, 6414.839629009312, 6418.1656384669695, 6377.553571250153, 6398.872022559616, 6403.079076277191, 6446.484281257394, 6457.967710161419, 6272.839524687947, 6297.2128483939505, 6305.779297724557, 6323.73525294952, 6365.331640177715, 6347.428731414195, 6354.142190804368, 6366.236051673829, 6398.200224971879, 6409.9679501602195, 5627.718614069362, 6064.666443345482, 6085.208922840003, 6143.539234557516, 6151.231096112986], "value": 4952.167582007293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.5636822509309, 920.714578480671, 932.5244125495999, 935.8642996765474, 946.1201082992816, 16872.746908796362, 17180.570485737862, 18022.99999999998, 18552.350667726598, 18613.906930465328, 15355.769663455028, 15788.84211157888, 15873.126978016204, 15999.200039998012, 18358.816411835876, 1005.6982905128468, 1032.4424810602266, 1036.7097212780434, 1041.1670663469195, 1041.4792603698152, 1035.3529044347283, 1038.3043360948184, 1044.7492601775596, 1046.1160319530022, 1050.1861057680283, 1104.828751543512, 1106.0985296982974, 1106.1758989552795, 1110.0730889707063, 1118.0049755717419, 1018.231235417259, 1070.0583486531802, 1077.4720387010386, 1083.9187060970419, 1101.5703875488566, 792.4254915186501, 795.308081968691, 801.4069588504465, 802.3661307567073, 802.7190483330846, 17989.190486428142, 18119.36582219629, 18119.818801811944, 18162.364317248965, 18245.908770456062, 18823.34118305853, 19030.809691903043, 19509.80490195094, 19578.412647620593, 19606.50983725404, 15329.233538323038, 15368.462103826425, 15469.994450360691, 15483.0, 15570.610734731723, 3386.86452541898, 3399.932001359959, 3418.8461519231446, 3419.709324707378, 3436.3642726095504, 101422.0, 102319.48840255826, 105551.47224263907, 107243.46378268058, 108015.0, 16059.357625695075, 16063.036217826968, 16516.17419129039, 16702.415415460644, 16708.916455417646, 28385.0, 28599.428011439653, 28844.711552884204, 29024.41951161007, 29068.563971540443, 8632.0, 8648.091950345122, 8650.740477785677, 8659.52372619512, 8676.1323867614, 3626.6917312028245, 3682.815859207029, 3736.626337366242, 3737.4020156775327, 3744.26986737589, 4946.258061290835, 4956.405231372186, 4959.7272150032095, 5002.699838009731, 5026.698398096126, 915.3455279475074, 938.8497840345512, 942.8067246214509, 955.8661787349777, 956.3257903178243, 594.3877805859971, 678.9171271821436, 702.3503259485058, 707.7098389660215, 730.5726150202084, 11492.94253528727, 11638.94180529109, 11728.76542469163, 11730.061595072544, 11797.351145686898, 650.456868514786, 652.1489456259532, 669.3641041011059, 677.9254282028973, 678.5588324416705, 5451.509364157245, 5481.725913704378, 5486.451354864482, 5520.227168196456, 5598.21624972496, 98456.50771746096, 100926.49536752269, 102068.48965755272, 102535.0, 104292.47853760683, 90162.54918725364, 91032.0, 91465.0, 92828.0, 94929.0, 73112.0, 75002.62498687471, 75871.9999999989, 77156.0, 78939.0, 10443.425611591436, 10675.51960161779, 10851.891481085404, 10855.240133190917, 10879.782404352027, 33622.0, 33749.156271093416, 34269.657303427644, 34572.0, 35834.4624830633, 43302.56697432986, 43485.782571086944, 44599.10801784011, 44750.77624611856, 45912.31131533097, 14753.336099875745, 15083.095014299177, 15356.155411452477, 15383.1539265337, 15387.076775393512, 16200.351985920432, 16629.417970370978, 16898.0, 16943.23755430984, 17105.144742762564, 14939.17834519112, 14971.700565988402, 15125.773113403528, 15290.61773455628, 15305.923470382577, 13940.30298485092, 13980.0, 14001.0, 14094.436222550983, 14163.150210987375, 14725.190114543375, 14830.703385932437, 14971.401143954556, 14976.0, 15079.170645614158, 10948.726281843017, 12934.611961641165, 12967.675808104495, 13254.602361929157, 13361.331933403486, 12956.222626642431, 13472.191668499921, 13493.98071432851, 13515.59453216405, 13812.309384530934], "value": 8389.350927825644, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 109.0, 111.0, 112.0, 113.0, 109.0, 109.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 154.0, 191.0, 120.0, 142.0, 152.0, 126.0, 175.0, 123.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 162.0, 162.0, 165.0, 167.0, 179.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 190.0, 76.0, 76.0, 75.0, 76.0, 100.0, 76.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 82.0, 81.0, 82.0, 136.0, 82.0, 81.0, 141.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 151.0, 151.0, 152.0, 150.0, 148.0, 150.0, 150.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 53.0, 56.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 57.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 79.0, 78.0, 78.0, 86.0, 77.0, 77.0, 77.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 137.0, 130.0, 127.0, 131.0, 132.0, 124.0, 124.0, 152.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 183.0, 181.0, 184.0, 179.0, 182.0, 196.0, 182.0, 181.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 75.0, 69.0, 72.0, 72.0, 69.0, 78.0, 70.0, 69.0], "value": 71.7, "unit": "score"}]}]} 05:01:37 INFO - Return code: 0 05:01:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:01:37 INFO - # TBPL SUCCESS # 05:01:37 INFO - Running post-action listener: _package_coverage_data 05:01:37 INFO - Running post-action listener: _resource_record_post_action 05:01:37 INFO - [mozharness: 2017-07-11 12:01:37.378870Z] Finished run-tests step (success) 05:01:37 INFO - Running post-run listener: _resource_record_post_run 05:01:37 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 441864192; Read time: 24; Write time: 360080 05:01:37 INFO - TinderboxPrint: CPU usage
13.1% 05:01:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 05:01:37 INFO - TinderboxPrint: I/O write bytes / time
441,864,192 / 360,080 05:01:37 INFO - TinderboxPrint: CPU idle
8,270.0 (86.9%) 05:01:37 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 05:01:37 INFO - TinderboxPrint: Swap in / out
0 / 0 05:01:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 113881088; Read time: 0; Write time: 120064 05:01:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:01:37 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 327983104; Read time: 0; Write time: 240016 05:01:38 INFO - Running post-run listener: _upload_blobber_files 05:01:38 INFO - Blob upload gear active. 05:01:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:01:38 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:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:01:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:01:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:01:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:41 INFO - (blobuploader) - INFO - Done attempting. 05:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:01:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:01:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:42 INFO - (blobuploader) - INFO - Done attempting. 05:01:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:01:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:01:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:43 INFO - (blobuploader) - INFO - Done attempting. 05:01:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:01:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:01:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:44 INFO - (blobuploader) - INFO - Done attempting. 05:01:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:44 INFO - Return code: 0 05:01:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:01:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48d648cc8324b5bf001fb932a0e85731bb737099521b60e80ce8a0ac26560338dd9dbae1189ba58dff0c3e26ab94c39ee45cacca1a7c8db309115e1791d1afac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc64977bb346cb258ba34d38fad33c3b430f292dc5437742845ca14d0655f6f8182a53bc26bb6e07453781eccdf97e4876265396bcf5ebad1cba1f505c34b987", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18a29f9ad9862fe372326ce600c178d560e07f919557f4feff2f93a789c21fd1d143089cdca2266b101b0f14b7c71865ada67949d52a593b7507ddb25ff91e1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce24a591915cd9eebfa72c44be4b5811637cbf68a7d7dd310771c77ce006bf78ba4b64a9f2203eb5076ac482754fdbeef1878b949948112dc14afcd5c391e44e"} 05:01:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:01:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:01:44 INFO - Contents: 05:01:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48d648cc8324b5bf001fb932a0e85731bb737099521b60e80ce8a0ac26560338dd9dbae1189ba58dff0c3e26ab94c39ee45cacca1a7c8db309115e1791d1afac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc64977bb346cb258ba34d38fad33c3b430f292dc5437742845ca14d0655f6f8182a53bc26bb6e07453781eccdf97e4876265396bcf5ebad1cba1f505c34b987", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18a29f9ad9862fe372326ce600c178d560e07f919557f4feff2f93a789c21fd1d143089cdca2266b101b0f14b7c71865ada67949d52a593b7507ddb25ff91e1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce24a591915cd9eebfa72c44be4b5811637cbf68a7d7dd310771c77ce006bf78ba4b64a9f2203eb5076ac482754fdbeef1878b949948112dc14afcd5c391e44e"} 05:01:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:01:44 INFO - Copying logs to upload dir... 05:01:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:01:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.981132 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-11 05:01:43.789445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-11 05:01:43.793401) ========= 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=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48d648cc8324b5bf001fb932a0e85731bb737099521b60e80ce8a0ac26560338dd9dbae1189ba58dff0c3e26ab94c39ee45cacca1a7c8db309115e1791d1afac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc64977bb346cb258ba34d38fad33c3b430f292dc5437742845ca14d0655f6f8182a53bc26bb6e07453781eccdf97e4876265396bcf5ebad1cba1f505c34b987", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18a29f9ad9862fe372326ce600c178d560e07f919557f4feff2f93a789c21fd1d143089cdca2266b101b0f14b7c71865ada67949d52a593b7507ddb25ff91e1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce24a591915cd9eebfa72c44be4b5811637cbf68a7d7dd310771c77ce006bf78ba4b64a9f2203eb5076ac482754fdbeef1878b949948112dc14afcd5c391e44e"} build_url:https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/WVdPpzIcS7G9M8yUkSwEXA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48d648cc8324b5bf001fb932a0e85731bb737099521b60e80ce8a0ac26560338dd9dbae1189ba58dff0c3e26ab94c39ee45cacca1a7c8db309115e1791d1afac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc64977bb346cb258ba34d38fad33c3b430f292dc5437742845ca14d0655f6f8182a53bc26bb6e07453781eccdf97e4876265396bcf5ebad1cba1f505c34b987", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18a29f9ad9862fe372326ce600c178d560e07f919557f4feff2f93a789c21fd1d143089cdca2266b101b0f14b7c71865ada67949d52a593b7507ddb25ff91e1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce24a591915cd9eebfa72c44be4b5811637cbf68a7d7dd310771c77ce006bf78ba4b64a9f2203eb5076ac482754fdbeef1878b949948112dc14afcd5c391e44e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-11 05:01:43.817722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 05:01:43.818063) ========= 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=cbe409c6de289db6ac707de3000001d4-1499771543.880226-1522073471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-11 05:01:43.901045) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-11 05:01:43.901367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-11 05:01:43.901649) ========= ========= Total master_lag: 0.16 =========