builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1500080214.37 results: success (0) revision: bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.369224) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.370005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.370293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.436203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.436463) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-14 17:56:54-- 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% 71.4M=0s 2017-07-14 17:56:54 (71.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118775 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.581347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.581634) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:54.633696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-14 17:56:54.634016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c --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 bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c --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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-14 17:56:54,920 truncating revision to first 12 chars 2017-07-14 17:56:54,921 Setting DEBUG logging. 2017-07-14 17:56:54,921 attempt 1/10 2017-07-14 17:56:54,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bd1b6a4e5d8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-14 17:56:56,345 unpacking tar archive at: mozilla-central-bd1b6a4e5d8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.754263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-14 17:56:56.403178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:56.403467) ========= script_repo_revision: bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:56.403830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:56.404111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-14 17:56:56.411132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-14 17:56:56.411423) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:56:56 INFO - MultiFileLogger online at 20170714 17:56:56 in /builds/slave/test 17:56:56 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 17:56:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:56 INFO - {'append_to_log': False, 17:56:56 INFO - 'base_work_dir': '/builds/slave/test', 17:56:56 INFO - 'blob_upload_branch': 'Firefox', 17:56:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:56 INFO - 'branch': 'Firefox', 17:56:56 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:56 INFO - 'code_coverage': False, 17:56:56 INFO - 'config_files': ('talos/linux_config.py',), 17:56:56 INFO - 'default_actions': ('clobber', 17:56:56 INFO - 'read-buildbot-config', 17:56:56 INFO - 'download-and-extract', 17:56:56 INFO - 'populate-webroot', 17:56:56 INFO - 'create-virtualenv', 17:56:56 INFO - 'install', 17:56:56 INFO - 'setup-mitmproxy', 17:56:56 INFO - 'run-tests'), 17:56:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:56 INFO - 'disable_ccov_upload': False, 17:56:56 INFO - 'download_minidump_stackwalk': True, 17:56:56 INFO - 'download_symbols': 'ondemand', 17:56:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:56 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:56 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:56 INFO - 'gecko_profile': False, 17:56:56 INFO - 'gecko_profile_interval': 0, 17:56:56 INFO - 'installer_path': 'installer.exe', 17:56:56 INFO - 'log_level': 'info', 17:56:56 INFO - 'log_name': 'talos', 17:56:56 INFO - 'log_to_console': True, 17:56:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:56:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:56:56 INFO - 'opt_config_files': (), 17:56:56 INFO - 'pip_index': False, 17:56:56 INFO - 'suite': 'dromaeojs-e10s', 17:56:56 INFO - 'system_bits': '32', 17:56:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:56 INFO - 'title': 'talos-linux64-ix-067', 17:56:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:56 INFO - 'use_talos_json': True, 17:56:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:56 INFO - 'work_dir': 'build'} 17:56:56 INFO - [mozharness: 2017-07-15 00:56:56.797826Z] Running clobber step. 17:56:56 INFO - Running pre-action listener: _resource_record_pre_action 17:56:56 INFO - Running main action method: clobber 17:56:56 INFO - rmtree: /builds/slave/test/build 17:56:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:57 INFO - Running post-action listener: _resource_record_post_action 17:56:57 INFO - [mozharness: 2017-07-15 00:56:57.832393Z] Finished clobber step (success) 17:56:57 INFO - [mozharness: 2017-07-15 00:56:57.832495Z] Running read-buildbot-config step. 17:56:57 INFO - Running pre-action listener: _resource_record_pre_action 17:56:57 INFO - Running main action method: read_buildbot_config 17:56:57 INFO - Using buildbot properties: 17:56:57 INFO - { 17:56:57 INFO - "project": "", 17:56:57 INFO - "product": "firefox", 17:56:57 INFO - "who": "kwierso@gmail.com", 17:56:57 INFO - "installer_path": "public/build/target.tar.bz2", 17:56:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:56:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:56:57 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:56:57 INFO - "stage_platform": "linux64-stylosequential", 17:56:57 INFO - "basedir": "/builds/slave/test", 17:56:57 INFO - "buildnumber": 120, 17:56:57 INFO - "platform": "ubuntu64_hw_styloseq", 17:56:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:56:57 INFO - "slavebuilddir": "test", 17:56:57 INFO - "taskId": "eRwbN3g4R0mDgrmlw1ZJMQ", 17:56:57 INFO - "branch": "mozilla-central", 17:56:57 INFO - "script_repo_revision": "production", 17:56:57 INFO - "revision": "bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c", 17:56:57 INFO - "slavename": "talos-linux64-ix-067", 17:56:57 INFO - "repo_path": "mozilla-central" 17:56:57 INFO - } 17:56:57 INFO - Finding installer, test and symbols from parent task. 17:56:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRwbN3g4R0mDgrmlw1ZJMQ'}, attempt #1 17:56:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRwbN3g4R0mDgrmlw1ZJMQ'}, attempt #1 17:56:58 INFO - Task dependencies: WeCLI3UqQb2jhRhnWOcQ7A 17:56:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A'}, attempt #1 17:56:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 17:56:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/test_packages.json 17:56:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.crashreporter-symbols.zip 17:56:59 INFO - Running post-action listener: _resource_record_post_action 17:56:59 INFO - [mozharness: 2017-07-15 00:56:59.188428Z] Finished read-buildbot-config step (success) 17:56:59 INFO - [mozharness: 2017-07-15 00:56:59.188650Z] Running download-and-extract step. 17:56:59 INFO - Running pre-action listener: _resource_record_pre_action 17:56:59 INFO - Running main action method: download_and_extract 17:56:59 INFO - mkdir: /builds/slave/test/build/tests 17:56:59 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')]} 17:56:59 INFO - trying https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.test_packages.json 17:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:56:59 INFO - Downloaded 989 bytes. 17:56:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:56:59 INFO - Using the following test package requirements: 17:56:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:56:59 INFO - u'common': [u'target.common.tests.zip'], 17:56:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:56:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:56:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:56:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:56:59 INFO - u'mozbase': [u'target.common.tests.zip'], 17:56:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:56:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:56:59 INFO - u'web-platform': [u'target.common.tests.zip', 17:56:59 INFO - u'target.web-platform.tests.tar.gz'], 17:56:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:56:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:56:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip 17:56:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:59 INFO - Fetch https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip into memory 17:57:02 INFO - Content-Length response header: 72753107 17:57:02 INFO - Bytes received: 72753107 17:57:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip 17:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.common.tests.zip into memory 17:57:15 INFO - Content-Length response header: 72753107 17:57:15 INFO - Bytes received: 72753107 17:57:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.talos.tests.zip 17:57:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:57:27 INFO - Fetch https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.talos.tests.zip into memory 17:57:28 INFO - Content-Length response header: 14495012 17:57:28 INFO - Bytes received: 14495012 17:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:28 INFO - trying https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 17:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:57:29 INFO - Downloaded 61853406 bytes. 17:57:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 17:57:29 INFO - mkdir: /builds/slave/test/properties 17:57:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:29 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:29 INFO - Contents: 17:57:29 INFO - build_url:https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 17:57:29 INFO - Running post-action listener: _resource_record_post_action 17:57:29 INFO - Running post-action listener: set_extra_try_arguments 17:57:29 INFO - [mozharness: 2017-07-15 00:57:29.916438Z] Finished download-and-extract step (success) 17:57:29 INFO - [mozharness: 2017-07-15 00:57:29.916536Z] Running populate-webroot step. 17:57:29 INFO - Running pre-action listener: _resource_record_pre_action 17:57:29 INFO - Running main action method: populate_webroot 17:57:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:29 INFO - '--tppagecycles', 17:57:29 INFO - '7'], 17:57:29 INFO - 'tests': ['tsvgm']}}, 17:57:29 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['damp', 'tps']}, 17:57:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'tests': ['damp', 'tps']}, 17:57:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['dromaeo_dom']}, 17:57:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:57:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:57:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:57:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_many_windows', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_many_windows', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_many_windows', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['a11yr', 17:57:29 INFO - 'ts_paint', 17:57:29 INFO - 'tpaint', 17:57:29 INFO - 'sessionrestore', 17:57:29 INFO - 'sessionrestore_no_auto_restore', 17:57:29 INFO - 'tabpaint']}, 17:57:29 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:57:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:57:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:57:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:57:29 INFO - 'talos_options': ['--mitmproxy', 17:57:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:57:29 INFO - '--firstNonBlankPaint'], 17:57:29 INFO - 'tests': ['quantum_pageload_google', 17:57:29 INFO - 'quantum_pageload_youtube', 17:57:29 INFO - 'quantum_pageload_amazon', 17:57:29 INFO - 'quantum_pageload_facebook']}, 17:57:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['tsvgx', 17:57:29 INFO - 'tsvgr_opacity', 17:57:29 INFO - 'tart', 17:57:29 INFO - 'tscrollx', 17:57:29 INFO - 'cart', 17:57:29 INFO - 'tsvg_static']}, 17:57:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:29 INFO - 'tsvgr_opacity', 17:57:29 INFO - 'tart', 17:57:29 INFO - 'tscrollx', 17:57:29 INFO - 'cart', 17:57:29 INFO - 'tsvg_static']}, 17:57:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'talos_options': ['--disable-e10s'], 17:57:29 INFO - 'tests': ['tp5o']}, 17:57:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:57:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'talos_options': ['--disable-e10s', 17:57:29 INFO - '--xperf_path', 17:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:29 INFO - 'tests': ['tp5n']}, 17:57:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:57:29 INFO - 'talos_options': ['--xperf_path', 17:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:29 INFO - 'tests': ['tp5n']}}, 17:57:29 INFO - 'talos.zip': {'path': '', 17:57:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:29 INFO - Running post-action listener: _resource_record_post_action 17:57:29 INFO - [mozharness: 2017-07-15 00:57:29.931736Z] Finished populate-webroot step (success) 17:57:29 INFO - [mozharness: 2017-07-15 00:57:29.931827Z] Running create-virtualenv step. 17:57:29 INFO - Running pre-action listener: _resource_record_pre_action 17:57:29 INFO - Running main action method: create_virtualenv 17:57:29 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:29 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 17:57:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:57:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:30 INFO - Using real prefix '/usr' 17:57:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:30 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:32 INFO - Installing pip.................done. 17:57:32 INFO - Return code: 0 17:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:57:32 INFO - Reading from file tmpfile_stdout 17:57:32 INFO - Output received: 17:57:32 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) 17:57:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:32 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')]} 17:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:32 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')]} 17:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:32 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:32 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 17:57:32 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 17:57:32 INFO - Using env: {'DISPLAY': ':0', 17:57:32 INFO - 'HOME': '/home/cltbld', 17:57:32 INFO - 'LANG': 'en_US.UTF-8', 17:57:32 INFO - 'LANGUAGE': 'en_US:en', 17:57:32 INFO - 'LOGNAME': 'cltbld', 17:57:32 INFO - 'MAIL': '/var/mail/cltbld', 17:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:32 INFO - 'MOZ_NO_REMOTE': '1', 17:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:32 INFO - 'NO_EM_RESTART': '1', 17:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:32 INFO - 'PWD': '/builds/slave/test', 17:57:32 INFO - 'SHELL': '/bin/bash', 17:57:32 INFO - 'SHLVL': '1', 17:57:32 INFO - 'TERM': 'linux', 17:57:32 INFO - 'TMOUT': '86400', 17:57:32 INFO - 'USER': 'cltbld', 17:57:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:32 INFO - '_': '/tools/buildbot/bin/python'} 17:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:32 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 17:57:32 INFO - Cleaning up... 17:57:32 INFO - Return code: 0 17:57:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57:32 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')]} 17:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:32 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')]} 17:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:32 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:32 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 17:57:32 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 17:57:32 INFO - Using env: {'DISPLAY': ':0', 17:57:32 INFO - 'HOME': '/home/cltbld', 17:57:32 INFO - 'LANG': 'en_US.UTF-8', 17:57:32 INFO - 'LANGUAGE': 'en_US:en', 17:57:32 INFO - 'LOGNAME': 'cltbld', 17:57:32 INFO - 'MAIL': '/var/mail/cltbld', 17:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:32 INFO - 'MOZ_NO_REMOTE': '1', 17:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:32 INFO - 'NO_EM_RESTART': '1', 17:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:32 INFO - 'PWD': '/builds/slave/test', 17:57:32 INFO - 'SHELL': '/bin/bash', 17:57:32 INFO - 'SHLVL': '1', 17:57:32 INFO - 'TERM': 'linux', 17:57:32 INFO - 'TMOUT': '86400', 17:57:32 INFO - 'USER': 'cltbld', 17:57:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:32 INFO - '_': '/tools/buildbot/bin/python'} 17:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:33 INFO - Downloading/unpacking psutil>=3.1.1 17:57: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 17:57: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 17:57: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 17:57: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 17:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:34 INFO - Installing collected packages: psutil 17:57:34 INFO - Running setup.py install for psutil 17:57:34 INFO - building 'psutil._psutil_linux' extension 17:57:34 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 17:57:34 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 17:57:34 INFO - building 'psutil._psutil_posix' extension 17:57:34 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 17:57:34 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 17:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:34 INFO - Successfully installed psutil 17:57:34 INFO - Cleaning up... 17:57:34 INFO - Return code: 0 17:57:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:34 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:34 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 17:57:34 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 17:57:34 INFO - Using env: {'DISPLAY': ':0', 17:57:34 INFO - 'HOME': '/home/cltbld', 17:57:34 INFO - 'LANG': 'en_US.UTF-8', 17:57:34 INFO - 'LANGUAGE': 'en_US:en', 17:57:34 INFO - 'LOGNAME': 'cltbld', 17:57:34 INFO - 'MAIL': '/var/mail/cltbld', 17:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:34 INFO - 'MOZ_NO_REMOTE': '1', 17:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:34 INFO - 'NO_EM_RESTART': '1', 17:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:34 INFO - 'PWD': '/builds/slave/test', 17:57:34 INFO - 'SHELL': '/bin/bash', 17:57:34 INFO - 'SHLVL': '1', 17:57:34 INFO - 'TERM': 'linux', 17:57:34 INFO - 'TMOUT': '86400', 17:57:34 INFO - 'USER': 'cltbld', 17:57:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:34 INFO - '_': '/tools/buildbot/bin/python'} 17:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:57:35 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 17:57:35 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 17:57:35 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 17:57:35 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 17:57:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:57:37 INFO - Installing collected packages: mozsystemmonitor 17:57:37 INFO - Running setup.py install for mozsystemmonitor 17:57:37 INFO - Successfully installed mozsystemmonitor 17:57:37 INFO - Cleaning up... 17:57:37 INFO - Return code: 0 17:57:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57: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')]} 17:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:37 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:37 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 17:57:37 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 17:57:37 INFO - Using env: {'DISPLAY': ':0', 17:57:37 INFO - 'HOME': '/home/cltbld', 17:57:37 INFO - 'LANG': 'en_US.UTF-8', 17:57:37 INFO - 'LANGUAGE': 'en_US:en', 17:57:37 INFO - 'LOGNAME': 'cltbld', 17:57:37 INFO - 'MAIL': '/var/mail/cltbld', 17:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:37 INFO - 'MOZ_NO_REMOTE': '1', 17:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:37 INFO - 'NO_EM_RESTART': '1', 17:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:37 INFO - 'PWD': '/builds/slave/test', 17:57:37 INFO - 'SHELL': '/bin/bash', 17:57:37 INFO - 'SHLVL': '1', 17:57:37 INFO - 'TERM': 'linux', 17:57:37 INFO - 'TMOUT': '86400', 17:57:37 INFO - 'USER': 'cltbld', 17:57:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:37 INFO - '_': '/tools/buildbot/bin/python'} 17:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:37 INFO - Downloading/unpacking jsonschema==2.5.1 17:57:37 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 17:57:37 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 17:57:37 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 17:57:37 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 17:57:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:57:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:57: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 17:57: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 17:57: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 17:57: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 17:57:38 INFO - Downloading functools32-3.2.3-2.tar.gz 17:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:57:38 INFO - warning: no files found matching '*.txt' 17:57:38 INFO - no previously-included directories found matching 'build' 17:57:38 INFO - no previously-included directories found matching 'dist' 17:57:38 INFO - no previously-included directories found matching '.git*' 17:57:38 INFO - Installing collected packages: jsonschema, functools32 17:57:38 INFO - Running setup.py install for functools32 17:57:39 INFO - warning: no files found matching '*.txt' 17:57:39 INFO - no previously-included directories found matching 'build' 17:57:39 INFO - no previously-included directories found matching 'dist' 17:57:39 INFO - no previously-included directories found matching '.git*' 17:57:39 INFO - Successfully installed jsonschema functools32 17:57:39 INFO - Cleaning up... 17:57:39 INFO - Return code: 0 17:57:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:57:39 INFO - Using env: {'DISPLAY': ':0', 17:57:39 INFO - 'HOME': '/home/cltbld', 17:57:39 INFO - 'LANG': 'en_US.UTF-8', 17:57:39 INFO - 'LANGUAGE': 'en_US:en', 17:57:39 INFO - 'LOGNAME': 'cltbld', 17:57:39 INFO - 'MAIL': '/var/mail/cltbld', 17:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:39 INFO - 'MOZ_NO_REMOTE': '1', 17:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:39 INFO - 'NO_EM_RESTART': '1', 17:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:39 INFO - 'PWD': '/builds/slave/test', 17:57:39 INFO - 'SHELL': '/bin/bash', 17:57:39 INFO - 'SHLVL': '1', 17:57:39 INFO - 'TERM': 'linux', 17:57:39 INFO - 'TMOUT': '86400', 17:57:39 INFO - 'USER': 'cltbld', 17:57:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:39 INFO - '_': '/tools/buildbot/bin/python'} 17:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:57:39 INFO - Cleaning up... 17:57:39 INFO - Return code: 0 17:57:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:57:39 INFO - Using env: {'DISPLAY': ':0', 17:57:39 INFO - 'HOME': '/home/cltbld', 17:57:39 INFO - 'LANG': 'en_US.UTF-8', 17:57:39 INFO - 'LANGUAGE': 'en_US:en', 17:57:39 INFO - 'LOGNAME': 'cltbld', 17:57:39 INFO - 'MAIL': '/var/mail/cltbld', 17:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:39 INFO - 'MOZ_NO_REMOTE': '1', 17:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:39 INFO - 'NO_EM_RESTART': '1', 17:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:39 INFO - 'PWD': '/builds/slave/test', 17:57:39 INFO - 'SHELL': '/bin/bash', 17:57:39 INFO - 'SHLVL': '1', 17:57:39 INFO - 'TERM': 'linux', 17:57:39 INFO - 'TMOUT': '86400', 17:57:39 INFO - 'USER': 'cltbld', 17:57:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:39 INFO - '_': '/tools/buildbot/bin/python'} 17:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57: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 17:57: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 17:57: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 17:57: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 17:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57: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 17:57: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 17:57: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 17:57: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 17:57:41 INFO - Downloading docopt-0.6.1.tar.gz 17:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:41 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:41 INFO - Running setup.py install for blobuploader 17:57:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:41 INFO - Running setup.py install for requests 17:57:41 INFO - Running setup.py install for docopt 17:57:41 INFO - Successfully installed blobuploader requests docopt 17:57:41 INFO - Cleaning up... 17:57:41 INFO - Return code: 0 17:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:41 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')]} 17:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:41 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')]} 17:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:41 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:41 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 17:57:41 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 17:57:41 INFO - Using env: {'DISPLAY': ':0', 17:57:41 INFO - 'HOME': '/home/cltbld', 17:57:41 INFO - 'LANG': 'en_US.UTF-8', 17:57:41 INFO - 'LANGUAGE': 'en_US:en', 17:57:41 INFO - 'LOGNAME': 'cltbld', 17:57:41 INFO - 'MAIL': '/var/mail/cltbld', 17:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:41 INFO - 'MOZ_NO_REMOTE': '1', 17:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:41 INFO - 'NO_EM_RESTART': '1', 17:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:41 INFO - 'PWD': '/builds/slave/test', 17:57:41 INFO - 'SHELL': '/bin/bash', 17:57:41 INFO - 'SHLVL': '1', 17:57:41 INFO - 'TERM': 'linux', 17:57:41 INFO - 'TMOUT': '86400', 17:57:41 INFO - 'USER': 'cltbld', 17:57:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:41 INFO - '_': '/tools/buildbot/bin/python'} 17:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:42 INFO - Running setup.py (path:/tmp/pip-RTcsYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:42 INFO - Running setup.py (path:/tmp/pip-NJCaEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:42 INFO - Running setup.py (path:/tmp/pip-X3t5kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:42 INFO - Running setup.py (path:/tmp/pip-DZoJhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:42 INFO - Running setup.py (path:/tmp/pip-E_tA7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:42 INFO - Running setup.py (path:/tmp/pip-KxBXQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:42 INFO - Running setup.py (path:/tmp/pip-sBpmAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:42 INFO - Running setup.py (path:/tmp/pip-5p0xaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:42 INFO - Running setup.py (path:/tmp/pip-8BLCtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:42 INFO - Running setup.py (path:/tmp/pip-WL9V5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:42 INFO - Running setup.py (path:/tmp/pip-ahsLFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:42 INFO - Running setup.py (path:/tmp/pip-7OflYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:42 INFO - Running setup.py (path:/tmp/pip-YAWyJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:42 INFO - Running setup.py (path:/tmp/pip-CLS6W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:43 INFO - Running setup.py (path:/tmp/pip-CignJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:43 INFO - Running setup.py (path:/tmp/pip-vOFw8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:43 INFO - Running setup.py (path:/tmp/pip-FPWT1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:43 INFO - Running setup.py install for manifestparser 17:57:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:43 INFO - Running setup.py install for mozcrash 17:57:43 INFO - Running setup.py install for mozdebug 17:57:43 INFO - Running setup.py install for mozdevice 17:57:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:43 INFO - Running setup.py install for mozfile 17:57:43 INFO - Running setup.py install for mozhttpd 17:57:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:43 INFO - Running setup.py install for mozinfo 17:57:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:43 INFO - Running setup.py install for mozInstall 17:57:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Running setup.py install for mozleak 17:57:44 INFO - Running setup.py install for mozlog 17:57:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Running setup.py install for moznetwork 17:57:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Running setup.py install for mozprocess 17:57:44 INFO - Running setup.py install for mozprofile 17:57:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Running setup.py install for mozrunner 17:57:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:44 INFO - Running setup.py install for mozscreenshot 17:57:44 INFO - Running setup.py install for moztest 17:57:44 INFO - Running setup.py install for mozversion 17:57:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:45 INFO - Cleaning up... 17:57:45 INFO - Return code: 0 17:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:45 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:45 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 17:57:45 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 17:57:45 INFO - Using env: {'DISPLAY': ':0', 17:57:45 INFO - 'HOME': '/home/cltbld', 17:57:45 INFO - 'LANG': 'en_US.UTF-8', 17:57:45 INFO - 'LANGUAGE': 'en_US:en', 17:57:45 INFO - 'LOGNAME': 'cltbld', 17:57:45 INFO - 'MAIL': '/var/mail/cltbld', 17:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:45 INFO - 'MOZ_NO_REMOTE': '1', 17:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:45 INFO - 'NO_EM_RESTART': '1', 17:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:45 INFO - 'PWD': '/builds/slave/test', 17:57:45 INFO - 'SHELL': '/bin/bash', 17:57:45 INFO - 'SHLVL': '1', 17:57:45 INFO - 'TERM': 'linux', 17:57:45 INFO - 'TMOUT': '86400', 17:57:45 INFO - 'USER': 'cltbld', 17:57:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:45 INFO - '_': '/tools/buildbot/bin/python'} 17:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:45 INFO - Running setup.py (path:/tmp/pip-OkTvS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:45 INFO - Running setup.py (path:/tmp/pip-Y5yFRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:45 INFO - Running setup.py (path:/tmp/pip-tAh4Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:45 INFO - Running setup.py (path:/tmp/pip-mORmhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:45 INFO - Running setup.py (path:/tmp/pip-rMLwBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:45 INFO - Running setup.py (path:/tmp/pip-rQqJzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:45 INFO - Running setup.py (path:/tmp/pip-jYzCuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:45 INFO - Running setup.py (path:/tmp/pip-k4uZG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:45 INFO - Running setup.py (path:/tmp/pip-i01r96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:45 INFO - Running setup.py (path:/tmp/pip-UArJcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:45 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)) 17:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:45 INFO - Running setup.py (path:/tmp/pip-xU8Rp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:46 INFO - Running setup.py (path:/tmp/pip-Oy0o4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:46 INFO - Running setup.py (path:/tmp/pip-l0XX2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:46 INFO - Running setup.py (path:/tmp/pip-dm9gHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:46 INFO - Running setup.py (path:/tmp/pip-Z42fXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:46 INFO - Running setup.py (path:/tmp/pip-JMR410-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:46 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)) 17:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:46 INFO - Running setup.py (path:/tmp/pip-vgMUCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:46 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)) 17:57:46 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)) 17:57:46 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)) 17:57:46 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)) 17:57:46 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)) 17:57:46 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)) 17:57:46 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)) 17:57:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:47 INFO - Downloading blessings-1.6.tar.gz 17:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:47 INFO - Installing collected packages: blessings 17:57:47 INFO - Running setup.py install for blessings 17:57:47 INFO - Successfully installed blessings 17:57:47 INFO - Cleaning up... 17:57:47 INFO - Return code: 0 17:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:48 INFO - Reading from file tmpfile_stdout 17:57:48 INFO - Current package versions: 17:57:48 INFO - argparse == 1.2.1 17:57:48 INFO - blessings == 1.6 17:57:48 INFO - blobuploader == 1.2.4 17:57:48 INFO - docopt == 0.6.1 17:57:48 INFO - functools32 == 3.2.3-2 17:57:48 INFO - jsonschema == 2.5.1 17:57:48 INFO - manifestparser == 1.1 17:57:48 INFO - mozInstall == 1.13 17:57:48 INFO - mozcrash == 1.0 17:57:48 INFO - mozdebug == 0.1 17:57:48 INFO - mozdevice == 0.51 17:57:48 INFO - mozfile == 1.2 17:57:48 INFO - mozhttpd == 0.7 17:57:48 INFO - mozinfo == 0.10 17:57:48 INFO - mozleak == 0.1 17:57:48 INFO - mozlog == 3.5 17:57:48 INFO - moznetwork == 0.27 17:57:48 INFO - mozprocess == 0.25 17:57:48 INFO - mozprofile == 0.28 17:57:48 INFO - mozrunner == 6.13 17:57:48 INFO - mozscreenshot == 0.1 17:57:48 INFO - mozsystemmonitor == 0.3 17:57:48 INFO - moztest == 0.8 17:57:48 INFO - mozversion == 1.4 17:57:48 INFO - psutil == 3.1.1 17:57:48 INFO - requests == 1.2.3 17:57:48 INFO - wsgiref == 0.1.2 17:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:48 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')]} 17:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:48 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')]} 17:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:48 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 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:48 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 17:57:48 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 17:57:48 INFO - Using env: {'DISPLAY': ':0', 17:57:48 INFO - 'HOME': '/home/cltbld', 17:57:48 INFO - 'LANG': 'en_US.UTF-8', 17:57:48 INFO - 'LANGUAGE': 'en_US:en', 17:57:48 INFO - 'LOGNAME': 'cltbld', 17:57:48 INFO - 'MAIL': '/var/mail/cltbld', 17:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:48 INFO - 'MOZ_NO_REMOTE': '1', 17:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:48 INFO - 'NO_EM_RESTART': '1', 17:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:48 INFO - 'PWD': '/builds/slave/test', 17:57:48 INFO - 'SHELL': '/bin/bash', 17:57:48 INFO - 'SHLVL': '1', 17:57:48 INFO - 'TERM': 'linux', 17:57:48 INFO - 'TMOUT': '86400', 17:57:48 INFO - 'USER': 'cltbld', 17:57:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:48 INFO - '_': '/tools/buildbot/bin/python'} 17:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 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)) 17:57:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:57:48 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 17:57:48 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 17:57:48 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 17:57:48 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 17:57:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:57:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:57:49 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 17:57:49 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 17:57:49 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 17:57:49 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 17:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:57:49 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)) 17:57:49 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)) 17:57:49 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)) 17:57:49 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)) 17:57:49 INFO - Installing collected packages: marionette-driver, simplejson 17:57:49 INFO - Running setup.py install for marionette-driver 17:57:49 INFO - Running setup.py install for simplejson 17:57:49 INFO - building 'simplejson._speedups' extension 17:57:49 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 17:57:50 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 17:57:50 INFO - Successfully installed marionette-driver simplejson 17:57:50 INFO - Cleaning up... 17:57:50 INFO - Return code: 0 17:57:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', '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 17:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:57:50 INFO - Using env: {'DISPLAY': ':0', 17:57:50 INFO - 'HOME': '/home/cltbld', 17:57:50 INFO - 'LANG': 'en_US.UTF-8', 17:57:50 INFO - 'LANGUAGE': 'en_US:en', 17:57:50 INFO - 'LOGNAME': 'cltbld', 17:57:50 INFO - 'MAIL': '/var/mail/cltbld', 17:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:50 INFO - 'MOZ_NO_REMOTE': '1', 17:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:50 INFO - 'NO_EM_RESTART': '1', 17:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:50 INFO - 'PWD': '/builds/slave/test', 17:57:50 INFO - 'SHELL': '/bin/bash', 17:57:50 INFO - 'SHLVL': '1', 17:57:50 INFO - 'TERM': 'linux', 17:57:50 INFO - 'TMOUT': '86400', 17:57:50 INFO - 'USER': 'cltbld', 17:57:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:50 INFO - '_': '/tools/buildbot/bin/python'} 17:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:51 INFO - Cleaning up... 17:57:51 INFO - Return code: 0 17:57:51 INFO - Running post-action listener: _resource_record_post_action 17:57:51 INFO - Running post-action listener: _start_resource_monitoring 17:57:51 INFO - Starting resource monitoring. 17:57:51 INFO - [mozharness: 2017-07-15 00:57:51.073665Z] Finished create-virtualenv step (success) 17:57:51 INFO - [mozharness: 2017-07-15 00:57:51.074176Z] Running install step. 17:57:51 INFO - Running pre-action listener: _resource_record_pre_action 17:57:51 INFO - Running main action method: install 17:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:51 INFO - Reading from file tmpfile_stdout 17:57:51 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:51 INFO - Reading from file tmpfile_stdout 17:57:51 INFO - Output received: 17:57:51 INFO - Usage: mozinstall [options] installer 17:57:51 INFO - Options: 17:57:51 INFO - -h, --help show this help message and exit 17:57:51 INFO - -d DEST, --destination=DEST 17:57:51 INFO - Directory to install application into. [default: 17:57:51 INFO - "/builds/slave/test"] 17:57:51 INFO - --app=APP Application being installed. [default: firefox] 17:57:51 INFO - mkdir: /builds/slave/test/build/application 17:57:51 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'] 17:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:58:09 INFO - Reading from file tmpfile_stdout 17:58:09 INFO - Output received: 17:58:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:58:09 INFO - Running post-action listener: _resource_record_post_action 17:58:09 INFO - [mozharness: 2017-07-15 00:58:09.337516Z] Finished install step (success) 17:58:09 INFO - [mozharness: 2017-07-15 00:58:09.337860Z] Running setup-mitmproxy step. 17:58:09 INFO - Running pre-action listener: _resource_record_pre_action 17:58:09 INFO - Running main action method: setup_mitmproxy 17:58:09 INFO - Skipping: mitmproxy is not required 17:58:09 INFO - Running post-action listener: _resource_record_post_action 17:58:09 INFO - [mozharness: 2017-07-15 00:58:09.339476Z] Finished setup-mitmproxy step (success) 17:58:09 INFO - [mozharness: 2017-07-15 00:58:09.339806Z] Running run-tests step. 17:58:09 INFO - Running pre-action listener: _resource_record_pre_action 17:58:09 INFO - Running pre-action listener: _set_gcov_prefix 17:58:09 INFO - Running main action method: run_tests 17:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:58:09 INFO - Python 2.7.3 17:58:09 INFO - Return code: 0 17:58:09 INFO - grabbing minidump binary from tooltool 17:58:09 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')]} 17:58:09 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 0xeb52a0>, '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 0xeb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb04d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:58:09 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 17:58:09 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 17:58:09 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 17:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:58:09 INFO - Return code: 0 17:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:58:09 INFO - ENV: RUST_BACKTRACE is now 1 17:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:58:09 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/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:58:09 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/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 17:58:09 INFO - Using env: {'DISPLAY': ':0', 17:58:09 INFO - 'HOME': '/home/cltbld', 17:58:09 INFO - 'LANG': 'en_US.UTF-8', 17:58:09 INFO - 'LANGUAGE': 'en_US:en', 17:58:09 INFO - 'LOGNAME': 'cltbld', 17:58:09 INFO - 'MAIL': '/var/mail/cltbld', 17:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:09 INFO - 'MOZ_NO_REMOTE': '1', 17:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:09 INFO - 'NO_EM_RESTART': '1', 17:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:09 INFO - 'PWD': '/builds/slave/test', 17:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:09 INFO - 'RUST_BACKTRACE': '1', 17:58:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:58:09 INFO - 'SHELL': '/bin/bash', 17:58:09 INFO - 'SHLVL': '1', 17:58:09 INFO - 'TERM': 'linux', 17:58:09 INFO - 'TMOUT': '86400', 17:58:09 INFO - 'USER': 'cltbld', 17:58:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765', 17:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:09 INFO - '_': '/tools/buildbot/bin/python'} 17:58:09 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/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:58:09 INFO - mozversion application_buildid: 20170715001454 17:58:09 INFO - mozversion application_changeset: bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c 17:58:09 INFO - mozversion application_display_name: Nightly 17:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:58:09 INFO - mozversion application_name: Firefox 17:58:09 INFO - mozversion application_remotingname: firefox 17:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:58:09 INFO - mozversion application_vendor: Mozilla 17:58:09 INFO - mozversion application_version: 56.0a1 17:58:09 INFO - mozversion platform_buildid: 20170715001454 17:58:09 INFO - mozversion platform_changeset: bd1b6a4e5d8e1184a89ae60a74fd86d3d4a9e95c 17:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:58:09 INFO - mozversion platform_version: 56.0a1 17:58:09 INFO - using testdate: 1500080289 17:58:09 INFO - actual date: 1500080289 17:58:09 INFO - starting webserver on 'localhost:46697' 17:58:09 INFO - SUITE-START | Running 2 tests 17:58:09 INFO - TEST-START | dromaeo_css 17:58:09 INFO - Initialising browser for dromaeo_css test... 17:58:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46697/getInfo.html -profile /tmp/tmpeoilxO/profile 17:58:09 INFO - TEST-INFO | started process 29907 (/builds/slave/test/build/application/firefox/firefox http://localhost:46697/getInfo.html) 17:58:15 INFO - TEST-INFO | 29907: exit 0 17:58:15 INFO - Browser initialized. 17:58:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:58:15 INFO - TEST-INFO | started process 30128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeoilxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:26 INFO - PID 30128 | RSS: Main: 170057728 17:58:26 INFO - PID 30128 | 18:01:25 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46697/tests/dromaeo/cssquery-ext.html) 18:01:27 INFO - PID 30128 | RSS: Main: 178372608 18:01:27 INFO - PID 30128 | 18:04:29 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-ext.html (next: http://localhost:46697/tests/dromaeo/cssquery-jquery.html) 18:04:29 INFO - PID 30128 | RSS: Main: 176648192 18:04:29 INFO - PID 30128 | 18:07:31 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46697/tests/dromaeo/cssquery-mootools.html) 18:07:32 INFO - PID 30128 | RSS: Main: 179081216 18:07:32 INFO - PID 30128 | 18:10:33 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46697/tests/dromaeo/cssquery-prototype.html) 18:10:34 INFO - PID 30128 | RSS: Main: 176910336 18:10:34 INFO - PID 30128 | 18:13:37 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46697/tests/dromaeo/cssquery-yui.html) 18:13:38 INFO - PID 30128 | RSS: Main: 176746496 18:13:38 INFO - PID 30128 | 18:16:39 INFO - PID 30128 | Cycle 1(1): loaded http://localhost:46697/tests/dromaeo/cssquery-yui.html (next: http://localhost:46697/tests/dromaeo/cssquery-dojo.html) 18:16:40 INFO - PID 30128 | RSS: Main: 180305920 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | __start_tp_report 18:16:40 INFO - PID 30128 | _x_x_mozilla_page_load 18:16:40 INFO - PID 30128 | _x_x_mozilla_page_load_details 18:16:40 INFO - PID 30128 | |i|pagename|runs| 18:16:40 INFO - PID 30128 | |0;dojo.html;3065.4175706615756;3094.8143111413315;3102.9844850775744;3120.110768430999;3121.5785868907697;5958.897603943268;6012.428819262169;6024.457798798107;6059.575829691923;6070.696465176746;6020.969895150529;6035.54733394996;6066.241719785027;6100.328963813977;6124.356942521038;5593.188987596796;5680.943190568103;5697.6866272355;5728.513076388512;5753.626014309057;5700.6579605223615;5705.4579814917515;5705.543556515489;5805.448482394187;5811.506021988136;5439.374471935699;5594.468525490072;5610.49505544503;5687.544996400278;5691.345495268056;5557.749901254413;5560.721963901829;5568.276124103841;5571.387147413781;5573.359063707685;5466.043442397565;5501.284832971728;5505.807296744595;5523.475269849358;5542.889142217174;6006.699665016732;6021.458068773788;6031.909521357139;6032.914075466414;6033.788817391414;6463.095166676669;6480;6514.250861150981;6520.771772987922;6525.902111468332;6551.475881929434;6594.901076483857;6602.504812139109;6603.900941485882;6604.900926486107;6033.9396606033815;6116.602420842675;6121.418465245794;6135.355787642278;6143.262808462969;6721.563098398588;6747.426468750113;6815.250322464574;6851.109355783717;6860.5540639858245;6371.203599550056;6402.423781859655;6510.283868774431;6515.4787616990525;6542.214934207926;6370.617762934239;6485.6108633482145;6493.70778314977;6502.902456463157;6511.511636627272;6389.137466442064;6433.388828061326;6471.352864713585;6475.417212450902;6513.120728701565;6362.586431881913;6488.772892948724;6532.41208291256;6610.107635469246;6614.603123812491;5332.466753324714;5336.146216605324;5416.91874621881;5421.512063914188;5422.783088676409;4523.095380923828;4571.177188106173;4583.037562111994;4615.723056616614;4666.69666471685;5663.830085097454;5666.631668941505;5679.858003549944;5681.2330335404195;5681.943180568224;6490.058941453557;6496.837579060467;6550.181227346582;6564.8358791030605;6662.167229096363;5674.716264186774;5726.455986681259;5782.132680098019;5797.565182611237;5820.82537523875;5811.535077193815;5823.068309070529;5883.352831188566;5914.9704251479325;5931.139984702194;6238.313785483593;6318.083877837687;6347.428731414103;6413.102165696806;6521.706523206467;6467.385598368148;6476.676166191766;6479.125318081999;6499.122618446449;6500.349965003462;6171;6243.375662433902;6245.531585131042;6273.905891411541;6282.3089460158435;6258.812235632939;6302.558820882494;6309.274433440213;6338.841528961629;6351.9047214290895;5607.010610104106;6422.518311126778;6655.301193374626;6672.666366681744;6720.899186512109;6425.61446313204;6432.807015789534;6492.610443373413;6529.085927969993;6529.444997175104;6385.706193916402;6423.293437721753;6517.934820651923;6529.934700652932;6535.57518761279;6145.262568491809;6240.843978900382;6305.369463053658;6360.777372792115;6384.489240860627;6148.354422785543;6368.652156360384;6492.837679058061;6507.089007539043;6544.181977252843;6129.601575897553;6172.382761723792;6179.0422484514975;6185.350538193605;6227.19046523949 18:16:40 INFO - PID 30128 | |1;ext.html;703.1456780012287;766.9463137580365;785.9017622797151;806.6894245715399;819.614781052905;41007.58992410075;41241.79379103104;41803.372949405784;41901.16197676045;41955;37801.81099094501;37989.43015854764;38016;38072;38084.04789880254;6777.051212830208;6893.069435626201;6898.103246577938;6906;6908.06741089954;6861.794146175623;6889.34551217636;6961.234264230956;6984.231734509225;6996.930030699704;6988.930110698904;6990.825229369281;6995.475339349569;7007.229204787469;7016.859662806741;6858.965705171492;6883.277255888135;6904.965475172642;6918.238993710713;6925.58446493212;6195.132681424604;6219.533534984895;6233.2208473940755;6258.123862659231;6294.685265736694;33998.32003359943;34093.65906340929;34266.65733342685;34335.484967725504;34498;3375.831208439593;3409.437442821931;3431.673990970854;3536.5932917714276;3607.4769158472136;31828.522572161437;31927.840360798047;32027.83986080078;32088.679113208804;32268.35463290721;4956.677815941988;4959.280904268897;4992.326035985132;5000.199968005102;5129.358830146231;186132;188797.05601471904;189132;193341;195758;42407.575924240366;49285;50269.74865125651;50663.49336506661;50771.746141269796;52147.21779173316;52320.476795232324;52675.73662131742;52738.20892686613;52741.208881866034;16697;16798.66402671964;16810;16892.746608800877;16924.57688557796;14012.369443374868;14016.439342426393;14046.438142474186;14049.578512644433;14071.71856562863;14894.180820054784;14901.627459313604;14905.478308259158;15094.622634434227;15159.621009474851;5692.544596432275;5729.684867332254;5778.624389414675;5819.214406055213;5866.882662346729;980.5538479991586;983.1446641421866;988.3135903081403;1044.2742294105676;1046.5447530324334;22295.88852055762;22849.148053765184;23158.305250842503;23463.061477541047;23582.7641723584;1057.39728354837;1102.7573933734566;1113.1651261553834;1129.203911242572;1134.2230572058168;11978.221415608132;12158.878411215952;12356.578993415693;12358.382080895919;12445.739489676775;229318;230575;231840;231915;232040;48429.27356089662;48855;49000.264996025086;49076;49120;1454.5999850041323;1458.9927050364681;1501.8948673592743;1505.796717443153;1510.1316742872891;21764.017236655545;21987.765138642128;22723.204687836507;22929;22952.540949181257;37839.810800945816;38031.80984095062;38108;38170.809145954096;38236.617633823305;190045;190855;191223;191375.0431247835;191631;35358.823205883804;36431.817840910626;37533.06167345729;39048;39163;45743.85640358885;46962;46975.29537057015;47044.29433558431;47345;32146.517802232516;33482.99551013376;34167.31665366629;34212.14469638279;35276.82361588176;33458.16354591155;33834.83082584571;34269;34328.82835585806;34484.310313794085;38169.80915095407;38803.61196388113;38990.41514377343;39102;39189.41215881821;32166.51750223795;33494.16264593405;33614.49578256377;34029.82985085059;34231.31537369289;23192.198025537105;24027.399315016566;24533.14134005301;24680.506389872462;24689.753102468745 18:16:40 INFO - PID 30128 | |2;jquery.html;559.9216109744634;563.169325245263;566.8242844718137;575.4159528079;599.4125756758376;21710.674339884914;22813.885930570366;22826.543469130607;23001.309960701186;23088.191913283037;25797.484050319028;27858.16425507238;27979.440411191765;28052.85973570129;28158.577621335695;6596.241432235282;6778.983152527136;6779.72881084756;6781.050652908597;6792.796216113525;4032.5765794591584;5695.917775622639;6635.203775546941;6702.396784289413;6704.2625311215725;4852.393450818648;6566.376194261537;6642.634655093968;6672.232693240291;6695.096162018114;6622.9668851655915;6634.635095069769;6636.601803891782;6642.3025582313885;6662.333766623347;6182;6199.163112979735;6212.534059945522;6221.222347206599;6239.0329498927285;27873.86063069692;29739.553906691417;30461;30623.69376306253;30709.692903070907;1876.0807204469847;1924.2495426783566;1926.3257859749117;1928.113067988727;1930.758655168104;18521.073946302764;19194.712079318822;19256.711149332772;19261.9036904816;19283.614327713367;2260.864348139117;2290.7709229077127;2300.344401845466;2326;2424.5029768897334;131788;137499.31250343684;137868.31065844608;138033.99999999898;138571.30714346364;14527.85472145286;14594.197319147548;14839.480618178311;14981.625459363604;15512.84487155114;23119.07523699067;23139.190128345428;23309.41726456852;23409;23546.411339716302;9725;9894.158996485236;9985.450800205914;9998.80002399948;10136.138428233535;9109.27125829932;9221.123993220634;9221.400608960395;9234.399764015317;9445.102715242041;8917.821643567222;9092.772680682903;9243.815123697623;9320.487373194539;9422.670206542738;2789.4839454700946;2799.2861820236117;2817.4224284021725;2841.9857900710363;2864.584635227922;944.5796620503947;947.9620815167316;970.4856426094182;975.8194733974237;994.4629899853998;19516.31692890742;19645;19782.30761923326;20072.49818754543;23973.880130599584;1007.5214273220162;1016.7102375822855;1040.6097713357492;1058.3596923861107;1065.6909496246158;10975.50610222542;11094.446777451163;11107.166962477846;11121.55513779456;11126.41281145795;447125;455441;459571;460407;465435;114562.42718786353;115925.99999999831;115950;117591.41204293924;118117;1208.0999655256715;1295.6848798469373;1317.7232781116072;1319.7888337865895;1333.953311634088;20455.4886127848;20572;21692.783072169077;21732.239371621916;21806.672899906833;55897.44102559085;56211.156832646724;56798;58185;60845.695771520855;66393.33606663872;67147.66426167838;70751.29248707448;70914.64542677253;71931.64034179796;14945.178015209269;15284.31220595098;15292.158931258442;15377.538673839803;15501.30244139039;18925.526861828563;19776.40670779879;19870.90064549668;22250.443738906655;23799;17957.551061223574;18473.44579662612;18706.812931870507;19164.616707666046;19226.711599325743;16013.919930400274;17114.743278851078;17183.054931978862;17744.91127544354;17922.283108675507;19108.713369299192;19401.2239510418;19696.60606787885;19711.112999915324;19714.112864920826;14597.197154156198;14597.92701036488;14671.486497972519;14696.191709455656;14891.851081489047;18110.637787244446;18673.71989420187;18824.15291311867;18954;19037.52406189801 18:16:40 INFO - PID 30128 | |3;mootools.html;1346.2528296795278;1383.9100458470205;1386.9722605547888;1394.6164804678713;1406.2757679794904;13234.801477977839;13602.979776516751;13850.930745346272;13900.791488127687;13934.163950162998;13423.523412424625;14353.35409906554;14400.06399584029;14455.710885782304;14467;2562.320984938988;2622.89508419663;2624.553825849601;2625.0681008242086;2628.040765120736;2538.6445897574263;2607.296030071889;2607.634931109646;2611.451595165018;2621.1350254416093;2566.948661026778;2577.5231582157267;2580.458103798195;2610.164747280871;2611.386324213808;2461.507698460315;2493.675822143128;2508.2099138771227;2508.41052352697;2509.8619575923317;2438.036975394727;2454.006127518358;2454.0919859652045;2475.9133430329853;2483.242611003643;13280.46878124874;13550.119242249222;13565.864341356657;13579.049466537248;13593.388297526635;7112.502124851262;7409.8518029639645;7464.365528930048;7490.925090749077;7519.774406767806;4569.771511424416;4690.81236750533;4766.237402015661;4773.594244489223;4842.370491836039;1770.3361239535175;1783.8850718301062;1801.2884910460295;1835.7521734565796;1838.7609610750517;20292.391228263175;21065.789342106535;21924.671129933064;22159.224427145135;22350.66474002891;5632;5815.912761308584;6510.446612037935;6692.297308782605;6791.4227290679855;17387.82612173862;17746.911265443847;17778.5555361117;17790.91104544469;17816;7116.323949224816;7594.202608726115;7603.125640551408;7647.197044310378;7670.463067585216;6838.794836154923;6925.168979722465;6932;6957.82605434858;7007.229204787469;5252;5322.707251101149;5323.068463018956;5381.30043094403;5450.345958485007;1639.7786298849742;1648.5384092454133;1656.9420070297722;1665.7168281392192;1684.115839184438;894.1952242981239;901.8557030875029;919.2783664823082;927.6984979881565;940.6801687426308;7030.718771249195;7158.749443769443;7181.425485961111;7186.7125314986815;7235.167955685059;732.1177980533445;734.6216698400328;743.6988019851968;745.7799949015053;753.5591678867924;4373.759443230653;4882.194437917775;5041.067402530543;5084.3898732152375;5168.328117344721;17357.13214339278;17508.912455437643;17705.468835934942;18437.7234341485;18650.067496625114;17502.29990800379;17544.736828947574;17805;17836.19737111833;17950.91024544869;10095.545700443497;10098.899011009942;10161;10324.535395907053;10501.789964200825;7421.777346679608;7940.325072368682;8181.5500147490075;8311.501309921425;8453.154684531497;15391.69216615639;15484.225788710293;16118.113503757406;16192.271347789143;16228.837711622733;15604.531864044096;16153.67692646117;16166;16209.837901620833;16714.247858846138;11156.219064665396;11419.14356423255;11421.14341424413;11427.142964277878;11466.369349685847;12314.445849936596;12546;12712.745745084861;12720.872791272339;12762.106652534234;9980.401175929177;10160.847587286344;10416.32293900894;10522.473876306307;10661.786764264827;9938.801223975335;9947.353422027834;9980;10241.948790256001;10276.434796086287;8093.595320233847;9043.864342034743;9077.228435582785;9101.908980910372;9134.543272836465;6613.834654133492;6684.4318232950745;6730.764423245163;6802.013708012211;6808.455323574201;7049.647517623996;7217;7242.239564845826;7309.122905251404;7319.780406587811 18:16:40 INFO - PID 30128 | |4;prototype.html;492.7278987773945;498.3997701217759;514.064402786928;519.6466402846065;523.4660646140936;6029.487493563047;6087.665178415185;6125.448709616134;6128.724207410666;6157.138000679908;5803.825885223439;5915.674637894914;5953.553483488734;5962.761489540413;6014.849628759283;4832.516748325157;4860.781264843073;4875.512448755132;4881.463039065718;4909.607231421478;4809.855704328876;4817.566419022287;4858.927116093261;4860.781264843091;4920.926186107194;4760.11937791508;4769;4774.116788394141;4806.471288158317;4842.152623290927;4544.545545445446;4765.523447655241;4774.472168905952;4828.637852161084;4878.658493905428;4387.561243875619;4397.31841564558;4399.724080016791;4412.426384570017;4421.182081314967;5814.418558144194;5835.620684655484;5863.794767183171;5866.413358664142;5893.821235752824;5534.280543529356;5579.358373787026;5614.550835933156;5623.915641265385;5636.971815140939;6264.248290205159;6299.9835157425005;6302.590331628476;6318.210223722035;6318.241810982666;4785.947091639834;4828.903421931542;4830.855074347775;4839.854804355875;4853.174960256765;6532.477401807844;6691.397774200296;6703.664816759143;6745.392914637657;6747.898781518281;4909.189983652657;4922.8769280768265;4925.532074452921;4941.50584941503;4989.800407983713;4948.134076536592;4963.10664080469;4965.659271996541;5004.374453193351;5074.13739664258;5364.6512976656395;5502.5597952163735;5537.141743029837;5544.944550554524;5607.7476513556985;6344.524160687967;6429.54993150475;6433.65728133508;6446.548741588043;6482.578632388974;1721.63845592427;1752.3866646673816;1754.2106052276272;1757.3761314733085;1757.4815429448342;1135.2450620337547;1223.7858374784378;1227.6317104868504;1233.4018001269378;1243.104964425612;5464.169503216388;5559.666420014732;5569.136783798518;5578.721063946868;5599.160125981054;6565.277819439858;6574.474042076622;6591.6374599397495;6595.581949880799;6660.200775906922;5525.364583072917;5593.210172744764;5624.971875140598;5647.887042259132;5719.742611582489;3432.467967465047;3433;3445.6554344565343;3480.9477857832153;3491.860325586999;6349.301576826545;6363.840903977438;6386.882295598251;6400.423961843363;6409.743610255631;6577;6712.83217919556;6730.663466826639;6785.457163426914;6851.177858656993;6331.778387756406;6426.967865160737;6451.838704032437;6455.838604034842;6457.192850893638;6496.740130394731;6500.609963402211;6552.705128269144;6561;6587.670616469253;6478.514111441755;6482.222133344029;6565.343465653396;6577.2436169841085;6586.80239592813;6226.40849119333;6335.65153916539;6346.777862774781;6380.170577824853;6383.329750376143;4878.707277563358;4886.609071274218;4893.877653058702;4901.50984901507;4910.558049775537;6495.642739649365;6556.704948277244;6568.573042752206;6569.408753212234;6595.87870062081;6412.166418365583;6426.196725409324;6433.710483028181;6473.546851720523;6479.611223326616;6403.551751377358;6410.45511131559;6422.550421470452;6436.0989461476365;6460.4508616766225;6284.780032698834;6286.779962701284;6298.527610429328;6340.207474065742;6347.270063942706;5864.24380541145;6366.522510811615;6381.85126677184;6383.170187875547;6405.167328247298;6086.60437071589;6159.599626024474;6179.382061793965;6191.288001879841;6214.9067763984485 18:16:40 INFO - PID 30128 | |5;yui.html;884.2218847414271;893.2184338703635;896.2292428511479;917.2799352508279;919.1222382624594;17011.404600838956;17959;18437.907810460947;18793.812061879376;18829.90585047076;19643.214271429162;21196.470088247803;21267.361979140613;21343.57312853742;21377.465563360925;1020.8877023527406;1054.1830081686717;1056.434807378053;1056.651305069329;1057.1912486947454;1062.6333914799382;1066.4934156275747;1067.8718553773558;1068.2415485005656;1069.1500257295468;785.6464590934074;810.3436216664492;1075.8171110911126;1110.9611163609275;1124.9100071994262;1110.0786347331696;1112.3492756737319;1112.6550769261514;1119.5577746790054;1121.6074373969045;816.9264766171013;820.6471217376526;821.3593397150232;821.4537332673765;825.8761185822175;18812.24751009958;19328.516787080294;19689.523285753625;19691.21235150592;19826.603467930705;19858.106385212555;20165.495862603406;20553.79446205534;20813;20831.583368332547;15155.772663410058;15489;15819.288132033971;15835;15850;3516.9648303517147;3548.591911930135;3556.1287484566187;3561.893143205708;3578.3380074686265;104770;105810;108188;111308;111375;15973.281202345923;16288.592785180464;16463.83536164647;16470.505884823473;16502.092384918706;27577.44845103087;29163.27091822679;29210.561841572395;29373.26566835846;29583.704162958096;8013.439059265912;8101.230383113595;8102.675892964216;8149.266566009088;8165.38759593021;3442.7417943654327;3608.45873119029;3616.5840928293055;3633.9091522711615;3970.10672598663;4951.801927922915;5046.596272298208;5096.490350964948;5119.232115182678;5120.769565369567;830.2154464031553;863.4473936680404;867.3061550759368;982.150439869522;985.0494273026563;652.3509108437136;665.9134312539339;706.0609389511936;711.2709472790431;726.5168662839153;11763.353015584225;12204.755904881853;12315.876841231653;12509.803725665479;12518.874811251771;686.5743239191634;693.7779910428615;704.0214102397671;704.844934114494;712.8574285142992;5491.890162196813;5545.473180047969;5552.500274975271;5577.442255774471;5619.915701264485;92513.53743231241;95237;97699;99350.5032474833;100915.49542252389;85235;86031;87759.56120219358;92300;93010;72063.2793672067;74392.25607743961;75585;75878.24121758711;77493.2250677486;10389.688309350731;10576.46641237001;10626.256162068581;10659.360438373722;10929.890701093205;33287.66712332846;34386.484202737476;34521;35122.64877351194;35951;61299;64814.67592662007;65293.347066528724;67119.99320010301;67605.66197168983;17515.737263940795;18248.817511824713;18632.627347453246;18731.906340468755;18748;19280.32518861833;19305.420837374902;19330.323438679578;19473.8052619472;19492.8050719491;18113.728294075336;18815.811841881405;18977;19055.52361190981;19548.022598869717;18563.35028274004;19549.21803127859;19563.706544402132;19610.705839412134;19650.312239071565;16739.163041848104;17405.65188696244;17618.559536011704;17749.911250443663;18523.536911577317;13381.19712817234;13742.175469471864;13777.380017899419;14133.787993180316;14449.78325325142;13818.239996800272;14120.43518259258;14220.786688199478;14461.49384771528;15073.170975596448 18:16:40 INFO - PID 30128 | __end_tp_report 18:16:40 INFO - PID 30128 | __start_cc_report 18:16:40 INFO - PID 30128 | _x_x_mozilla_cycle_collect,359 18:16:40 INFO - PID 30128 | __end_cc_report 18:16:40 INFO - PID 30128 | __startTimestamp1500081400209__endTimestamp 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | ------- Summary: start ------- 18:16:40 INFO - PID 30128 | Number of tests: 6 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#0] dojo.html Cycles:165 Average:6022.97 Median:6185.35 stddev:695.82 (11.2%) stddev-sans-first:658.13 18:16:40 INFO - PID 30128 | Values: 3065.4 3094.8 3103.0 3120.1 3121.6 5958.9 6012.4 6024.5 6059.6 6070.7 6021.0 6035.5 6066.2 6100.3 6124.4 5593.2 5680.9 5697.7 5728.5 5753.6 5700.7 5705.5 5705.5 5805.4 5811.5 5439.4 5594.5 5610.5 5687.5 5691.3 5557.7 5560.7 5568.3 5571.4 5573.4 5466.0 5501.3 5505.8 5523.5 5542.9 6006.7 6021.5 6031.9 6032.9 6033.8 6463.1 6480.0 6514.3 6520.8 6525.9 6551.5 6594.9 6602.5 6603.9 6604.9 6033.9 6116.6 6121.4 6135.4 6143.3 6721.6 6747.4 6815.3 6851.1 6860.6 6371.2 6402.4 6510.3 6515.5 6542.2 6370.6 6485.6 6493.7 6502.9 6511.5 6389.1 6433.4 6471.4 6475.4 6513.1 6362.6 6488.8 6532.4 6610.1 6614.6 5332.5 5336.1 5416.9 5421.5 5422.8 4523.1 4571.2 4583.0 4615.7 4666.7 5663.8 5666.6 5679.9 5681.2 5681.9 6490.1 6496.8 6550.2 6564.8 6662.2 5674.7 5726.5 5782.1 5797.6 5820.8 5811.5 5823.1 5883.4 5915.0 5931.1 6238.3 6318.1 6347.4 6413.1 6521.7 6467.4 6476.7 6479.1 6499.1 6500.3 6171.0 6243.4 6245.5 6273.9 6282.3 6258.8 6302.6 6309.3 6338.8 6351.9 5607.0 6422.5 6655.3 6672.7 6720.9 6425.6 6432.8 6492.6 6529.1 6529.4 6385.7 6423.3 6517.9 6529.9 6535.6 6145.3 6240.8 6305.4 6360.8 6384.5 6148.4 6368.7 6492.8 6507.1 6544.2 6129.6 6172.4 6179.0 6185.4 6227.2 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#1] ext.html Cycles:180 Average:37552.64 Median:19447.71 stddev:53162.86 (273.4%) stddev-sans-first:53239.99 18:16:40 INFO - PID 30128 | Values: 703.1 766.9 785.9 806.7 819.6 41007.6 41241.8 41803.4 41901.2 41955.0 37801.8 37989.4 38016.0 38072.0 38084.0 6777.1 6893.1 6898.1 6906.0 6908.1 6861.8 6889.3 6961.2 6984.2 6996.9 6988.9 6990.8 6995.5 7007.2 7016.9 6859.0 6883.3 6905.0 6918.2 6925.6 6195.1 6219.5 6233.2 6258.1 6294.7 33998.3 34093.7 34266.7 34335.5 34498.0 3375.8 3409.4 3431.7 3536.6 3607.5 31828.5 31927.8 32027.8 32088.7 32268.4 4956.7 4959.3 4992.3 5000.2 5129.4 186132.0 188797.1 189132.0 193341.0 195758.0 42407.6 49285.0 50269.7 50663.5 50771.7 52147.2 52320.5 52675.7 52738.2 52741.2 16697.0 16798.7 16810.0 16892.7 16924.6 14012.4 14016.4 14046.4 14049.6 14071.7 14894.2 14901.6 14905.5 15094.6 15159.6 5692.5 5729.7 5778.6 5819.2 5866.9 980.6 983.1 988.3 1044.3 1046.5 22295.9 22849.1 23158.3 23463.1 23582.8 1057.4 1102.8 1113.2 1129.2 1134.2 11978.2 12158.9 12356.6 12358.4 12445.7 229318.0 230575.0 231840.0 231915.0 232040.0 48429.3 48855.0 49000.3 49076.0 49120.0 1454.6 1459.0 1501.9 1505.8 1510.1 21764.0 21987.8 22723.2 22929.0 22952.5 37839.8 38031.8 38108.0 38170.8 38236.6 190045.0 190855.0 191223.0 191375.0 191631.0 35358.8 36431.8 37533.1 39048.0 39163.0 45743.9 46962.0 46975.3 47044.3 47345.0 32146.5 33483.0 34167.3 34212.1 35276.8 33458.2 33834.8 34269.0 34328.8 34484.3 38169.8 38803.6 38990.4 39102.0 39189.4 32166.5 33494.2 33614.5 34029.8 34231.3 23192.2 24027.4 24533.1 24680.5 24689.8 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#2] jquery.html Cycles:180 Average:34010.32 Median:23044.75 stddev:77543.51 (336.5%) stddev-sans-first:77720.37 18:16:40 INFO - PID 30128 | Values: 559.9 563.2 566.8 575.4 599.4 21710.7 22813.9 22826.5 23001.3 23088.2 25797.5 27858.2 27979.4 28052.9 28158.6 6596.2 6779.0 6779.7 6781.1 6792.8 4032.6 5695.9 6635.2 6702.4 6704.3 4852.4 6566.4 6642.6 6672.2 6695.1 6623.0 6634.6 6636.6 6642.3 6662.3 6182.0 6199.2 6212.5 6221.2 6239.0 27873.9 29739.6 30461.0 30623.7 30709.7 1876.1 1924.2 1926.3 1928.1 1930.8 18521.1 19194.7 19256.7 19261.9 19283.6 2260.9 2290.8 2300.3 2326.0 2424.5 131788.0 137499.3 137868.3 138034.0 138571.3 14527.9 14594.2 14839.5 14981.6 15512.8 23119.1 23139.2 23309.4 23409.0 23546.4 9725.0 9894.2 9985.5 9998.8 10136.1 9109.3 9221.1 9221.4 9234.4 9445.1 8917.8 9092.8 9243.8 9320.5 9422.7 2789.5 2799.3 2817.4 2842.0 2864.6 944.6 948.0 970.5 975.8 994.5 19516.3 19645.0 19782.3 20072.5 23973.9 1007.5 1016.7 1040.6 1058.4 1065.7 10975.5 11094.4 11107.2 11121.6 11126.4 447125.0 455441.0 459571.0 460407.0 465435.0 114562.4 115926.0 115950.0 117591.4 118117.0 1208.1 1295.7 1317.7 1319.8 1334.0 20455.5 20572.0 21692.8 21732.2 21806.7 55897.4 56211.2 56798.0 58185.0 60845.7 66393.3 67147.7 70751.3 70914.6 71931.6 14945.2 15284.3 15292.2 15377.5 15501.3 18925.5 19776.4 19870.9 22250.4 23799.0 17957.6 18473.4 18706.8 19164.6 19226.7 16013.9 17114.7 17183.1 17744.9 17922.3 19108.7 19401.2 19696.6 19711.1 19714.1 14597.2 14597.9 14671.5 14696.2 14891.9 18110.6 18673.7 18824.2 18954.0 19037.5 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#3] mootools.html Cycles:180 Average:8431.24 Median:2524.25 stddev:5678.04 (224.9%) stddev-sans-first:5669.01 18:16:40 INFO - PID 30128 | Values: 1346.3 1383.9 1387.0 1394.6 1406.3 13234.8 13603.0 13850.9 13900.8 13934.2 13423.5 14353.4 14400.1 14455.7 14467.0 2562.3 2622.9 2624.6 2625.1 2628.0 2538.6 2607.3 2607.6 2611.5 2621.1 2566.9 2577.5 2580.5 2610.2 2611.4 2461.5 2493.7 2508.2 2508.4 2509.9 2438.0 2454.0 2454.1 2475.9 2483.2 13280.5 13550.1 13565.9 13579.0 13593.4 7112.5 7409.9 7464.4 7490.9 7519.8 4569.8 4690.8 4766.2 4773.6 4842.4 1770.3 1783.9 1801.3 1835.8 1838.8 20292.4 21065.8 21924.7 22159.2 22350.7 5632.0 5815.9 6510.4 6692.3 6791.4 17387.8 17746.9 17778.6 17790.9 17816.0 7116.3 7594.2 7603.1 7647.2 7670.5 6838.8 6925.2 6932.0 6957.8 7007.2 5252.0 5322.7 5323.1 5381.3 5450.3 1639.8 1648.5 1656.9 1665.7 1684.1 894.2 901.9 919.3 927.7 940.7 7030.7 7158.7 7181.4 7186.7 7235.2 732.1 734.6 743.7 745.8 753.6 4373.8 4882.2 5041.1 5084.4 5168.3 17357.1 17508.9 17705.5 18437.7 18650.1 17502.3 17544.7 17805.0 17836.2 17950.9 10095.5 10098.9 10161.0 10324.5 10501.8 7421.8 7940.3 8181.6 8311.5 8453.2 15391.7 15484.2 16118.1 16192.3 16228.8 15604.5 16153.7 16166.0 16209.8 16714.2 11156.2 11419.1 11421.1 11427.1 11466.4 12314.4 12546.0 12712.7 12720.9 12762.1 9980.4 10160.8 10416.3 10522.5 10661.8 9938.8 9947.4 9980.0 10241.9 10276.4 8093.6 9043.9 9077.2 9101.9 9134.5 6613.8 6684.4 6730.8 6802.0 6808.5 7049.6 7217.0 7242.2 7309.1 7319.8 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#4] prototype.html Cycles:180 Average:5377.22 Median:5880.12 stddev:1503.91 (25.6%) stddev-sans-first:1462.76 18:16:40 INFO - PID 30128 | Values: 492.7 498.4 514.1 519.6 523.5 6029.5 6087.7 6125.4 6128.7 6157.1 5803.8 5915.7 5953.6 5962.8 6014.8 4832.5 4860.8 4875.5 4881.5 4909.6 4809.9 4817.6 4858.9 4860.8 4920.9 4760.1 4769.0 4774.1 4806.5 4842.2 4544.5 4765.5 4774.5 4828.6 4878.7 4387.6 4397.3 4399.7 4412.4 4421.2 5814.4 5835.6 5863.8 5866.4 5893.8 5534.3 5579.4 5614.6 5623.9 5637.0 6264.2 6300.0 6302.6 6318.2 6318.2 4785.9 4828.9 4830.9 4839.9 4853.2 6532.5 6691.4 6703.7 6745.4 6747.9 4909.2 4922.9 4925.5 4941.5 4989.8 4948.1 4963.1 4965.7 5004.4 5074.1 5364.7 5502.6 5537.1 5544.9 5607.7 6344.5 6429.5 6433.7 6446.5 6482.6 1721.6 1752.4 1754.2 1757.4 1757.5 1135.2 1223.8 1227.6 1233.4 1243.1 5464.2 5559.7 5569.1 5578.7 5599.2 6565.3 6574.5 6591.6 6595.6 6660.2 5525.4 5593.2 5625.0 5647.9 5719.7 3432.5 3433.0 3445.7 3480.9 3491.9 6349.3 6363.8 6386.9 6400.4 6409.7 6577.0 6712.8 6730.7 6785.5 6851.2 6331.8 6427.0 6451.8 6455.8 6457.2 6496.7 6500.6 6552.7 6561.0 6587.7 6478.5 6482.2 6565.3 6577.2 6586.8 6226.4 6335.7 6346.8 6380.2 6383.3 4878.7 4886.6 4893.9 4901.5 4910.6 6495.6 6556.7 6568.6 6569.4 6595.9 6412.2 6426.2 6433.7 6473.5 6479.6 6403.6 6410.5 6422.6 6436.1 6460.5 6284.8 6286.8 6298.5 6340.2 6347.3 5864.2 6366.5 6381.9 6383.2 6405.2 6086.6 6159.6 6179.4 6191.3 6214.9 18:16:40 INFO - PID 30128 | 18:16:40 INFO - PID 30128 | [#5] yui.html Cycles:180 Average:21895.99 Median:20011.80 stddev:28178.72 (140.8%) stddev-sans-first:28213.59 18:16:40 INFO - PID 30128 | Values: 884.2 893.2 896.2 917.3 919.1 17011.4 17959.0 18437.9 18793.8 18829.9 19643.2 21196.5 21267.4 21343.6 21377.5 1020.9 1054.2 1056.4 1056.7 1057.2 1062.6 1066.5 1067.9 1068.2 1069.2 785.6 810.3 1075.8 1111.0 1124.9 1110.1 1112.3 1112.7 1119.6 1121.6 816.9 820.6 821.4 821.5 825.9 18812.2 19328.5 19689.5 19691.2 19826.6 19858.1 20165.5 20553.8 20813.0 20831.6 15155.8 15489.0 15819.3 15835.0 15850.0 3517.0 3548.6 3556.1 3561.9 3578.3 104770.0 105810.0 108188.0 111308.0 111375.0 15973.3 16288.6 16463.8 16470.5 16502.1 27577.4 29163.3 29210.6 29373.3 29583.7 8013.4 8101.2 8102.7 8149.3 8165.4 3442.7 3608.5 3616.6 3633.9 3970.1 4951.8 5046.6 5096.5 5119.2 5120.8 830.2 863.4 867.3 982.2 985.0 652.4 665.9 706.1 711.3 726.5 11763.4 12204.8 12315.9 12509.8 12518.9 686.6 693.8 704.0 704.8 712.9 5491.9 5545.5 5552.5 5577.4 5619.9 92513.5 95237.0 97699.0 99350.5 100915.5 85235.0 86031.0 87759.6 92300.0 93010.0 72063.3 74392.3 75585.0 75878.2 77493.2 10389.7 10576.5 10626.3 10659.4 10929.9 33287.7 34386.5 34521.0 35122.6 35951.0 61299.0 64814.7 65293.3 67120.0 67605.7 17515.7 18248.8 18632.6 18731.9 18748.0 19280.3 19305.4 19330.3 19473.8 19492.8 18113.7 18815.8 18977.0 19055.5 19548.0 18563.4 19549.2 19563.7 19610.7 19650.3 16739.2 17405.7 17618.6 17749.9 18523.5 13381.2 13742.2 13777.4 14133.8 14449.8 13818.2 14120.4 14220.8 14461.5 15073.2 18:16:40 INFO - PID 30128 | -------- Summary: end -------- 18:16:40 INFO - PID 30128 | 18:16:40 INFO - TEST-INFO | 30128: exit 0 18:16:40 INFO - TEST-OK | dromaeo_css | took 1111025ms 18:16:40 INFO - TEST-START | kraken 18:16:40 INFO - Initialising browser for kraken test... 18:16:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46697/getInfo.html -profile /tmp/tmptvPcSd/profile 18:16:40 INFO - TEST-INFO | started process 30542 (/builds/slave/test/build/application/firefox/firefox http://localhost:46697/getInfo.html) 18:16:46 INFO - TEST-INFO | 30542: exit 0 18:16:46 INFO - Browser initialized. 18:16:46 INFO - Running cycle 1/1 for kraken test... 18:16:46 INFO - TEST-INFO | started process 30767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptvPcSd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:57 INFO - PID 30767 | RSS: Main: 170565632 18:16:57 INFO - PID 30767 | 18:17:00 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46697/tests/kraken/driver.html?testName=audio-beat-detection) 18:17:01 INFO - PID 30767 | RSS: Main: 177053696 18:17:01 INFO - PID 30767 | 18:17:03 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46697/tests/kraken/driver.html?testName=audio-dft) 18:17:04 INFO - PID 30767 | RSS: Main: 177491968 18:17:04 INFO - PID 30767 | 18:17:07 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46697/tests/kraken/driver.html?testName=audio-fft) 18:17:08 INFO - PID 30767 | RSS: Main: 171737088 18:17:08 INFO - PID 30767 | 18:17:10 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46697/tests/kraken/driver.html?testName=audio-oscillator) 18:17:10 INFO - PID 30767 | RSS: Main: 172560384 18:17:10 INFO - PID 30767 | 18:17:12 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:13 INFO - PID 30767 | RSS: Main: 172335104 18:17:13 INFO - PID 30767 | 18:17:16 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46697/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:17 INFO - PID 30767 | RSS: Main: 175788032 18:17:17 INFO - PID 30767 | 18:17:20 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46697/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:21 INFO - PID 30767 | RSS: Main: 177147904 18:17:21 INFO - PID 30767 | 18:17:23 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46697/tests/kraken/driver.html?testName=json-parse-financial) 18:17:24 INFO - PID 30767 | RSS: Main: 176066560 18:17:24 INFO - PID 30767 | 18:17:26 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:17:26 INFO - PID 30767 | RSS: Main: 175763456 18:17:26 INFO - PID 30767 | 18:17:28 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:17:29 INFO - PID 30767 | RSS: Main: 175931392 18:17:29 INFO - PID 30767 | 18:17:31 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:17:31 INFO - PID 30767 | RSS: Main: 176369664 18:17:31 INFO - PID 30767 | 18:17:34 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:17:35 INFO - PID 30767 | RSS: Main: 175792128 18:17:35 INFO - PID 30767 | 18:17:38 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:38 INFO - PID 30767 | RSS: Main: 175964160 18:17:38 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | Cycle 1(1): loaded http://localhost:46697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46697/tests/kraken/driver.html?testName=ai-astar) 18:17:40 INFO - PID 30767 | RSS: Main: 177250304 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | __start_tp_report 18:17:40 INFO - PID 30767 | _x_x_mozilla_page_load 18:17:40 INFO - PID 30767 | _x_x_mozilla_page_load_details 18:17:40 INFO - PID 30767 | |i|pagename|runs| 18:17:40 INFO - PID 30767 | |0;ai-astar;101;109;110;108;109;109;110;110;112;111 18:17:40 INFO - PID 30767 | |1;audio-beat-detection;151;121;154;188;122;155;154;122;179;121 18:17:40 INFO - PID 30767 | |2;audio-dft;162;165;164;163;163;170;165;166;168;172 18:17:40 INFO - PID 30767 | |3;audio-fft;76;76;77;162;74;77;74;75;96;75 18:17:40 INFO - PID 30767 | |4;audio-oscillator;82;82;139;82;83;85;132;81;83;145 18:17:40 INFO - PID 30767 | |5;imaging-gaussian-blur;114;113;114;114;114;113;114;113;113;113 18:17:40 INFO - PID 30767 | |6;imaging-darkroom;150;149;151;151;151;151;150;150;154;151 18:17:40 INFO - PID 30767 | |7;imaging-desaturate;95;94;94;95;94;94;93;95;95;94 18:17:40 INFO - PID 30767 | |8;json-parse-financial;55;62;55;55;62;58;54;56;57;54 18:17:40 INFO - PID 30767 | |9;json-stringify-tinderbox;55;55;54;54;54;54;54;55;55;54 18:17:40 INFO - PID 30767 | |10;stanford-crypto-aes;79;78;88;78;77;79;78;77;77;76 18:17:40 INFO - PID 30767 | |11;stanford-crypto-ccm;129;131;131;125;139;126;125;131;127;149 18:17:40 INFO - PID 30767 | |12;stanford-crypto-pbkdf2;205;183;189;182;189;184;194;199;183;183 18:17:40 INFO - PID 30767 | |13;stanford-crypto-sha256-iterative;68;69;69;73;67;69;75;75;71;69 18:17:40 INFO - PID 30767 | __end_tp_report 18:17:40 INFO - PID 30767 | __start_cc_report 18:17:40 INFO - PID 30767 | _x_x_mozilla_cycle_collect,934 18:17:40 INFO - PID 30767 | __end_cc_report 18:17:40 INFO - PID 30767 | __startTimestamp1500081460920__endTimestamp 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | ------- Summary: start ------- 18:17:40 INFO - PID 30767 | Number of tests: 14 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.00 (2.7%) stddev-sans-first:1.20 18:17:40 INFO - PID 30767 | Values: 101.0 109.0 110.0 108.0 109.0 109.0 110.0 110.0 112.0 111.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.00 stddev:24.68 (16.0%) stddev-sans-first:26.13 18:17:40 INFO - PID 30767 | Values: 151.0 121.0 154.0 188.0 122.0 155.0 154.0 122.0 179.0 121.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.26 (2.0%) stddev-sans-first:3.15 18:17:40 INFO - PID 30767 | Values: 162.0 165.0 164.0 163.0 163.0 170.0 165.0 166.0 168.0 172.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#3] audio-fft Cycles:10 Average:86.20 Median:76.00 stddev:27.42 (36.1%) stddev-sans-first:28.84 18:17:40 INFO - PID 30767 | Values: 76.0 76.0 77.0 162.0 74.0 77.0 74.0 75.0 96.0 75.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:82.00 stddev:27.29 (33.3%) stddev-sans-first:28.21 18:17:40 INFO - PID 30767 | Values: 82.0 82.0 139.0 82.0 83.0 85.0 132.0 81.0 83.0 145.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:17:40 INFO - PID 30767 | Values: 114.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 113.0 113.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.32 (0.9%) stddev-sans-first:1.36 18:17:40 INFO - PID 30767 | Values: 150.0 149.0 151.0 151.0 151.0 151.0 150.0 150.0 154.0 151.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 18:17:40 INFO - PID 30767 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 93.0 95.0 95.0 94.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.01 (5.3%) stddev-sans-first:3.12 18:17:40 INFO - PID 30767 | Values: 55.0 62.0 55.0 55.0 62.0 58.0 54.0 56.0 57.0 54.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 18:17:40 INFO - PID 30767 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 55.0 54.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:3.40 (4.4%) stddev-sans-first:3.61 18:17:40 INFO - PID 30767 | Values: 79.0 78.0 88.0 78.0 77.0 79.0 78.0 77.0 77.0 76.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:131.00 stddev:7.48 (5.7%) stddev-sans-first:7.89 18:17:40 INFO - PID 30767 | Values: 129.0 131.0 131.0 125.0 139.0 126.0 125.0 131.0 127.0 149.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:189.00 stddev:7.91 (4.2%) stddev-sans-first:5.94 18:17:40 INFO - PID 30767 | Values: 205.0 183.0 189.0 182.0 189.0 184.0 194.0 199.0 183.0 183.0 18:17:40 INFO - PID 30767 | 18:17:40 INFO - PID 30767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:2.88 (4.1%) stddev-sans-first:2.91 18:17:40 INFO - PID 30767 | Values: 68.0 69.0 69.0 73.0 67.0 69.0 75.0 75.0 71.0 69.0 18:17:40 INFO - PID 30767 | -------- Summary: end -------- 18:17:40 INFO - PID 30767 | 18:17:41 INFO - PID 30767 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:17:41 INFO - TEST-INFO | 30767: exit 0 18:17:41 INFO - TEST-OK | kraken | took 60908ms 18:17:41 INFO - SUITE-END | took 1171s 18:17:42 INFO - Completed test suite (00:19:32) 18:17:42 INFO - javascript benchmark 18:17:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8311.473949179066, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.4175706615756, 3094.8143111413315, 3102.9844850775744, 3120.110768430999, 3121.5785868907697, 5958.897603943268, 6012.428819262169, 6024.457798798107, 6059.575829691923, 6070.696465176746, 6020.969895150529, 6035.54733394996, 6066.241719785027, 6100.328963813977, 6124.356942521038, 5593.188987596796, 5680.943190568103, 5697.6866272355, 5728.513076388512, 5753.626014309057, 5700.6579605223615, 5705.4579814917515, 5705.543556515489, 5805.448482394187, 5811.506021988136, 5439.374471935699, 5594.468525490072, 5610.49505544503, 5687.544996400278, 5691.345495268056, 5557.749901254413, 5560.721963901829, 5568.276124103841, 5571.387147413781, 5573.359063707685, 5466.043442397565, 5501.284832971728, 5505.807296744595, 5523.475269849358, 5542.889142217174, 6006.699665016732, 6021.458068773788, 6031.909521357139, 6032.914075466414, 6033.788817391414, 6463.095166676669, 6480.0, 6514.250861150981, 6520.771772987922, 6525.902111468332, 6551.475881929434, 6594.901076483857, 6602.504812139109, 6603.900941485882, 6604.900926486107, 6033.9396606033815, 6116.602420842675, 6121.418465245794, 6135.355787642278, 6143.262808462969, 6721.563098398588, 6747.426468750113, 6815.250322464574, 6851.109355783717, 6860.5540639858245, 6371.203599550056, 6402.423781859655, 6510.283868774431, 6515.4787616990525, 6542.214934207926, 6370.617762934239, 6485.6108633482145, 6493.70778314977, 6502.902456463157, 6511.511636627272, 6389.137466442064, 6433.388828061326, 6471.352864713585, 6475.417212450902, 6513.120728701565, 6362.586431881913, 6488.772892948724, 6532.41208291256, 6610.107635469246, 6614.603123812491, 5332.466753324714, 5336.146216605324, 5416.91874621881, 5421.512063914188, 5422.783088676409, 4523.095380923828, 4571.177188106173, 4583.037562111994, 4615.723056616614, 4666.69666471685, 5663.830085097454, 5666.631668941505, 5679.858003549944, 5681.2330335404195, 5681.943180568224, 6490.058941453557, 6496.837579060467, 6550.181227346582, 6564.8358791030605, 6662.167229096363, 5674.716264186774, 5726.455986681259, 5782.132680098019, 5797.565182611237, 5820.82537523875, 5811.535077193815, 5823.068309070529, 5883.352831188566, 5914.9704251479325, 5931.139984702194, 6238.313785483593, 6318.083877837687, 6347.428731414103, 6413.102165696806, 6521.706523206467, 6467.385598368148, 6476.676166191766, 6479.125318081999, 6499.122618446449, 6500.349965003462, 6171.0, 6243.375662433902, 6245.531585131042, 6273.905891411541, 6282.3089460158435, 6258.812235632939, 6302.558820882494, 6309.274433440213, 6338.841528961629, 6351.9047214290895, 5607.010610104106, 6422.518311126778, 6655.301193374626, 6672.666366681744, 6720.899186512109, 6425.61446313204, 6432.807015789534, 6492.610443373413, 6529.085927969993, 6529.444997175104, 6385.706193916402, 6423.293437721753, 6517.934820651923, 6529.934700652932, 6535.57518761279, 6145.262568491809, 6240.843978900382, 6305.369463053658, 6360.777372792115, 6384.489240860627, 6148.354422785543, 6368.652156360384, 6492.837679058061, 6507.089007539043, 6544.181977252843, 6129.601575897553, 6172.382761723792, 6179.0422484514975, 6185.350538193605, 6227.19046523949], "value": 5972.075275585832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1456780012287, 766.9463137580365, 785.9017622797151, 806.6894245715399, 819.614781052905, 41007.58992410075, 41241.79379103104, 41803.372949405784, 41901.16197676045, 41955.0, 37801.81099094501, 37989.43015854764, 38016.0, 38072.0, 38084.04789880254, 6777.051212830208, 6893.069435626201, 6898.103246577938, 6906.0, 6908.06741089954, 6861.794146175623, 6889.34551217636, 6961.234264230956, 6984.231734509225, 6996.930030699704, 6988.930110698904, 6990.825229369281, 6995.475339349569, 7007.229204787469, 7016.859662806741, 6858.965705171492, 6883.277255888135, 6904.965475172642, 6918.238993710713, 6925.58446493212, 6195.132681424604, 6219.533534984895, 6233.2208473940755, 6258.123862659231, 6294.685265736694, 33998.32003359943, 34093.65906340929, 34266.65733342685, 34335.484967725504, 34498.0, 3375.831208439593, 3409.437442821931, 3431.673990970854, 3536.5932917714276, 3607.4769158472136, 31828.522572161437, 31927.840360798047, 32027.83986080078, 32088.679113208804, 32268.35463290721, 4956.677815941988, 4959.280904268897, 4992.326035985132, 5000.199968005102, 5129.358830146231, 186132.0, 188797.05601471904, 189132.0, 193341.0, 195758.0, 42407.575924240366, 49285.0, 50269.74865125651, 50663.49336506661, 50771.746141269796, 52147.21779173316, 52320.476795232324, 52675.73662131742, 52738.20892686613, 52741.208881866034, 16697.0, 16798.66402671964, 16810.0, 16892.746608800877, 16924.57688557796, 14012.369443374868, 14016.439342426393, 14046.438142474186, 14049.578512644433, 14071.71856562863, 14894.180820054784, 14901.627459313604, 14905.478308259158, 15094.622634434227, 15159.621009474851, 5692.544596432275, 5729.684867332254, 5778.624389414675, 5819.214406055213, 5866.882662346729, 980.5538479991586, 983.1446641421866, 988.3135903081403, 1044.2742294105676, 1046.5447530324334, 22295.88852055762, 22849.148053765184, 23158.305250842503, 23463.061477541047, 23582.7641723584, 1057.39728354837, 1102.7573933734566, 1113.1651261553834, 1129.203911242572, 1134.2230572058168, 11978.221415608132, 12158.878411215952, 12356.578993415693, 12358.382080895919, 12445.739489676775, 229318.0, 230575.0, 231840.0, 231915.0, 232040.0, 48429.27356089662, 48855.0, 49000.264996025086, 49076.0, 49120.0, 1454.5999850041323, 1458.9927050364681, 1501.8948673592743, 1505.796717443153, 1510.1316742872891, 21764.017236655545, 21987.765138642128, 22723.204687836507, 22929.0, 22952.540949181257, 37839.810800945816, 38031.80984095062, 38108.0, 38170.809145954096, 38236.617633823305, 190045.0, 190855.0, 191223.0, 191375.0431247835, 191631.0, 35358.823205883804, 36431.817840910626, 37533.06167345729, 39048.0, 39163.0, 45743.85640358885, 46962.0, 46975.29537057015, 47044.29433558431, 47345.0, 32146.517802232516, 33482.99551013376, 34167.31665366629, 34212.14469638279, 35276.82361588176, 33458.16354591155, 33834.83082584571, 34269.0, 34328.82835585806, 34484.310313794085, 38169.80915095407, 38803.61196388113, 38990.41514377343, 39102.0, 39189.41215881821, 32166.51750223795, 33494.16264593405, 33614.49578256377, 34029.82985085059, 34231.31537369289, 23192.198025537105, 24027.399315016566, 24533.14134005301, 24680.506389872462, 24689.753102468745], "value": 16972.272257271456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9216109744634, 563.169325245263, 566.8242844718137, 575.4159528079, 599.4125756758376, 21710.674339884914, 22813.885930570366, 22826.543469130607, 23001.309960701186, 23088.191913283037, 25797.484050319028, 27858.16425507238, 27979.440411191765, 28052.85973570129, 28158.577621335695, 6596.241432235282, 6778.983152527136, 6779.72881084756, 6781.050652908597, 6792.796216113525, 4032.5765794591584, 5695.917775622639, 6635.203775546941, 6702.396784289413, 6704.2625311215725, 4852.393450818648, 6566.376194261537, 6642.634655093968, 6672.232693240291, 6695.096162018114, 6622.9668851655915, 6634.635095069769, 6636.601803891782, 6642.3025582313885, 6662.333766623347, 6182.0, 6199.163112979735, 6212.534059945522, 6221.222347206599, 6239.0329498927285, 27873.86063069692, 29739.553906691417, 30461.0, 30623.69376306253, 30709.692903070907, 1876.0807204469847, 1924.2495426783566, 1926.3257859749117, 1928.113067988727, 1930.758655168104, 18521.073946302764, 19194.712079318822, 19256.711149332772, 19261.9036904816, 19283.614327713367, 2260.864348139117, 2290.7709229077127, 2300.344401845466, 2326.0, 2424.5029768897334, 131788.0, 137499.31250343684, 137868.31065844608, 138033.99999999898, 138571.30714346364, 14527.85472145286, 14594.197319147548, 14839.480618178311, 14981.625459363604, 15512.84487155114, 23119.07523699067, 23139.190128345428, 23309.41726456852, 23409.0, 23546.411339716302, 9725.0, 9894.158996485236, 9985.450800205914, 9998.80002399948, 10136.138428233535, 9109.27125829932, 9221.123993220634, 9221.400608960395, 9234.399764015317, 9445.102715242041, 8917.821643567222, 9092.772680682903, 9243.815123697623, 9320.487373194539, 9422.670206542738, 2789.4839454700946, 2799.2861820236117, 2817.4224284021725, 2841.9857900710363, 2864.584635227922, 944.5796620503947, 947.9620815167316, 970.4856426094182, 975.8194733974237, 994.4629899853998, 19516.31692890742, 19645.0, 19782.30761923326, 20072.49818754543, 23973.880130599584, 1007.5214273220162, 1016.7102375822855, 1040.6097713357492, 1058.3596923861107, 1065.6909496246158, 10975.50610222542, 11094.446777451163, 11107.166962477846, 11121.55513779456, 11126.41281145795, 447125.0, 455441.0, 459571.0, 460407.0, 465435.0, 114562.42718786353, 115925.99999999831, 115950.0, 117591.41204293924, 118117.0, 1208.0999655256715, 1295.6848798469373, 1317.7232781116072, 1319.7888337865895, 1333.953311634088, 20455.4886127848, 20572.0, 21692.783072169077, 21732.239371621916, 21806.672899906833, 55897.44102559085, 56211.156832646724, 56798.0, 58185.0, 60845.695771520855, 66393.33606663872, 67147.66426167838, 70751.29248707448, 70914.64542677253, 71931.64034179796, 14945.178015209269, 15284.31220595098, 15292.158931258442, 15377.538673839803, 15501.30244139039, 18925.526861828563, 19776.40670779879, 19870.90064549668, 22250.443738906655, 23799.0, 17957.551061223574, 18473.44579662612, 18706.812931870507, 19164.616707666046, 19226.711599325743, 16013.919930400274, 17114.743278851078, 17183.054931978862, 17744.91127544354, 17922.283108675507, 19108.713369299192, 19401.2239510418, 19696.60606787885, 19711.112999915324, 19714.112864920826, 14597.197154156198, 14597.92701036488, 14671.486497972519, 14696.191709455656, 14891.851081489047, 18110.637787244446, 18673.71989420187, 18824.15291311867, 18954.0, 19037.52406189801], "value": 12040.56420871514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.2528296795278, 1383.9100458470205, 1386.9722605547888, 1394.6164804678713, 1406.2757679794904, 13234.801477977839, 13602.979776516751, 13850.930745346272, 13900.791488127687, 13934.163950162998, 13423.523412424625, 14353.35409906554, 14400.06399584029, 14455.710885782304, 14467.0, 2562.320984938988, 2622.89508419663, 2624.553825849601, 2625.0681008242086, 2628.040765120736, 2538.6445897574263, 2607.296030071889, 2607.634931109646, 2611.451595165018, 2621.1350254416093, 2566.948661026778, 2577.5231582157267, 2580.458103798195, 2610.164747280871, 2611.386324213808, 2461.507698460315, 2493.675822143128, 2508.2099138771227, 2508.41052352697, 2509.8619575923317, 2438.036975394727, 2454.006127518358, 2454.0919859652045, 2475.9133430329853, 2483.242611003643, 13280.46878124874, 13550.119242249222, 13565.864341356657, 13579.049466537248, 13593.388297526635, 7112.502124851262, 7409.8518029639645, 7464.365528930048, 7490.925090749077, 7519.774406767806, 4569.771511424416, 4690.81236750533, 4766.237402015661, 4773.594244489223, 4842.370491836039, 1770.3361239535175, 1783.8850718301062, 1801.2884910460295, 1835.7521734565796, 1838.7609610750517, 20292.391228263175, 21065.789342106535, 21924.671129933064, 22159.224427145135, 22350.66474002891, 5632.0, 5815.912761308584, 6510.446612037935, 6692.297308782605, 6791.4227290679855, 17387.82612173862, 17746.911265443847, 17778.5555361117, 17790.91104544469, 17816.0, 7116.323949224816, 7594.202608726115, 7603.125640551408, 7647.197044310378, 7670.463067585216, 6838.794836154923, 6925.168979722465, 6932.0, 6957.82605434858, 7007.229204787469, 5252.0, 5322.707251101149, 5323.068463018956, 5381.30043094403, 5450.345958485007, 1639.7786298849742, 1648.5384092454133, 1656.9420070297722, 1665.7168281392192, 1684.115839184438, 894.1952242981239, 901.8557030875029, 919.2783664823082, 927.6984979881565, 940.6801687426308, 7030.718771249195, 7158.749443769443, 7181.425485961111, 7186.7125314986815, 7235.167955685059, 732.1177980533445, 734.6216698400328, 743.6988019851968, 745.7799949015053, 753.5591678867924, 4373.759443230653, 4882.194437917775, 5041.067402530543, 5084.3898732152375, 5168.328117344721, 17357.13214339278, 17508.912455437643, 17705.468835934942, 18437.7234341485, 18650.067496625114, 17502.29990800379, 17544.736828947574, 17805.0, 17836.19737111833, 17950.91024544869, 10095.545700443497, 10098.899011009942, 10161.0, 10324.535395907053, 10501.789964200825, 7421.777346679608, 7940.325072368682, 8181.5500147490075, 8311.501309921425, 8453.154684531497, 15391.69216615639, 15484.225788710293, 16118.113503757406, 16192.271347789143, 16228.837711622733, 15604.531864044096, 16153.67692646117, 16166.0, 16209.837901620833, 16714.247858846138, 11156.219064665396, 11419.14356423255, 11421.14341424413, 11427.142964277878, 11466.369349685847, 12314.445849936596, 12546.0, 12712.745745084861, 12720.872791272339, 12762.106652534234, 9980.401175929177, 10160.847587286344, 10416.32293900894, 10522.473876306307, 10661.786764264827, 9938.801223975335, 9947.353422027834, 9980.0, 10241.948790256001, 10276.434796086287, 8093.595320233847, 9043.864342034743, 9077.228435582785, 9101.908980910372, 9134.543272836465, 6613.834654133492, 6684.4318232950745, 6730.764423245163, 6802.013708012211, 6808.455323574201, 7049.647517623996, 7217.0, 7242.239564845826, 7309.122905251404, 7319.780406587811], "value": 6173.921012958591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.7278987773945, 498.3997701217759, 514.064402786928, 519.6466402846065, 523.4660646140936, 6029.487493563047, 6087.665178415185, 6125.448709616134, 6128.724207410666, 6157.138000679908, 5803.825885223439, 5915.674637894914, 5953.553483488734, 5962.761489540413, 6014.849628759283, 4832.516748325157, 4860.781264843073, 4875.512448755132, 4881.463039065718, 4909.607231421478, 4809.855704328876, 4817.566419022287, 4858.927116093261, 4860.781264843091, 4920.926186107194, 4760.11937791508, 4769.0, 4774.116788394141, 4806.471288158317, 4842.152623290927, 4544.545545445446, 4765.523447655241, 4774.472168905952, 4828.637852161084, 4878.658493905428, 4387.561243875619, 4397.31841564558, 4399.724080016791, 4412.426384570017, 4421.182081314967, 5814.418558144194, 5835.620684655484, 5863.794767183171, 5866.413358664142, 5893.821235752824, 5534.280543529356, 5579.358373787026, 5614.550835933156, 5623.915641265385, 5636.971815140939, 6264.248290205159, 6299.9835157425005, 6302.590331628476, 6318.210223722035, 6318.241810982666, 4785.947091639834, 4828.903421931542, 4830.855074347775, 4839.854804355875, 4853.174960256765, 6532.477401807844, 6691.397774200296, 6703.664816759143, 6745.392914637657, 6747.898781518281, 4909.189983652657, 4922.8769280768265, 4925.532074452921, 4941.50584941503, 4989.800407983713, 4948.134076536592, 4963.10664080469, 4965.659271996541, 5004.374453193351, 5074.13739664258, 5364.6512976656395, 5502.5597952163735, 5537.141743029837, 5544.944550554524, 5607.7476513556985, 6344.524160687967, 6429.54993150475, 6433.65728133508, 6446.548741588043, 6482.578632388974, 1721.63845592427, 1752.3866646673816, 1754.2106052276272, 1757.3761314733085, 1757.4815429448342, 1135.2450620337547, 1223.7858374784378, 1227.6317104868504, 1233.4018001269378, 1243.104964425612, 5464.169503216388, 5559.666420014732, 5569.136783798518, 5578.721063946868, 5599.160125981054, 6565.277819439858, 6574.474042076622, 6591.6374599397495, 6595.581949880799, 6660.200775906922, 5525.364583072917, 5593.210172744764, 5624.971875140598, 5647.887042259132, 5719.742611582489, 3432.467967465047, 3433.0, 3445.6554344565343, 3480.9477857832153, 3491.860325586999, 6349.301576826545, 6363.840903977438, 6386.882295598251, 6400.423961843363, 6409.743610255631, 6577.0, 6712.83217919556, 6730.663466826639, 6785.457163426914, 6851.177858656993, 6331.778387756406, 6426.967865160737, 6451.838704032437, 6455.838604034842, 6457.192850893638, 6496.740130394731, 6500.609963402211, 6552.705128269144, 6561.0, 6587.670616469253, 6478.514111441755, 6482.222133344029, 6565.343465653396, 6577.2436169841085, 6586.80239592813, 6226.40849119333, 6335.65153916539, 6346.777862774781, 6380.170577824853, 6383.329750376143, 4878.707277563358, 4886.609071274218, 4893.877653058702, 4901.50984901507, 4910.558049775537, 6495.642739649365, 6556.704948277244, 6568.573042752206, 6569.408753212234, 6595.87870062081, 6412.166418365583, 6426.196725409324, 6433.710483028181, 6473.546851720523, 6479.611223326616, 6403.551751377358, 6410.45511131559, 6422.550421470452, 6436.0989461476365, 6460.4508616766225, 6284.780032698834, 6286.779962701284, 6298.527610429328, 6340.207474065742, 6347.270063942706, 5864.24380541145, 6366.522510811615, 6381.85126677184, 6383.170187875547, 6405.167328247298, 6086.60437071589, 6159.599626024474, 6179.382061793965, 6191.288001879841, 6214.9067763984485], "value": 4939.141154885385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.2218847414271, 893.2184338703635, 896.2292428511479, 917.2799352508279, 919.1222382624594, 17011.404600838956, 17959.0, 18437.907810460947, 18793.812061879376, 18829.90585047076, 19643.214271429162, 21196.470088247803, 21267.361979140613, 21343.57312853742, 21377.465563360925, 1020.8877023527406, 1054.1830081686717, 1056.434807378053, 1056.651305069329, 1057.1912486947454, 1062.6333914799382, 1066.4934156275747, 1067.8718553773558, 1068.2415485005656, 1069.1500257295468, 785.6464590934074, 810.3436216664492, 1075.8171110911126, 1110.9611163609275, 1124.9100071994262, 1110.0786347331696, 1112.3492756737319, 1112.6550769261514, 1119.5577746790054, 1121.6074373969045, 816.9264766171013, 820.6471217376526, 821.3593397150232, 821.4537332673765, 825.8761185822175, 18812.24751009958, 19328.516787080294, 19689.523285753625, 19691.21235150592, 19826.603467930705, 19858.106385212555, 20165.495862603406, 20553.79446205534, 20813.0, 20831.583368332547, 15155.772663410058, 15489.0, 15819.288132033971, 15835.0, 15850.0, 3516.9648303517147, 3548.591911930135, 3556.1287484566187, 3561.893143205708, 3578.3380074686265, 104770.0, 105810.0, 108188.0, 111308.0, 111375.0, 15973.281202345923, 16288.592785180464, 16463.83536164647, 16470.505884823473, 16502.092384918706, 27577.44845103087, 29163.27091822679, 29210.561841572395, 29373.26566835846, 29583.704162958096, 8013.439059265912, 8101.230383113595, 8102.675892964216, 8149.266566009088, 8165.38759593021, 3442.7417943654327, 3608.45873119029, 3616.5840928293055, 3633.9091522711615, 3970.10672598663, 4951.801927922915, 5046.596272298208, 5096.490350964948, 5119.232115182678, 5120.769565369567, 830.2154464031553, 863.4473936680404, 867.3061550759368, 982.150439869522, 985.0494273026563, 652.3509108437136, 665.9134312539339, 706.0609389511936, 711.2709472790431, 726.5168662839153, 11763.353015584225, 12204.755904881853, 12315.876841231653, 12509.803725665479, 12518.874811251771, 686.5743239191634, 693.7779910428615, 704.0214102397671, 704.844934114494, 712.8574285142992, 5491.890162196813, 5545.473180047969, 5552.500274975271, 5577.442255774471, 5619.915701264485, 92513.53743231241, 95237.0, 97699.0, 99350.5032474833, 100915.49542252389, 85235.0, 86031.0, 87759.56120219358, 92300.0, 93010.0, 72063.2793672067, 74392.25607743961, 75585.0, 75878.24121758711, 77493.2250677486, 10389.688309350731, 10576.46641237001, 10626.256162068581, 10659.360438373722, 10929.890701093205, 33287.66712332846, 34386.484202737476, 34521.0, 35122.64877351194, 35951.0, 61299.0, 64814.67592662007, 65293.347066528724, 67119.99320010301, 67605.66197168983, 17515.737263940795, 18248.817511824713, 18632.627347453246, 18731.906340468755, 18748.0, 19280.32518861833, 19305.420837374902, 19330.323438679578, 19473.8052619472, 19492.8050719491, 18113.728294075336, 18815.811841881405, 18977.0, 19055.52361190981, 19548.022598869717, 18563.35028274004, 19549.21803127859, 19563.706544402132, 19610.705839412134, 19650.312239071565, 16739.163041848104, 17405.65188696244, 17618.559536011704, 17749.911250443663, 18523.536911577317, 13381.19712817234, 13742.175469471864, 13777.380017899419, 14133.787993180316, 14449.78325325142, 13818.239996800272, 14120.43518259258, 14220.786688199478, 14461.49384771528, 15073.170975596448], "value": 8857.588890680358, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 110.0, 108.0, 109.0, 109.0, 110.0, 110.0, 112.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 154.0, 188.0, 122.0, 155.0, 154.0, 122.0, 179.0, 121.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 163.0, 163.0, 170.0, 165.0, 166.0, 168.0, 172.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 162.0, 74.0, 77.0, 74.0, 75.0, 96.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 139.0, 82.0, 83.0, 85.0, 132.0, 81.0, 83.0, 145.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 151.0, 151.0, 151.0, 150.0, 150.0, 154.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 55.0, 55.0, 62.0, 58.0, 54.0, 56.0, 57.0, 54.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 88.0, 78.0, 77.0, 79.0, 78.0, 77.0, 77.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 131.0, 125.0, 139.0, 126.0, 125.0, 131.0, 127.0, 149.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 183.0, 189.0, 182.0, 189.0, 184.0, 194.0, 199.0, 183.0, 183.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 73.0, 67.0, 69.0, 75.0, 75.0, 71.0, 69.0], "value": 70.5, "unit": "score"}]}]} 18:17:42 INFO - Return code: 0 18:17:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:17:42 INFO - # TBPL SUCCESS # 18:17:42 INFO - Running post-action listener: _package_coverage_data 18:17:42 INFO - Running post-action listener: _resource_record_post_action 18:17:42 INFO - [mozharness: 2017-07-15 01:17:42.218597Z] Finished run-tests step (success) 18:17:42 INFO - Running post-run listener: _resource_record_post_run 18:17:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439382016; Read time: 20; Write time: 255780 18:17:42 INFO - TinderboxPrint: CPU usage
13.1% 18:17:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 18:17:42 INFO - TinderboxPrint: I/O write bytes / time
439,382,016 / 255,780 18:17:42 INFO - TinderboxPrint: CPU idle
8,254.0 (86.9%) 18:17:42 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 18:17:42 INFO - TinderboxPrint: Swap in / out
0 / 0 18:17:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106672128; Read time: 0; Write time: 66128 18:17:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:17:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 329658368; Read time: 0; Write time: 189172 18:17:42 INFO - Running post-run listener: _upload_blobber_files 18:17:42 INFO - Blob upload gear active. 18:17:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:17:42 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 18:17:42 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'] 18:17:42 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 18:17:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:17:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:17:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:44 INFO - (blobuploader) - INFO - Done attempting. 18:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:44 INFO - (blobuploader) - INFO - Done attempting. 18:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:48 INFO - (blobuploader) - INFO - Done attempting. 18:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:49 INFO - (blobuploader) - INFO - Done attempting. 18:17:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:17:49 INFO - Return code: 0 18:17:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:17:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:17:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6863088cbf19576fd6c5c0426e31b53c59d62cd2f86bdc2be45c71f95c8561910749c0cd0d1b9c4c5ae2e460533c18393eae8914dde2bfaba7e7b284477a89a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b03b9136c36eaabcae38fad40b8cccd9d8296f87464e9e42928c02c3d784df56b0e1036c94c89d0fa30fbe6647f57c205e6e78697972b301ff59e9f4a15c90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5577d7e08c30621998146093529b325a4b45e2f97778a36bf6d29500b4f6da56a4d2f3eb96f6921765111971591a78845c2b6b0a54aad2919506b8248e2f83b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767a488311a7945f4202d8c37170e44043a3de57ece0de3f5150ae04371c3118cb783c970be6ce1ff58f0271831cbde763bdffc15338ec5fd727e1ed70112c5"} 18:17:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:17:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:17:49 INFO - Contents: 18:17:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6863088cbf19576fd6c5c0426e31b53c59d62cd2f86bdc2be45c71f95c8561910749c0cd0d1b9c4c5ae2e460533c18393eae8914dde2bfaba7e7b284477a89a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b03b9136c36eaabcae38fad40b8cccd9d8296f87464e9e42928c02c3d784df56b0e1036c94c89d0fa30fbe6647f57c205e6e78697972b301ff59e9f4a15c90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5577d7e08c30621998146093529b325a4b45e2f97778a36bf6d29500b4f6da56a4d2f3eb96f6921765111971591a78845c2b6b0a54aad2919506b8248e2f83b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767a488311a7945f4202d8c37170e44043a3de57ece0de3f5150ae04371c3118cb783c970be6ce1ff58f0271831cbde763bdffc15338ec5fd727e1ed70112c5"} 18:17:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:17:49 INFO - Copying logs to upload dir... 18:17:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:17:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.118905 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-14 18:17:49.520867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-14 18:17:49.524393) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 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/e6863088cbf19576fd6c5c0426e31b53c59d62cd2f86bdc2be45c71f95c8561910749c0cd0d1b9c4c5ae2e460533c18393eae8914dde2bfaba7e7b284477a89a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b03b9136c36eaabcae38fad40b8cccd9d8296f87464e9e42928c02c3d784df56b0e1036c94c89d0fa30fbe6647f57c205e6e78697972b301ff59e9f4a15c90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5577d7e08c30621998146093529b325a4b45e2f97778a36bf6d29500b4f6da56a4d2f3eb96f6921765111971591a78845c2b6b0a54aad2919506b8248e2f83b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767a488311a7945f4202d8c37170e44043a3de57ece0de3f5150ae04371c3118cb783c970be6ce1ff58f0271831cbde763bdffc15338ec5fd727e1ed70112c5"} build_url:https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/WeCLI3UqQb2jhRhnWOcQ7A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6863088cbf19576fd6c5c0426e31b53c59d62cd2f86bdc2be45c71f95c8561910749c0cd0d1b9c4c5ae2e460533c18393eae8914dde2bfaba7e7b284477a89a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b03b9136c36eaabcae38fad40b8cccd9d8296f87464e9e42928c02c3d784df56b0e1036c94c89d0fa30fbe6647f57c205e6e78697972b301ff59e9f4a15c90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5577d7e08c30621998146093529b325a4b45e2f97778a36bf6d29500b4f6da56a4d2f3eb96f6921765111971591a78845c2b6b0a54aad2919506b8248e2f83b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767a488311a7945f4202d8c37170e44043a3de57ece0de3f5150ae04371c3118cb783c970be6ce1ff58f0271831cbde763bdffc15338ec5fd727e1ed70112c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-14 18:17:49.548270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 18:17:49.548627) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500079072.199981-48608765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-14 18:17:49.629983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-14 18:17:49.633355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-14 18:17:49.633649) ========= ========= Total master_lag: 0.16 =========