builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1500423269.98 results: success (0) revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:29.978248) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:29.978802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:29.979077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:30.069144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:30.069405) ========= 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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 17:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-18 17:14:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114612 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:30.197438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:30.197728) ========= 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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:30.247121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-18 17:14:30.247413) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 17:14:30,582 truncating revision to first 12 chars 2017-07-18 17:14:30,582 Setting DEBUG logging. 2017-07-18 17:14:30,582 attempt 1/10 2017-07-18 17:14:30,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b065ffd8a53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 17:14:31,189 unpacking tar archive at: mozilla-central-1b065ffd8a53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.236493 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-18 17:14:31.496121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:31.496422) ========= script_repo_revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:31.496800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:31.497062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:31.504239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-18 17:14:31.504500) ========= /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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:31 INFO - MultiFileLogger online at 20170718 17:14:31 in /builds/slave/test 17:14:31 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:14:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:31 INFO - {'append_to_log': False, 17:14:31 INFO - 'base_work_dir': '/builds/slave/test', 17:14:31 INFO - 'blob_upload_branch': 'Firefox', 17:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:31 INFO - 'branch': 'Firefox', 17:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:31 INFO - 'code_coverage': False, 17:14:31 INFO - 'config_files': ('talos/linux_config.py',), 17:14:31 INFO - 'default_actions': ('clobber', 17:14:31 INFO - 'read-buildbot-config', 17:14:31 INFO - 'download-and-extract', 17:14:31 INFO - 'populate-webroot', 17:14:31 INFO - 'create-virtualenv', 17:14:31 INFO - 'install', 17:14:31 INFO - 'setup-mitmproxy', 17:14:31 INFO - 'run-tests'), 17:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:31 INFO - 'disable_ccov_upload': False, 17:14:31 INFO - 'download_minidump_stackwalk': True, 17:14:31 INFO - 'download_symbols': 'ondemand', 17:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:31 INFO - 'gecko_profile': False, 17:14:31 INFO - 'gecko_profile_interval': 0, 17:14:31 INFO - 'installer_path': 'installer.exe', 17:14:31 INFO - 'log_level': 'info', 17:14:31 INFO - 'log_name': 'talos', 17:14:31 INFO - 'log_to_console': True, 17:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:31 INFO - 'opt_config_files': (), 17:14:31 INFO - 'pip_index': False, 17:14:31 INFO - 'suite': 'dromaeojs-e10s', 17:14:31 INFO - 'system_bits': '32', 17:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:31 INFO - 'title': 'talos-linux64-ix-055', 17:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:31 INFO - 'use_talos_json': True, 17:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:31 INFO - 'work_dir': 'build'} 17:14:31 INFO - [mozharness: 2017-07-19 00:14:31.942990Z] Running clobber step. 17:14:31 INFO - Running pre-action listener: _resource_record_pre_action 17:14:31 INFO - Running main action method: clobber 17:14:31 INFO - rmtree: /builds/slave/test/build 17:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:32 INFO - Running post-action listener: _resource_record_post_action 17:14:32 INFO - [mozharness: 2017-07-19 00:14:32.985221Z] Finished clobber step (success) 17:14:32 INFO - [mozharness: 2017-07-19 00:14:32.985326Z] Running read-buildbot-config step. 17:14:32 INFO - Running pre-action listener: _resource_record_pre_action 17:14:32 INFO - Running main action method: read_buildbot_config 17:14:32 INFO - Using buildbot properties: 17:14:32 INFO - { 17:14:32 INFO - "project": "", 17:14:32 INFO - "product": "firefox", 17:14:32 INFO - "who": "kwierso@gmail.com", 17:14:32 INFO - "installer_path": "public/build/target.tar.bz2", 17:14:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:14:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:14:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:14:32 INFO - "stage_platform": "linux64-stylo", 17:14:32 INFO - "basedir": "/builds/slave/test", 17:14:32 INFO - "buildnumber": 219, 17:14:32 INFO - "platform": "ubuntu64_hw_stylo", 17:14:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:14:32 INFO - "slavebuilddir": "test", 17:14:32 INFO - "taskId": "Yv2EP92vT-2tKVyUyI9w4g", 17:14:32 INFO - "branch": "mozilla-central", 17:14:32 INFO - "script_repo_revision": "production", 17:14:32 INFO - "revision": "1b065ffd8a535a0ad4c39a912af18e948e6a42c1", 17:14:32 INFO - "slavename": "talos-linux64-ix-055", 17:14:32 INFO - "repo_path": "mozilla-central" 17:14:32 INFO - } 17:14:32 INFO - Finding installer, test and symbols from parent task. 17:14:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yv2EP92vT-2tKVyUyI9w4g'}, attempt #1 17:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yv2EP92vT-2tKVyUyI9w4g'}, attempt #1 17:14:33 INFO - Task dependencies: AL8eNrU6QISMrRooVk2SfA 17:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA'}, attempt #1 17:14:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:14:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/test_packages.json 17:14:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip 17:14:34 INFO - Running post-action listener: _resource_record_post_action 17:14:34 INFO - [mozharness: 2017-07-19 00:14:34.342230Z] Finished read-buildbot-config step (success) 17:14:34 INFO - [mozharness: 2017-07-19 00:14:34.342455Z] Running download-and-extract step. 17:14:34 INFO - Running pre-action listener: _resource_record_pre_action 17:14:34 INFO - Running main action method: download_and_extract 17:14:34 INFO - mkdir: /builds/slave/test/build/tests 17:14: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:14:34 INFO - trying https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json 17:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:14:34 INFO - Downloaded 989 bytes. 17:14:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:14:34 INFO - Using the following test package requirements: 17:14:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:14:34 INFO - u'common': [u'target.common.tests.zip'], 17:14:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:14:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:14:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:14:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:14:34 INFO - u'mozbase': [u'target.common.tests.zip'], 17:14:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:14:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:14:34 INFO - u'web-platform': [u'target.common.tests.zip', 17:14:34 INFO - u'target.web-platform.tests.tar.gz'], 17:14:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:14:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:14:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip 17:14:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:14:34 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip into memory 17:14:38 INFO - Content-Length response header: 72754959 17:14:38 INFO - Bytes received: 72754959 17:14:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:14:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip 17:14:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:14:49 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip into memory 17:14:52 INFO - Content-Length response header: 72754959 17:14:52 INFO - Bytes received: 72754959 17:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip 17:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip into memory 17:15:06 INFO - Content-Length response header: 14495033 17:15:06 INFO - Bytes received: 14495033 17:15:06 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:15:06 INFO - trying https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:15:10 INFO - Downloaded 61947920 bytes. 17:15:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:10 INFO - mkdir: /builds/slave/test/properties 17:15:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:10 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:10 INFO - Contents: 17:15:10 INFO - build_url:https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:10 INFO - Running post-action listener: _resource_record_post_action 17:15:10 INFO - Running post-action listener: set_extra_try_arguments 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.434645Z] Finished download-and-extract step (success) 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.434873Z] Running populate-webroot step. 17:15:10 INFO - Running pre-action listener: _resource_record_pre_action 17:15:10 INFO - Running main action method: populate_webroot 17:15:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:10 INFO - '--tppagecycles', 17:15:10 INFO - '7'], 17:15:10 INFO - 'tests': ['tsvgm']}}, 17:15:10 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['damp', 'tps']}, 17:15:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['damp', 'tps']}, 17:15:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['dromaeo_dom']}, 17:15:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:15:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:15:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:15:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:15:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:15:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:15:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:15:10 INFO - 'talos_options': ['--mitmproxy', 17:15:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:15:10 INFO - '--firstNonBlankPaint'], 17:15:10 INFO - 'tests': ['quantum_pageload_google', 17:15:10 INFO - 'quantum_pageload_youtube', 17:15:10 INFO - 'quantum_pageload_amazon', 17:15:10 INFO - 'quantum_pageload_facebook']}, 17:15:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tsvgx', 17:15:10 INFO - 'tsvgr_opacity', 17:15:10 INFO - 'tart', 17:15:10 INFO - 'tscrollx', 17:15:10 INFO - 'cart', 17:15:10 INFO - 'tsvg_static']}, 17:15:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:10 INFO - 'tsvgr_opacity', 17:15:10 INFO - 'tart', 17:15:10 INFO - 'tscrollx', 17:15:10 INFO - 'cart', 17:15:10 INFO - 'tsvg_static']}, 17:15:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tp5o']}, 17:15:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:15:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s', 17:15:10 INFO - '--xperf_path', 17:15:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:10 INFO - 'tests': ['tp5n']}, 17:15:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--xperf_path', 17:15:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:10 INFO - 'tests': ['tp5n']}}, 17:15:10 INFO - 'talos.zip': {'path': '', 17:15:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:10 INFO - Running post-action listener: _resource_record_post_action 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.459312Z] Finished populate-webroot step (success) 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.459403Z] Running create-virtualenv step. 17:15:10 INFO - Running pre-action listener: _resource_record_pre_action 17:15:10 INFO - Running main action method: create_virtualenv 17:15:10 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:10 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:15:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:15:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:10 INFO - Using real prefix '/usr' 17:15:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:11 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:13 INFO - Installing pip.................done. 17:15:13 INFO - Return code: 0 17:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:15:13 INFO - Reading from file tmpfile_stdout 17:15:13 INFO - Output received: 17:15:13 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:15:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:13 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 17:15:13 INFO - 'HOME': '/home/cltbld', 17:15:13 INFO - 'LANG': 'en_US.UTF-8', 17:15:13 INFO - 'LANGUAGE': 'en_US:en', 17:15:13 INFO - 'LOGNAME': 'cltbld', 17:15:13 INFO - 'MAIL': '/var/mail/cltbld', 17:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:13 INFO - 'MOZ_NO_REMOTE': '1', 17:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:13 INFO - 'NO_EM_RESTART': '1', 17:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:13 INFO - 'PWD': '/builds/slave/test', 17:15:13 INFO - 'SHELL': '/bin/bash', 17:15:13 INFO - 'SHLVL': '1', 17:15:13 INFO - 'TERM': 'linux', 17:15:13 INFO - 'TMOUT': '86400', 17:15:13 INFO - 'USER': 'cltbld', 17:15:13 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:13 INFO - '_': '/tools/buildbot/bin/python'} 17:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:13 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:15:13 INFO - Cleaning up... 17:15:13 INFO - Return code: 0 17:15:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:13 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 17:15:13 INFO - 'HOME': '/home/cltbld', 17:15:13 INFO - 'LANG': 'en_US.UTF-8', 17:15:13 INFO - 'LANGUAGE': 'en_US:en', 17:15:13 INFO - 'LOGNAME': 'cltbld', 17:15:13 INFO - 'MAIL': '/var/mail/cltbld', 17:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:13 INFO - 'MOZ_NO_REMOTE': '1', 17:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:13 INFO - 'NO_EM_RESTART': '1', 17:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:13 INFO - 'PWD': '/builds/slave/test', 17:15:13 INFO - 'SHELL': '/bin/bash', 17:15:13 INFO - 'SHLVL': '1', 17:15:13 INFO - 'TERM': 'linux', 17:15:13 INFO - 'TMOUT': '86400', 17:15:13 INFO - 'USER': 'cltbld', 17:15:13 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:13 INFO - '_': '/tools/buildbot/bin/python'} 17:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:13 INFO - Downloading/unpacking psutil>=3.1.1 17:15:13 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:15:13 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:15:13 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:15:13 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:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:14 INFO - Installing collected packages: psutil 17:15:14 INFO - Running setup.py install for psutil 17:15:14 INFO - building 'psutil._psutil_linux' extension 17:15:14 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:15:15 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:15:15 INFO - building 'psutil._psutil_posix' extension 17:15:15 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:15:15 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:15:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:15 INFO - Successfully installed psutil 17:15:15 INFO - Cleaning up... 17:15:15 INFO - Return code: 0 17:15:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15:15 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:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:15 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:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:15 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:15 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:15:15 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:15:15 INFO - Using env: {'DISPLAY': ':0', 17:15:15 INFO - 'HOME': '/home/cltbld', 17:15:15 INFO - 'LANG': 'en_US.UTF-8', 17:15:15 INFO - 'LANGUAGE': 'en_US:en', 17:15:15 INFO - 'LOGNAME': 'cltbld', 17:15:15 INFO - 'MAIL': '/var/mail/cltbld', 17:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:15 INFO - 'MOZ_NO_REMOTE': '1', 17:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:15 INFO - 'NO_EM_RESTART': '1', 17:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:15 INFO - 'PWD': '/builds/slave/test', 17:15:15 INFO - 'SHELL': '/bin/bash', 17:15:15 INFO - 'SHLVL': '1', 17:15:15 INFO - 'TERM': 'linux', 17:15:15 INFO - 'TMOUT': '86400', 17:15:15 INFO - 'USER': 'cltbld', 17:15:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:15 INFO - '_': '/tools/buildbot/bin/python'} 17:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:15 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:15:15 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:15:15 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:15:15 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:15:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:16 INFO - Installing collected packages: mozsystemmonitor 17:15:16 INFO - Running setup.py install for mozsystemmonitor 17:15:16 INFO - Successfully installed mozsystemmonitor 17:15:16 INFO - Cleaning up... 17:15:16 INFO - Return code: 0 17:15:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:16 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:16 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:15:16 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:15:16 INFO - Using env: {'DISPLAY': ':0', 17:15:16 INFO - 'HOME': '/home/cltbld', 17:15:16 INFO - 'LANG': 'en_US.UTF-8', 17:15:16 INFO - 'LANGUAGE': 'en_US:en', 17:15:16 INFO - 'LOGNAME': 'cltbld', 17:15:16 INFO - 'MAIL': '/var/mail/cltbld', 17:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:16 INFO - 'MOZ_NO_REMOTE': '1', 17:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:16 INFO - 'NO_EM_RESTART': '1', 17:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:16 INFO - 'PWD': '/builds/slave/test', 17:15:16 INFO - 'SHELL': '/bin/bash', 17:15:16 INFO - 'SHLVL': '1', 17:15:16 INFO - 'TERM': 'linux', 17:15:16 INFO - 'TMOUT': '86400', 17:15:16 INFO - 'USER': 'cltbld', 17:15:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:16 INFO - '_': '/tools/buildbot/bin/python'} 17:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:18 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:15:18 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:15:18 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:15:18 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:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:18 INFO - warning: no files found matching '*.txt' 17:15:18 INFO - no previously-included directories found matching 'build' 17:15:18 INFO - no previously-included directories found matching 'dist' 17:15:18 INFO - no previously-included directories found matching '.git*' 17:15:18 INFO - Installing collected packages: jsonschema, functools32 17:15:18 INFO - Running setup.py install for functools32 17:15:18 INFO - warning: no files found matching '*.txt' 17:15:18 INFO - no previously-included directories found matching 'build' 17:15:18 INFO - no previously-included directories found matching 'dist' 17:15:18 INFO - no previously-included directories found matching '.git*' 17:15:18 INFO - Successfully installed jsonschema functools32 17:15:18 INFO - Cleaning up... 17:15:18 INFO - Return code: 0 17:15:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15:18 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:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:18 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:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:18 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:18 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:15:18 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:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:18 INFO - Cleaning up... 17:15:18 INFO - Return code: 0 17:15:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:18 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:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:18 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:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:18 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:18 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:15:18 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:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:18 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:18 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:15:18 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:15:18 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:15:18 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:15:20 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:20 INFO - Downloading docopt-0.6.1.tar.gz 17:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:20 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:20 INFO - Running setup.py install for blobuploader 17:15:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:20 INFO - Running setup.py install for requests 17:15:21 INFO - Running setup.py install for docopt 17:15:21 INFO - Successfully installed blobuploader requests docopt 17:15:21 INFO - Cleaning up... 17:15:21 INFO - Return code: 0 17:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:21 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:21 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:15:21 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:15:21 INFO - Using env: {'DISPLAY': ':0', 17:15:21 INFO - 'HOME': '/home/cltbld', 17:15:21 INFO - 'LANG': 'en_US.UTF-8', 17:15:21 INFO - 'LANGUAGE': 'en_US:en', 17:15:21 INFO - 'LOGNAME': 'cltbld', 17:15:21 INFO - 'MAIL': '/var/mail/cltbld', 17:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:21 INFO - 'MOZ_NO_REMOTE': '1', 17:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:21 INFO - 'NO_EM_RESTART': '1', 17:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:21 INFO - 'PWD': '/builds/slave/test', 17:15:21 INFO - 'SHELL': '/bin/bash', 17:15:21 INFO - 'SHLVL': '1', 17:15:21 INFO - 'TERM': 'linux', 17:15:21 INFO - 'TMOUT': '86400', 17:15:21 INFO - 'USER': 'cltbld', 17:15:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:21 INFO - '_': '/tools/buildbot/bin/python'} 17:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:21 INFO - Running setup.py (path:/tmp/pip-J6KrU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:21 INFO - Running setup.py (path:/tmp/pip-zC9Rz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:21 INFO - Running setup.py (path:/tmp/pip-LbZeBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:21 INFO - Running setup.py (path:/tmp/pip-EbtFxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:21 INFO - Running setup.py (path:/tmp/pip-0DrrJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:21 INFO - Running setup.py (path:/tmp/pip-K0mUzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:21 INFO - Running setup.py (path:/tmp/pip-0an1AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:21 INFO - Running setup.py (path:/tmp/pip-LwkP8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:22 INFO - Running setup.py (path:/tmp/pip-qxmEQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:22 INFO - Running setup.py (path:/tmp/pip-59WuF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:22 INFO - Running setup.py (path:/tmp/pip-BiGUY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:22 INFO - Running setup.py (path:/tmp/pip-8JnBun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:22 INFO - Running setup.py (path:/tmp/pip-haWsw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:22 INFO - Running setup.py (path:/tmp/pip-nxJ5rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:22 INFO - Running setup.py (path:/tmp/pip-PrID7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:22 INFO - Running setup.py (path:/tmp/pip-oZg9sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:22 INFO - Running setup.py (path:/tmp/pip-OXHRxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:22 INFO - Running setup.py install for manifestparser 17:15:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:22 INFO - Running setup.py install for mozcrash 17:15:22 INFO - Running setup.py install for mozdebug 17:15:22 INFO - Running setup.py install for mozdevice 17:15:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozfile 17:15:23 INFO - Running setup.py install for mozhttpd 17:15:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozinfo 17:15:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozInstall 17:15:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozleak 17:15:23 INFO - Running setup.py install for mozlog 17:15:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for moznetwork 17:15:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozprocess 17:15:23 INFO - Running setup.py install for mozprofile 17:15:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for mozrunner 17:15:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for mozscreenshot 17:15:24 INFO - Running setup.py install for moztest 17:15:24 INFO - Running setup.py install for mozversion 17:15:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:24 INFO - Cleaning up... 17:15:24 INFO - Return code: 0 17:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:24 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:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:24 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:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:24 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:24 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:15:24 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:15:24 INFO - Using env: {'DISPLAY': ':0', 17:15:24 INFO - 'HOME': '/home/cltbld', 17:15:24 INFO - 'LANG': 'en_US.UTF-8', 17:15:24 INFO - 'LANGUAGE': 'en_US:en', 17:15:24 INFO - 'LOGNAME': 'cltbld', 17:15:24 INFO - 'MAIL': '/var/mail/cltbld', 17:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:24 INFO - 'MOZ_NO_REMOTE': '1', 17:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:24 INFO - 'NO_EM_RESTART': '1', 17:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:24 INFO - 'PWD': '/builds/slave/test', 17:15:24 INFO - 'SHELL': '/bin/bash', 17:15:24 INFO - 'SHLVL': '1', 17:15:24 INFO - 'TERM': 'linux', 17:15:24 INFO - 'TMOUT': '86400', 17:15:24 INFO - 'USER': 'cltbld', 17:15:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:24 INFO - '_': '/tools/buildbot/bin/python'} 17:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:24 INFO - Running setup.py (path:/tmp/pip-tF7fzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:24 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:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:24 INFO - Running setup.py (path:/tmp/pip-h9NyDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:24 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:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:24 INFO - Running setup.py (path:/tmp/pip-pOH_Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:24 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:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:24 INFO - Running setup.py (path:/tmp/pip-Mx_lNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:24 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:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:24 INFO - Running setup.py (path:/tmp/pip-wlcJdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:25 INFO - Running setup.py (path:/tmp/pip-ps3m4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:25 INFO - Running setup.py (path:/tmp/pip-n5JqG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:25 INFO - Running setup.py (path:/tmp/pip-b66LUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:25 INFO - Running setup.py (path:/tmp/pip-fGjRcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:25 INFO - Running setup.py (path:/tmp/pip-OFS1tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:25 INFO - Running setup.py (path:/tmp/pip-kRPsXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:25 INFO - Running setup.py (path:/tmp/pip-QrZ9Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:25 INFO - Running setup.py (path:/tmp/pip-jVwvfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:25 INFO - Running setup.py (path:/tmp/pip-g3EizL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:25 INFO - Running setup.py (path:/tmp/pip-piyn2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:25 INFO - Running setup.py (path:/tmp/pip-tZ8oFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:25 INFO - Running setup.py (path:/tmp/pip-UCLR5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:25 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:15:25 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:15:25 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:15:25 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:15:27 INFO - Downloading blessings-1.6.tar.gz 17:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:27 INFO - Installing collected packages: blessings 17:15:27 INFO - Running setup.py install for blessings 17:15:27 INFO - Successfully installed blessings 17:15:27 INFO - Cleaning up... 17:15:27 INFO - Return code: 0 17:15:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:27 INFO - Reading from file tmpfile_stdout 17:15:27 INFO - Current package versions: 17:15:27 INFO - argparse == 1.2.1 17:15:27 INFO - blessings == 1.6 17:15:27 INFO - blobuploader == 1.2.4 17:15:27 INFO - docopt == 0.6.1 17:15:27 INFO - functools32 == 3.2.3-2 17:15:27 INFO - jsonschema == 2.5.1 17:15:27 INFO - manifestparser == 1.1 17:15:27 INFO - mozInstall == 1.13 17:15:27 INFO - mozcrash == 1.0 17:15:27 INFO - mozdebug == 0.1 17:15:27 INFO - mozdevice == 0.51 17:15:27 INFO - mozfile == 1.2 17:15:27 INFO - mozhttpd == 0.7 17:15:27 INFO - mozinfo == 0.10 17:15:27 INFO - mozleak == 0.1 17:15:27 INFO - mozlog == 3.5 17:15:27 INFO - moznetwork == 0.27 17:15:27 INFO - mozprocess == 0.25 17:15:27 INFO - mozprofile == 0.28 17:15:27 INFO - mozrunner == 6.13 17:15:27 INFO - mozscreenshot == 0.1 17:15:27 INFO - mozsystemmonitor == 0.3 17:15:27 INFO - moztest == 0.8 17:15:27 INFO - mozversion == 1.4 17:15:27 INFO - psutil == 3.1.1 17:15:27 INFO - requests == 1.2.3 17:15:27 INFO - wsgiref == 0.1.2 17:15:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:27 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:27 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:15:27 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:15:27 INFO - Using env: {'DISPLAY': ':0', 17:15:27 INFO - 'HOME': '/home/cltbld', 17:15:27 INFO - 'LANG': 'en_US.UTF-8', 17:15:27 INFO - 'LANGUAGE': 'en_US:en', 17:15:27 INFO - 'LOGNAME': 'cltbld', 17:15:27 INFO - 'MAIL': '/var/mail/cltbld', 17:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:27 INFO - 'MOZ_NO_REMOTE': '1', 17:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:27 INFO - 'NO_EM_RESTART': '1', 17:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:27 INFO - 'PWD': '/builds/slave/test', 17:15:27 INFO - 'SHELL': '/bin/bash', 17:15:27 INFO - 'SHLVL': '1', 17:15:27 INFO - 'TERM': 'linux', 17:15:27 INFO - 'TMOUT': '86400', 17:15:27 INFO - 'USER': 'cltbld', 17:15:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:27 INFO - '_': '/tools/buildbot/bin/python'} 17:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:15:27 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:15:27 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:15:27 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:15:27 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:15:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:15:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:15:29 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:15:29 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:15:29 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:15:29 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:15:29 INFO - Installing collected packages: marionette-driver, simplejson 17:15:29 INFO - Running setup.py install for marionette-driver 17:15:29 INFO - Running setup.py install for simplejson 17:15:29 INFO - building 'simplejson._speedups' extension 17:15:29 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:15:30 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:15:30 INFO - Successfully installed marionette-driver simplejson 17:15:30 INFO - Cleaning up... 17:15:30 INFO - Return code: 0 17:15:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:30 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:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:30 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:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:30 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 0x1adc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, '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': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', '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:15:30 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:15:30 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:15:30 INFO - Using env: {'DISPLAY': ':0', 17:15:30 INFO - 'HOME': '/home/cltbld', 17:15:30 INFO - 'LANG': 'en_US.UTF-8', 17:15:30 INFO - 'LANGUAGE': 'en_US:en', 17:15:30 INFO - 'LOGNAME': 'cltbld', 17:15:30 INFO - 'MAIL': '/var/mail/cltbld', 17:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:30 INFO - 'MOZ_NO_REMOTE': '1', 17:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:30 INFO - 'NO_EM_RESTART': '1', 17:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:30 INFO - 'PWD': '/builds/slave/test', 17:15:30 INFO - 'SHELL': '/bin/bash', 17:15:30 INFO - 'SHLVL': '1', 17:15:30 INFO - 'TERM': 'linux', 17:15:30 INFO - 'TMOUT': '86400', 17:15:30 INFO - 'USER': 'cltbld', 17:15:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:30 INFO - '_': '/tools/buildbot/bin/python'} 17:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:15:30 INFO - Cleaning up... 17:15:30 INFO - Return code: 0 17:15:30 INFO - Running post-action listener: _resource_record_post_action 17:15:30 INFO - Running post-action listener: _start_resource_monitoring 17:15:30 INFO - Starting resource monitoring. 17:15:30 INFO - [mozharness: 2017-07-19 00:15:30.504916Z] Finished create-virtualenv step (success) 17:15:30 INFO - [mozharness: 2017-07-19 00:15:30.505432Z] Running install step. 17:15:30 INFO - Running pre-action listener: _resource_record_pre_action 17:15:30 INFO - Running main action method: install 17:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:30 INFO - Reading from file tmpfile_stdout 17:15:30 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:30 INFO - Reading from file tmpfile_stdout 17:15:30 INFO - Output received: 17:15:30 INFO - Usage: mozinstall [options] installer 17:15:30 INFO - Options: 17:15:30 INFO - -h, --help show this help message and exit 17:15:30 INFO - -d DEST, --destination=DEST 17:15:30 INFO - Directory to install application into. [default: 17:15:30 INFO - "/builds/slave/test"] 17:15:30 INFO - --app=APP Application being installed. [default: firefox] 17:15:30 INFO - mkdir: /builds/slave/test/build/application 17:15:30 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:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:15:48 INFO - Reading from file tmpfile_stdout 17:15:48 INFO - Output received: 17:15:48 INFO - /builds/slave/test/build/application/firefox/firefox 17:15:48 INFO - Running post-action listener: _resource_record_post_action 17:15:48 INFO - [mozharness: 2017-07-19 00:15:48.779655Z] Finished install step (success) 17:15:48 INFO - [mozharness: 2017-07-19 00:15:48.779893Z] Running setup-mitmproxy step. 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running main action method: setup_mitmproxy 17:15:48 INFO - Skipping: mitmproxy is not required 17:15:48 INFO - Running post-action listener: _resource_record_post_action 17:15:48 INFO - [mozharness: 2017-07-19 00:15:48.780436Z] Finished setup-mitmproxy step (success) 17:15:48 INFO - [mozharness: 2017-07-19 00:15:48.780541Z] Running run-tests step. 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running pre-action listener: _set_gcov_prefix 17:15:48 INFO - Running main action method: run_tests 17:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:48 INFO - Python 2.7.3 17:15:48 INFO - Return code: 0 17:15:48 INFO - grabbing minidump binary from tooltool 17:15: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:15:48 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 0x1e4ad00>, '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 0x1e4bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:48 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:15:48 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:15:48 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:15:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:48 INFO - Return code: 0 17:15:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:15:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:48 INFO - ENV: RUST_BACKTRACE is now 1 17:15:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:15:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:48 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:15:48 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test', 17:15:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:48 INFO - 'RUST_BACKTRACE': '1', 17:15:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:48 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:15:49 INFO - mozversion application_buildid: 20170718233341 17:15:49 INFO - mozversion application_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:15:49 INFO - mozversion application_display_name: Nightly 17:15:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:49 INFO - mozversion application_name: Firefox 17:15:49 INFO - mozversion application_remotingname: firefox 17:15:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:15:49 INFO - mozversion application_vendor: Mozilla 17:15:49 INFO - mozversion application_version: 56.0a1 17:15:49 INFO - mozversion platform_buildid: 20170718233341 17:15:49 INFO - mozversion platform_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:15:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:15:49 INFO - mozversion platform_version: 56.0a1 17:15:49 INFO - using testdate: 1500423349 17:15:49 INFO - actual date: 1500423349 17:15:49 INFO - starting webserver on 'localhost:60191' 17:15:49 INFO - SUITE-START | Running 2 tests 17:15:49 INFO - TEST-START | dromaeo_css 17:15:49 INFO - Initialising browser for dromaeo_css test... 17:15:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60191/getInfo.html -profile /tmp/tmp3ND3vt/profile 17:15:49 INFO - TEST-INFO | started process 11181 (/builds/slave/test/build/application/firefox/firefox http://localhost:60191/getInfo.html) 17:15:55 INFO - TEST-INFO | 11181: exit 0 17:15:55 INFO - Browser initialized. 17:15:55 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:55 INFO - TEST-INFO | started process 11450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ND3vt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:06 INFO - PID 11450 | RSS: Main: 176254976 17:16:06 INFO - PID 11450 | 17:19:05 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60191/tests/dromaeo/cssquery-ext.html) 17:19:06 INFO - PID 11450 | RSS: Main: 179347456 17:19:06 INFO - PID 11450 | 17:22:08 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-ext.html (next: http://localhost:60191/tests/dromaeo/cssquery-jquery.html) 17:22:08 INFO - PID 11450 | RSS: Main: 178139136 17:22:08 INFO - PID 11450 | 17:25:10 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60191/tests/dromaeo/cssquery-mootools.html) 17:25:11 INFO - PID 11450 | RSS: Main: 180195328 17:25:11 INFO - PID 11450 | 17:28:12 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60191/tests/dromaeo/cssquery-prototype.html) 17:28:13 INFO - PID 11450 | RSS: Main: 178880512 17:28:13 INFO - PID 11450 | 17:31:16 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60191/tests/dromaeo/cssquery-yui.html) 17:31:17 INFO - PID 11450 | RSS: Main: 178098176 17:31:17 INFO - PID 11450 | 17:34:18 INFO - PID 11450 | Cycle 1(1): loaded http://localhost:60191/tests/dromaeo/cssquery-yui.html (next: http://localhost:60191/tests/dromaeo/cssquery-dojo.html) 17:34:19 INFO - PID 11450 | RSS: Main: 182464512 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | __start_tp_report 17:34:19 INFO - PID 11450 | _x_x_mozilla_page_load 17:34:19 INFO - PID 11450 | _x_x_mozilla_page_load_details 17:34:19 INFO - PID 11450 | |i|pagename|runs| 17:34:19 INFO - PID 11450 | |0;dojo.html;3095.9380812383765;3152.4956007038872;3170.984145079274;3175.3966746318197;3210.133264018715;6055.122007308938;6092.817215483537;6126.356732543086;6138.048602466619;6160.907586386196;6154.692265386724;6191.752329906798;6199.752009919598;6199.876002479948;6216.409441103088;5619.7471113799975;5636.15457681347;5648.435156484339;5661.433856614347;5685.317761868561;5660.462256085665;5666.688332141731;5676.631018983753;5687.8578035549235;5690.174924635925;5662.631928924628;5663.8584035399035;5667.8583035424235;5679.943200568004;5691.772329106851;5659.51894089003;5671.7447714852515;5682.090865461527;5686.289213848289;5693.402192769741;5529.778808847641;5656.575756818255;5671.489565939044;5677.574181936371;5747.195392645033;6108.633481991051;6126.785562505291;6173.506119510428;6186.9381306186815;6250.7812226572305;6479.838004049937;6546.214454265519;6568.901466478007;6658.300878407746;6669.966650166767;6591.93408065918;6619.437347825441;6626.370494802986;6632.63520506372;6640.33596640337;6087.969560152215;6114.8777024459705;6142.293636231846;6155.261368635747;6158.938410615881;6771.5259931805285;6775.186977562675;6779.559328643622;6827.2831352708245;6855.108835851407;6359.777407790705;6416.230052393743;6421.197350331208;6458.644774537445;6530.379613936669;6393.488520918316;6596.142501474777;6650.900236496456;6661.866762664817;6676.232233293234;6441.033844923205;6443.48452123829;6447.9355206447335;6485.578437401554;6488.026795980641;6543.541952063405;6547.705353259114;6579.374959378852;6633.137692100093;6650.567713098633;5211.114110601206;5254.816081437131;5284.207368894697;5355.009323275207;5362.383325917492;4509.233430316854;4530.320451932171;4558.566936141061;4565.611922986517;4567.497575266718;5728.312602487728;5749.3963133871175;5760.36635970043;5760.913586296209;5762.423757624204;6585.80242592723;6586.242582103024;6597.208334999735;6597.80206593803;6610.471162307004;5644.463775941361;5719.170720245541;5741.913871291934;5743.023685973395;5758.568107391879;5765.942340576625;5825.0388685866355;5833.854153646108;5839.328477225174;5840.5035571976005;5402.162664786964;6343.619382836952;6426.485881129498;6451.1290975717675;6483.0275458680635;6633.237177724527;6638.336166383516;6684.966575167093;6703.363180497845;6715.56348837324;6369.585976911486;6381.680915954276;6457.321981191907;6471.838204044937;6492.870142597028;6416.13382193398;6444.645544495098;6497.057926600711;6520.869582608416;6547.770828021187;5630.549556035426;6601.306862779339;6628.767993120217;6665.900011499734;6750.29121942189;6420.711068002044;6443.226812782496;6490.675466226576;6513.641749703812;6522.836929076621;6426.871462570629;6455.9677201613695;6500.609963402211;6535.967320163369;6557.540972131905;6301.212348456443;6371.808845734636;6392.488600912009;6393.200849893763;6421.068945003042;6408;6411.0397448699305;6434.549581529435;6443.291237963726;6461.127747753993;5375.16424865552;6270.122182894307;6278.654673992792;6287.779927702692;6354.872902541831 17:34:19 INFO - PID 11450 | |1;ext.html;745.1095940351279;772.119783446871;784.3607459920165;808.6926967752255;815.188887057378;41046.38430423542;41621.3756793648;41871.58128418715;41873.37189942153;41934.370984435256;38258.23483530328;38505.807470962674;38591;38704.80647596765;38725.41911871317;6802.7959161225;6900.275471075515;6918.75784347548;6935.479839012069;6951.2701166377565;6788.355106264897;6890.793276201722;6893.448524118058;6900.551464154839;6903.689333979958;6870.4503639708955;6884.586924784504;6890.7588234411805;6890.896636550456;6920.4809639277255;6795.7961261162245;6830.726770929182;6841.2132604750095;6849.7602583909575;6867.244603093655;6230.2523697156175;6233.470155036827;6291.748330066792;6294.402031806971;6302.149209856657;34201.82899085514;34613.480797788055;34666.306673866384;34885.12787180315;35027.82486087553;3417.5044618530424;3462.8441720122655;3468.7225021998433;3583.426651735736;3673.1918977824835;31255.68744312573;31283.530747038814;31347.37305253882;31452;31664.36671266562;4864.075825593126;4869.14789911764;4938.80244790208;4942.827001054981;5018.422881368653;193757;195962;196743;198410.00794996077;199184;47730.761346193045;48521;48690;48908.7554562232;48922;50743.492565074615;50862.491375085774;50872;50879.74560127176;51314.74342628263;16301.266443010092;16425.1787410629;16456.09491477956;16478.34086636521;16542;13667.521636742866;13685.178889266477;13734.244616546186;13761.243131627656;13795.517156899461;14143.949127376678;14241.145531268157;14275.571732848031;14362;14480.565583032527;5685.488306052475;5755.740991655385;5784.1902133701315;5794.768209271582;5830.542364408898;972.003696211389;979.9314048016571;1002.293383164867;1010.4897027001317;1035.4874337202982;22447.32658020262;22992.540149197255;22999.770002299763;23266;23387.298381048597;1093.4040947683532;1095.769888323445;1109.2678831970861;1111.1666250312267;1117.9944100279608;12026.684298303764;12072.3360215189;12557.811632825515;15639.843601564065;16091.678166436606;233468;235176;236041;236554;236791;57258;57276.42723572711;57284.42715572874;57531.13703294454;57636.135457968165;1408.2114016150988;1477.4016523308078;1499.9625009374636;1504.1877386211324;1507.2237797534278;26676.466470670865;27603.72396276092;27866.721332787223;27871.72128278691;27932.44135117327;37953.62046379501;38296.61703382931;38324.6167538321;38439;38512.422313664756;199238;204387;204614;205129;205668;29934.70065299319;30400.84799575988;33403.16492087717;33959;34939.30121397608;40854;44587.554124458344;45303.54696452993;45342;45982;30988.380232394775;32161.517577235893;32295.838520808185;32794.83602581972;33235.169120772174;31471;32005.839970799996;32199.034028979167;32768.344633106724;33589.16027099342;37579.06052348604;37868.431973519866;38060.80969595134;38187.2362552753;38566.42150367691;31083.912063077685;33191;33264.334713305114;33369.499457508646;34083;24481.143159989315;24707.135250266154;24782.256532304058;24876.12933547317;24910.501789963735 17:34:19 INFO - PID 11450 | |2;jquery.html;563.9802606908759;571.1603942204957;577.8526475748683;581.4737662415514;601.359552077038;22161.55676886461;23118.65322020169;23171;23206.65190022151;23216.41958951027;23889.402764930885;25182.496350072986;25976.35059123523;26235.606465903027;26339.60490592638;6462.612243265396;6605.834854128661;6606.603603783764;6608.339166083378;6627.668616569176;6501.284858665543;6521.510886683494;6546.476281897437;6551.475881929434;6574.835629109262;5667.121596152582;6174.783882564111;6183.845403864894;6533.738650453976;6546;6297.968510157443;6345.333739957284;6348.746050157988;6349.841253968688;6356.745730170787;5851.795187168471;5863.794767183171;5865.266841644794;5885.470307672287;5895.587308888379;29034.693438795304;29074.70925290741;29605;29690;29766.851165744032;1905.9904700476548;1952.492351988479;1957.1877670766614;1959.4513536209884;1964.6463636545416;18305.450836474927;18954.14706338218;19028.904855475772;19071.2371505141;19129.521761955923;2279.065583110933;2285.931422057341;2347.3779448446176;2394.928152155438;2395.3173345596597;136142;138508.30745846208;139419;140592;143658;14282.714345713028;14766;14955.130608673915;15119.749253910462;15270.31283592241;23796.405089872893;23799.40501487442;23860.284191474282;23962.161324353565;24006.87996560006;10449.111825494767;10570.577176912837;10590.57637694499;10595.682129536126;10621.256512044238;9802.852957205647;9873;9910.10809027191;9938.403695778277;9974.650887218913;8980.820383592421;9150.313726470542;9181.678641247525;9284.118008789153;9580.13778759915;2571.614257861336;2575.2531765788085;2706.6751989761356;2736.0834120569434;2879.4385094906293;928.3084102343797;948.7201275623707;954.71358592422;983.1201075037944;1000.1948431512702;19789;19797.697942099814;19945.301914433214;20582.794172058388;20676.06957686908;1011.7066050845173;1017.2472370445817;1042.4527123260198;1044.0916402729522;1050.1703654113164;10951;11013.724656883642;11015.228933974546;11115.777684446266;11258.16586046982;470860;480222;480229;487240;487666;110843;113580.43209783899;114038;114259.42870285595;114831.42584287192;1175.5591653130077;1182.131133616791;1197.9520819167135;1201.1351826684772;1211.54567037361;17026;17748.3788067417;17886.5528361792;18466.169022393755;18467.445976620722;52546.73726631342;52872.471275286756;53405;54480.45519544754;56084.719576401854;68869;71202.93195601966;71421.6428917852;71791;72038.63980680062;14460.783088253895;14467.421303147756;14671.413143474141;14678.633034173803;14732.55802325932;22630.434239144153;23063.19278825233;23156.421089472897;23188.072477101403;23384.883075584512;19222.711659324843;19276.22895084181;19449.8055019448;19475.123619437443;19656.508587285432;15197.316120774813;16983.79210702601;17213.56966075808;17572.209250584012;18086.095695214924;18806.623867522845;19020.619587608446;19028.524286892938;19104.522386939883;20457.18171273192;14881.85118148848;15138;15200.847991520386;15202.239888005777;15214.847851521787;18513.9074304633;19301.90349048246;19415.2233910642;19440.416787496397;19603.411897643095 17:34:19 INFO - PID 11450 | |3;mootools.html;1331.7203387288669;1382.5506710319148;1388.8333399992002;1416.2847761880244;1421.815164028676;13237.271950042743;13930.651733706638;14014.579562613113;14022.509212177576;14023.298835058244;13657.863421365784;14096.78854817176;14453.349599268033;14465.63835904103;14498.347574359153;2535.201411555359;2601.3756698392344;2604.28382194897;2616.921492355232;2618.515574618692;2524.936876578091;2554;2555.501677172952;2561.180422264876;2564.1538292363475;2528.8609126498036;2539.162076514755;2561.4236796720684;2572.164046684835;2581.5224183526016;2514.6228065790187;2645.6163856240833;2738.835669859815;2742.1773467959533;2742.5886117082396;2593.9481210375875;2599.285196570939;2635.4729054189047;2648.0599387217453;2650.045983445958;13402.46390144393;13534.120282181626;13652.726945461134;13653.522126725617;13736.65658358539;7147.571145731221;7400.962995184989;7427.888581671279;7442.03253577037;7442.925570744277;4893.657443978923;5020.623453240985;5132.435432102466;5149.588032957355;5151.484851514856;1718.6133120048014;1798.0919635583946;1823.2889173222454;1852.6202128563611;1860.7301941218448;22350.441238968993;22679.319620411414;22703.886480567493;22721.091156353727;22737.88631056834;5961.821145365646;6008.519318454601;6078.696065196723;6133.202683651186;6197.96901015492;15253;15304.158271294962;15311.540653780405;15371.308291126927;15385;7163.928360716326;7325.2308507607;7329.267073292628;7334.3765779908235;7339.559626422431;6687.130673012574;6717.966410167918;6745.93254067453;6766.661666916634;6858.5199036068;4630.560096790799;4753.168195565762;4818.301346304766;4881.365422495124;4885.096257192431;1351.8039884216732;1352.8241328627216;1357.0432844844559;1367.699106196635;1371.067673981682;870.6256309786852;873.9563021848882;907.3240435875183;921.6866265469772;923.6490133749267;8064.879026814602;8079.555624440594;8177.304929080976;8266.008079030435;8547.316214702809;980.857775622545;980.9852852207223;998.0468652436905;998.3410948773775;1001.6744558018673;5095.108356037678;5166.741662916839;5195.402528709171;5223.399309079505;5354.598405119632;18066.548336291435;18356.958024002102;19123.139458724392;19146.138423770964;19444.51388715265;19096.140673669717;19433.31983380575;19476.318328858422;19565.902170489342;19569.706454403196;10329.586816527404;10808.081313088476;10854.131669466424;11032.44837758109;11055.447227638746;7745.22547745221;8356.33149348063;8434.325253979545;8534.402591818513;8630.870536941826;16077.67844643124;16186.514404567883;16499.010059396474;16700.331986720394;16863.409780657617;16395.180240988142;16721.832781672027;17286.22212000488;17326.30694772195;17397.913010434866;10899;11124.054455371384;11185.32888026721;11186.272892261977;11197;12968.546100886424;13096.541621043218;13101.606951791462;13112.278824664734;13118.147320424141;9959.701208963743;10054.748631284276;10504.317219380715;10687.679369618923;10804.67585972422;9824.361416507903;10369.63706270277;10382.844257336297;10387.169026477712;10422.114120299557;9384.436933783994;9492.57283422234;9500.334976551852;9546.427214366882;9548.42709437436;6907.6891539879825;7049.506534542533;7109.537880037781;7129.215786263403;7271.781846544613;6922.480813938874;7304.926950730637;7305.086864141982;7361.190269070291;7365.447591430771 17:34:19 INFO - PID 11450 | |4;prototype.html;476.51157563497435;489.1928318274847;499.32341677027625;502.9119904016797;508.4483335580895;6000.249968753906;6009.0685943678745;6048.193734015351;6067;6145.231846019242;5774.971125144379;6047.727852246649;6058.878822423549;6068.6965651717455;6088.782243551285;4882.951170488285;4937.5065591876055;4955.4548999610015;4956.553910148086;4971.433998290545;4882.731449770261;4897.094037603037;4899.828506002291;4929.309896614477;4936.876578085541;4801.879953001168;4839.927401088987;4868.0750657375165;4874.927515946504;4894.241392584137;4644.465886423054;4798.424189097331;4804.183288840905;4878;4894.535019173173;4312.935305970413;4318.114786468766;4341.392205091258;4367.410399596046;4385;5859.355470898197;5882.323532793741;5919.644821310692;5961.5230781537375;5982.760689572412;5475.056354994;5497.422770609069;5532.225488431623;5539.723013849291;5601.851620417805;6347.270063942659;6367.5861069030825;6438.517111216631;6458.90311645321;6460.126563296639;4697.436307643071;4731.739754313511;4752.4297084349755;4777.28340748887;4791.712497250176;6605.70274337656;6624.966875165642;6675.499337549703;6680.465562755016;6705.6982435790505;4815.3499277597775;4901.3383193269165;4912.140375434285;4925.13810083234;4925.532074452921;4953.526353379464;4959.404871415453;4970.875728106754;4988.251762235694;5011.173156429149;5479.150731636602;5486.670799752028;5491.341039075336;5511.614187006951;5569.275994120739;6407.807765767035;6433.5496515243485;6434.806955791334;6469.897283382826;6470.9029364559565;1697.2532085882171;1703.872209584286;1704.5994191365019;1707.846293833561;1715.7254839225664;1101.6750058732694;1190.7678002789373;1201.1831954271179;1201.597464849268;1204.981790387139;5460.672359658433;5559.831665650399;5615.213870058195;5658.462446067617;5684.204211410406;6476.902846457307;6550.246721626979;6574.243961944342;6580.676758237059;6621.702637889669;5618.0449323615085;5648.881669373985;5664;5667.291588551431;5721.628094173865;3408.7954722716718;3427.4687423449404;3478.243497023209;3485.877994270239;3556.519869817593;6253.249610046823;6273.937260627426;6286.339934306832;6331.497175846636;6434.806955791334;6577.736890524421;6639.170103737033;6665.900011499832;6770.52606317553;6773.221079575912;6292.811215663537;6334.873302533923;6348.904766428415;6367.140436041075;6373.936260637334;6484.351564843478;6498.285188629342;6563.7702680405955;6564.409203171737;6634.900476492953;6361.491080713625;6374.840628984312;6464.709088091141;6470.255920569195;6523.347665233438;6261.812145635638;6294.527910406646;6328.303886572381;6337.96831015842;6362.681865906594;4866.197077482318;4877.487863774252;4903.215485522299;4908.214685650421;4918.188498897642;6545.345465453607;6584.62122688426;6584.736610535525;6586.946088625797;6649.368310010541;6317.210348706411;6344.492440604833;6388.265349484869;6393.520485963479;6400.167978162809;6327.841803954938;6334.968325158345;6343.143675603735;6394.145697747601;6408.61010208009;6226.813195604139;6230.937690623217;6242.531810114168;6295.931774921232;6318.925782616874;6296.779612713533;6323.715432805443;6346.446858998376;6377.362263773585;6431.485481161402;6127.938720612737;6221.377862213742;6222.906656400248;6240.375962403723;6281 17:34:19 INFO - PID 11450 | |5;yui.html;913.3469569257979;919.7102912582536;932.7201839448164;937.5640327247828;938.4088024544534;16586.33654653814;16677.332906683747;16729;16768.07775572343;18858.33995810147;19933.20267189311;20740;21496.140154393845;21532.354029379105;21539.24612638558;1008.2337423558075;1024.1499555369064;1032.6747074671491;1035.0684384054373;1038.392540363888;1036.8341065429534;1037.2272656870641;1043.1029314789275;1043.2853495355705;1046.3512622174262;783.8824176373532;965;1032.1433210435357;1093.3276035238312;1105.8451816745662;1085.0560012788924;1086.3156211586688;1087.690008347617;1090.0189829153746;1094.60047082815;799.2007992007992;800.1518390506083;800.6917336825306;805.1827395193883;809.5062012172571;18963.33628323002;19436.80563194364;19739.309124180585;19821.603567928705;19961.600767984703;18386.90806545972;18656.906715466335;18897.81102188988;18977.620447591107;18981.62036759257;15716.135612541306;16356.672866542602;16421.671566568602;16425;16432.589185270343;3534.1341371363924;3546.929061418783;3571.2678900825267;3572.964270357289;3589.2821435712963;122823.38588307002;125865;130453.34773326167;130755.34622326923;132202;14898.25508724581;15805.051696898223;15945.202739863193;16082.195890205443;16176.433824816075;28125.718742812718;28138.85930570334;28170;28442.857785710938;28450.715492845222;8249.587520623945;8391.035030971516;8614.138586141336;8621.741347759576;8671.393002489765;3947.743396679207;4031.475908131924;4123.422720819088;4129.752214867118;4130.359794231838;5131.743412829418;5160.819371321985;5182.067227898939;5188.351456067991;5259.8422047338645;947.8199142162968;950.8193443245762;968.1577027985697;971.4511301114848;988.5255077562811;604.3080672629815;674.4638012779852;690.8169335126196;699.2727563334075;701.7158050989358;10901.781964360669;11145.442727863574;11276.718082048015;11319.434028298552;11518.193726439236;601.6931365003792;639.9072134540465;661.3981277037873;665.0489799586541;675.0684056002783;5390.946090539122;5411.080116380225;5450;5473.698946557977;5477.67133971963;97083;103929;104712;110304;111730;84890;89715;91697;92074;92092.53953730188;82025;82179;82463.58768206241;84549.57725211335;85517.57241213879;11241.269317494336;11763.764724705286;11839.76320473603;12349.135560510678;12378;34341.656583434844;35851.28297433985;36120;36492.81753591215;37580;45619;47185.52814471811;47345;47476.7626161867;49003.75498122487;17584;18006.72989905179;18131.36540221086;18486.260549577866;18554.44336669902;20367.69448458304;20495;20578.58842823105;20622.38132856017;20865.165393384093;15118.697626047637;15827.208639567745;15863.52409427719;16027.839721602635;16210;18255.726164107284;18361.265549377877;18446.81553184451;18538.907305463385;19053.333133340268;18136.18387172607;18241;18252.908735456767;18351.449456516326;18407.355742549484;12027.338496382783;12261.938690306491;12815.551455699006;12940.029497787891;12987.610371688865;12576.559820406243;12818.166819156724;12850.742985140432;12895.935520322339;13001.479940802263 17:34:19 INFO - PID 11450 | __end_tp_report 17:34:19 INFO - PID 11450 | __start_cc_report 17:34:19 INFO - PID 11450 | _x_x_mozilla_cycle_collect,355 17:34:19 INFO - PID 11450 | __end_cc_report 17:34:19 INFO - PID 11450 | __startTimestamp1500424459145__endTimestamp 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | ------- Summary: start ------- 17:34:19 INFO - PID 11450 | Number of tests: 6 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#0] dojo.html Cycles:165 Average:6063.45 Median:6343.62 stddev:713.13 (11.2%) stddev-sans-first:676.26 17:34:19 INFO - PID 11450 | Values: 3095.9 3152.5 3171.0 3175.4 3210.1 6055.1 6092.8 6126.4 6138.0 6160.9 6154.7 6191.8 6199.8 6199.9 6216.4 5619.7 5636.2 5648.4 5661.4 5685.3 5660.5 5666.7 5676.6 5687.9 5690.2 5662.6 5663.9 5667.9 5679.9 5691.8 5659.5 5671.7 5682.1 5686.3 5693.4 5529.8 5656.6 5671.5 5677.6 5747.2 6108.6 6126.8 6173.5 6186.9 6250.8 6479.8 6546.2 6568.9 6658.3 6670.0 6591.9 6619.4 6626.4 6632.6 6640.3 6088.0 6114.9 6142.3 6155.3 6158.9 6771.5 6775.2 6779.6 6827.3 6855.1 6359.8 6416.2 6421.2 6458.6 6530.4 6393.5 6596.1 6650.9 6661.9 6676.2 6441.0 6443.5 6447.9 6485.6 6488.0 6543.5 6547.7 6579.4 6633.1 6650.6 5211.1 5254.8 5284.2 5355.0 5362.4 4509.2 4530.3 4558.6 4565.6 4567.5 5728.3 5749.4 5760.4 5760.9 5762.4 6585.8 6586.2 6597.2 6597.8 6610.5 5644.5 5719.2 5741.9 5743.0 5758.6 5765.9 5825.0 5833.9 5839.3 5840.5 5402.2 6343.6 6426.5 6451.1 6483.0 6633.2 6638.3 6685.0 6703.4 6715.6 6369.6 6381.7 6457.3 6471.8 6492.9 6416.1 6444.6 6497.1 6520.9 6547.8 5630.5 6601.3 6628.8 6665.9 6750.3 6420.7 6443.2 6490.7 6513.6 6522.8 6426.9 6456.0 6500.6 6536.0 6557.5 6301.2 6371.8 6392.5 6393.2 6421.1 6408.0 6411.0 6434.5 6443.3 6461.1 5375.2 6270.1 6278.7 6287.8 6354.9 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#1] ext.html Cycles:180 Average:38230.20 Median:19064.58 stddev:55187.36 (289.5%) stddev-sans-first:55270.40 17:34:19 INFO - PID 11450 | Values: 745.1 772.1 784.4 808.7 815.2 41046.4 41621.4 41871.6 41873.4 41934.4 38258.2 38505.8 38591.0 38704.8 38725.4 6802.8 6900.3 6918.8 6935.5 6951.3 6788.4 6890.8 6893.4 6900.6 6903.7 6870.5 6884.6 6890.8 6890.9 6920.5 6795.8 6830.7 6841.2 6849.8 6867.2 6230.3 6233.5 6291.7 6294.4 6302.1 34201.8 34613.5 34666.3 34885.1 35027.8 3417.5 3462.8 3468.7 3583.4 3673.2 31255.7 31283.5 31347.4 31452.0 31664.4 4864.1 4869.1 4938.8 4942.8 5018.4 193757.0 195962.0 196743.0 198410.0 199184.0 47730.8 48521.0 48690.0 48908.8 48922.0 50743.5 50862.5 50872.0 50879.7 51314.7 16301.3 16425.2 16456.1 16478.3 16542.0 13667.5 13685.2 13734.2 13761.2 13795.5 14143.9 14241.1 14275.6 14362.0 14480.6 5685.5 5755.7 5784.2 5794.8 5830.5 972.0 979.9 1002.3 1010.5 1035.5 22447.3 22992.5 22999.8 23266.0 23387.3 1093.4 1095.8 1109.3 1111.2 1118.0 12026.7 12072.3 12557.8 15639.8 16091.7 233468.0 235176.0 236041.0 236554.0 236791.0 57258.0 57276.4 57284.4 57531.1 57636.1 1408.2 1477.4 1500.0 1504.2 1507.2 26676.5 27603.7 27866.7 27871.7 27932.4 37953.6 38296.6 38324.6 38439.0 38512.4 199238.0 204387.0 204614.0 205129.0 205668.0 29934.7 30400.8 33403.2 33959.0 34939.3 40854.0 44587.6 45303.5 45342.0 45982.0 30988.4 32161.5 32295.8 32794.8 33235.2 31471.0 32005.8 32199.0 32768.3 33589.2 37579.1 37868.4 38060.8 38187.2 38566.4 31083.9 33191.0 33264.3 33369.5 34083.0 24481.1 24707.1 24782.3 24876.1 24910.5 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#2] jquery.html Cycles:180 Average:34552.49 Median:23090.92 stddev:81184.43 (351.6%) stddev-sans-first:81372.06 17:34:19 INFO - PID 11450 | Values: 564.0 571.2 577.9 581.5 601.4 22161.6 23118.7 23171.0 23206.7 23216.4 23889.4 25182.5 25976.4 26235.6 26339.6 6462.6 6605.8 6606.6 6608.3 6627.7 6501.3 6521.5 6546.5 6551.5 6574.8 5667.1 6174.8 6183.8 6533.7 6546.0 6298.0 6345.3 6348.7 6349.8 6356.7 5851.8 5863.8 5865.3 5885.5 5895.6 29034.7 29074.7 29605.0 29690.0 29766.9 1906.0 1952.5 1957.2 1959.5 1964.6 18305.5 18954.1 19028.9 19071.2 19129.5 2279.1 2285.9 2347.4 2394.9 2395.3 136142.0 138508.3 139419.0 140592.0 143658.0 14282.7 14766.0 14955.1 15119.7 15270.3 23796.4 23799.4 23860.3 23962.2 24006.9 10449.1 10570.6 10590.6 10595.7 10621.3 9802.9 9873.0 9910.1 9938.4 9974.7 8980.8 9150.3 9181.7 9284.1 9580.1 2571.6 2575.3 2706.7 2736.1 2879.4 928.3 948.7 954.7 983.1 1000.2 19789.0 19797.7 19945.3 20582.8 20676.1 1011.7 1017.2 1042.5 1044.1 1050.2 10951.0 11013.7 11015.2 11115.8 11258.2 470860.0 480222.0 480229.0 487240.0 487666.0 110843.0 113580.4 114038.0 114259.4 114831.4 1175.6 1182.1 1198.0 1201.1 1211.5 17026.0 17748.4 17886.6 18466.2 18467.4 52546.7 52872.5 53405.0 54480.5 56084.7 68869.0 71202.9 71421.6 71791.0 72038.6 14460.8 14467.4 14671.4 14678.6 14732.6 22630.4 23063.2 23156.4 23188.1 23384.9 19222.7 19276.2 19449.8 19475.1 19656.5 15197.3 16983.8 17213.6 17572.2 18086.1 18806.6 19020.6 19028.5 19104.5 20457.2 14881.9 15138.0 15200.8 15202.2 15214.8 18513.9 19301.9 19415.2 19440.4 19603.4 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#3] mootools.html Cycles:180 Average:8597.64 Median:2558.34 stddev:5847.37 (228.6%) stddev-sans-first:5838.28 17:34:19 INFO - PID 11450 | Values: 1331.7 1382.6 1388.8 1416.3 1421.8 13237.3 13930.7 14014.6 14022.5 14023.3 13657.9 14096.8 14453.3 14465.6 14498.3 2535.2 2601.4 2604.3 2616.9 2618.5 2524.9 2554.0 2555.5 2561.2 2564.2 2528.9 2539.2 2561.4 2572.2 2581.5 2514.6 2645.6 2738.8 2742.2 2742.6 2593.9 2599.3 2635.5 2648.1 2650.0 13402.5 13534.1 13652.7 13653.5 13736.7 7147.6 7401.0 7427.9 7442.0 7442.9 4893.7 5020.6 5132.4 5149.6 5151.5 1718.6 1798.1 1823.3 1852.6 1860.7 22350.4 22679.3 22703.9 22721.1 22737.9 5961.8 6008.5 6078.7 6133.2 6198.0 15253.0 15304.2 15311.5 15371.3 15385.0 7163.9 7325.2 7329.3 7334.4 7339.6 6687.1 6718.0 6745.9 6766.7 6858.5 4630.6 4753.2 4818.3 4881.4 4885.1 1351.8 1352.8 1357.0 1367.7 1371.1 870.6 874.0 907.3 921.7 923.6 8064.9 8079.6 8177.3 8266.0 8547.3 980.9 981.0 998.0 998.3 1001.7 5095.1 5166.7 5195.4 5223.4 5354.6 18066.5 18357.0 19123.1 19146.1 19444.5 19096.1 19433.3 19476.3 19565.9 19569.7 10329.6 10808.1 10854.1 11032.4 11055.4 7745.2 8356.3 8434.3 8534.4 8630.9 16077.7 16186.5 16499.0 16700.3 16863.4 16395.2 16721.8 17286.2 17326.3 17397.9 10899.0 11124.1 11185.3 11186.3 11197.0 12968.5 13096.5 13101.6 13112.3 13118.1 9959.7 10054.7 10504.3 10687.7 10804.7 9824.4 10369.6 10382.8 10387.2 10422.1 9384.4 9492.6 9500.3 9546.4 9548.4 6907.7 7049.5 7109.5 7129.2 7271.8 6922.5 7304.9 7305.1 7361.2 7365.4 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#4] prototype.html Cycles:180 Average:5371.90 Median:5991.51 stddev:1505.07 (25.1%) stddev-sans-first:1463.76 17:34:19 INFO - PID 11450 | Values: 476.5 489.2 499.3 502.9 508.4 6000.2 6009.1 6048.2 6067.0 6145.2 5775.0 6047.7 6058.9 6068.7 6088.8 4883.0 4937.5 4955.5 4956.6 4971.4 4882.7 4897.1 4899.8 4929.3 4936.9 4801.9 4839.9 4868.1 4874.9 4894.2 4644.5 4798.4 4804.2 4878.0 4894.5 4312.9 4318.1 4341.4 4367.4 4385.0 5859.4 5882.3 5919.6 5961.5 5982.8 5475.1 5497.4 5532.2 5539.7 5601.9 6347.3 6367.6 6438.5 6458.9 6460.1 4697.4 4731.7 4752.4 4777.3 4791.7 6605.7 6625.0 6675.5 6680.5 6705.7 4815.3 4901.3 4912.1 4925.1 4925.5 4953.5 4959.4 4970.9 4988.3 5011.2 5479.2 5486.7 5491.3 5511.6 5569.3 6407.8 6433.5 6434.8 6469.9 6470.9 1697.3 1703.9 1704.6 1707.8 1715.7 1101.7 1190.8 1201.2 1201.6 1205.0 5460.7 5559.8 5615.2 5658.5 5684.2 6476.9 6550.2 6574.2 6580.7 6621.7 5618.0 5648.9 5664.0 5667.3 5721.6 3408.8 3427.5 3478.2 3485.9 3556.5 6253.2 6273.9 6286.3 6331.5 6434.8 6577.7 6639.2 6665.9 6770.5 6773.2 6292.8 6334.9 6348.9 6367.1 6373.9 6484.4 6498.3 6563.8 6564.4 6634.9 6361.5 6374.8 6464.7 6470.3 6523.3 6261.8 6294.5 6328.3 6338.0 6362.7 4866.2 4877.5 4903.2 4908.2 4918.2 6545.3 6584.6 6584.7 6586.9 6649.4 6317.2 6344.5 6388.3 6393.5 6400.2 6327.8 6335.0 6343.1 6394.1 6408.6 6226.8 6230.9 6242.5 6295.9 6318.9 6296.8 6323.7 6346.4 6377.4 6431.5 6127.9 6221.4 6222.9 6240.4 6281.0 17:34:19 INFO - PID 11450 | 17:34:19 INFO - PID 11450 | [#5] yui.html Cycles:180 Average:22293.10 Median:19877.40 stddev:30646.42 (154.2%) stddev-sans-first:30690.34 17:34:19 INFO - PID 11450 | Values: 913.3 919.7 932.7 937.6 938.4 16586.3 16677.3 16729.0 16768.1 18858.3 19933.2 20740.0 21496.1 21532.4 21539.2 1008.2 1024.1 1032.7 1035.1 1038.4 1036.8 1037.2 1043.1 1043.3 1046.4 783.9 965.0 1032.1 1093.3 1105.8 1085.1 1086.3 1087.7 1090.0 1094.6 799.2 800.2 800.7 805.2 809.5 18963.3 19436.8 19739.3 19821.6 19961.6 18386.9 18656.9 18897.8 18977.6 18981.6 15716.1 16356.7 16421.7 16425.0 16432.6 3534.1 3546.9 3571.3 3573.0 3589.3 122823.4 125865.0 130453.3 130755.3 132202.0 14898.3 15805.1 15945.2 16082.2 16176.4 28125.7 28138.9 28170.0 28442.9 28450.7 8249.6 8391.0 8614.1 8621.7 8671.4 3947.7 4031.5 4123.4 4129.8 4130.4 5131.7 5160.8 5182.1 5188.4 5259.8 947.8 950.8 968.2 971.5 988.5 604.3 674.5 690.8 699.3 701.7 10901.8 11145.4 11276.7 11319.4 11518.2 601.7 639.9 661.4 665.0 675.1 5390.9 5411.1 5450.0 5473.7 5477.7 97083.0 103929.0 104712.0 110304.0 111730.0 84890.0 89715.0 91697.0 92074.0 92092.5 82025.0 82179.0 82463.6 84549.6 85517.6 11241.3 11763.8 11839.8 12349.1 12378.0 34341.7 35851.3 36120.0 36492.8 37580.0 45619.0 47185.5 47345.0 47476.8 49003.8 17584.0 18006.7 18131.4 18486.3 18554.4 20367.7 20495.0 20578.6 20622.4 20865.2 15118.7 15827.2 15863.5 16027.8 16210.0 18255.7 18361.3 18446.8 18538.9 19053.3 18136.2 18241.0 18252.9 18351.4 18407.4 12027.3 12261.9 12815.6 12940.0 12987.6 12576.6 12818.2 12850.7 12895.9 13001.5 17:34:19 INFO - PID 11450 | -------- Summary: end -------- 17:34:19 INFO - PID 11450 | 17:34:19 INFO - TEST-INFO | 11450: exit 0 17:34:19 INFO - TEST-OK | dromaeo_css | took 1110724ms 17:34:19 INFO - TEST-START | kraken 17:34:19 INFO - Initialising browser for kraken test... 17:34:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60191/getInfo.html -profile /tmp/tmpNOLp9r/profile 17:34:19 INFO - TEST-INFO | started process 11862 (/builds/slave/test/build/application/firefox/firefox http://localhost:60191/getInfo.html) 17:34:25 INFO - TEST-INFO | 11862: exit 0 17:34:25 INFO - Browser initialized. 17:34:25 INFO - Running cycle 1/1 for kraken test... 17:34:25 INFO - TEST-INFO | started process 12133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOLp9r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:37 INFO - PID 12133 | RSS: Main: 175456256 17:34:37 INFO - PID 12133 | 17:34:39 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60191/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:40 INFO - PID 12133 | RSS: Main: 179695616 17:34:40 INFO - PID 12133 | 17:34:43 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60191/tests/kraken/driver.html?testName=audio-dft) 17:34:43 INFO - PID 12133 | RSS: Main: 179568640 17:34:43 INFO - PID 12133 | 17:34:46 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60191/tests/kraken/driver.html?testName=audio-fft) 17:34:47 INFO - PID 12133 | RSS: Main: 173834240 17:34:47 INFO - PID 12133 | 17:34:49 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60191/tests/kraken/driver.html?testName=audio-oscillator) 17:34:50 INFO - PID 12133 | RSS: Main: 174637056 17:34:50 INFO - PID 12133 | 17:34:52 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60191/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:52 INFO - PID 12133 | RSS: Main: 175001600 17:34:52 INFO - PID 12133 | 17:34:55 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60191/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:56 INFO - PID 12133 | RSS: Main: 178475008 17:34:56 INFO - PID 12133 | 17:35:00 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60191/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:00 INFO - PID 12133 | RSS: Main: 177876992 17:35:00 INFO - PID 12133 | 17:35:03 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60191/tests/kraken/driver.html?testName=json-parse-financial) 17:35:04 INFO - PID 12133 | RSS: Main: 177750016 17:35:04 INFO - PID 12133 | 17:35:05 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60191/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:06 INFO - PID 12133 | RSS: Main: 177606656 17:35:06 INFO - PID 12133 | 17:35:07 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:08 INFO - PID 12133 | RSS: Main: 177569792 17:35:08 INFO - PID 12133 | 17:35:10 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:11 INFO - PID 12133 | RSS: Main: 177528832 17:35:11 INFO - PID 12133 | 17:35:13 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:14 INFO - PID 12133 | RSS: Main: 177795072 17:35:14 INFO - PID 12133 | 17:35:17 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:18 INFO - PID 12133 | RSS: Main: 178397184 17:35:18 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | Cycle 1(1): loaded http://localhost:60191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60191/tests/kraken/driver.html?testName=ai-astar) 17:35:20 INFO - PID 12133 | RSS: Main: 179322880 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | __start_tp_report 17:35:20 INFO - PID 12133 | _x_x_mozilla_page_load 17:35:20 INFO - PID 12133 | _x_x_mozilla_page_load_details 17:35:20 INFO - PID 12133 | |i|pagename|runs| 17:35:20 INFO - PID 12133 | |0;ai-astar;97;111;103;108;108;110;108;98;108;109 17:35:20 INFO - PID 12133 | |1;audio-beat-detection;144;118;146;178;117;153;151;122;177;124 17:35:20 INFO - PID 12133 | |2;audio-dft;163;162;161;164;163;170;162;170;171;164 17:35:20 INFO - PID 12133 | |3;audio-fft;76;77;76;167;75;74;75;74;109;75 17:35:20 INFO - PID 12133 | |4;audio-oscillator;80;80;130;81;79;80;133;81;80;134 17:35:20 INFO - PID 12133 | |5;imaging-gaussian-blur;114;114;115;113;114;115;114;114;114;114 17:35:20 INFO - PID 12133 | |6;imaging-darkroom;150;150;149;149;150;152;149;150;150;149 17:35:20 INFO - PID 12133 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;94;93 17:35:20 INFO - PID 12133 | |8;json-parse-financial;55;58;56;56;56;56;56;55;55;56 17:35:20 INFO - PID 12133 | |9;json-stringify-tinderbox;54;54;55;54;56;54;54;54;55;54 17:35:20 INFO - PID 12133 | |10;stanford-crypto-aes;77;77;78;76;80;78;77;77;76;77 17:35:20 INFO - PID 12133 | |11;stanford-crypto-ccm;133;149;129;134;125;129;121;133;123;149 17:35:20 INFO - PID 12133 | |12;stanford-crypto-pbkdf2;196;179;178;177;180;177;184;178;179;176 17:35:20 INFO - PID 12133 | |13;stanford-crypto-sha256-iterative;71;70;76;73;71;69;70;71;68;68 17:35:20 INFO - PID 12133 | __end_tp_report 17:35:20 INFO - PID 12133 | __start_cc_report 17:35:20 INFO - PID 12133 | _x_x_mozilla_cycle_collect,955 17:35:20 INFO - PID 12133 | __end_cc_report 17:35:20 INFO - PID 12133 | __startTimestamp1500424520325__endTimestamp 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | ------- Summary: start ------- 17:35:20 INFO - PID 12133 | Number of tests: 14 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#0] ai-astar Cycles:10 Average:106.00 Median:109.50 stddev:4.94 (4.5%) stddev-sans-first:4.03 17:35:20 INFO - PID 12133 | Values: 97.0 111.0 103.0 108.0 108.0 110.0 108.0 98.0 108.0 109.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:148.50 stddev:22.75 (15.3%) stddev-sans-first:24.13 17:35:20 INFO - PID 12133 | Values: 144.0 118.0 146.0 178.0 117.0 153.0 151.0 122.0 177.0 124.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.80 (2.3%) stddev-sans-first:3.96 17:35:20 INFO - PID 12133 | Values: 163.0 162.0 161.0 164.0 163.0 170.0 162.0 170.0 171.0 164.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#3] audio-fft Cycles:10 Average:87.80 Median:75.00 stddev:29.79 (39.7%) stddev-sans-first:31.29 17:35:20 INFO - PID 12133 | Values: 76.0 77.0 76.0 167.0 75.0 74.0 75.0 74.0 109.0 75.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:80.00 stddev:25.24 (31.5%) stddev-sans-first:26.11 17:35:20 INFO - PID 12133 | Values: 80.0 80.0 130.0 81.0 79.0 80.0 133.0 81.0 80.0 134.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:35:20 INFO - PID 12133 | Values: 114.0 114.0 115.0 113.0 114.0 115.0 114.0 114.0 114.0 114.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:35:20 INFO - PID 12133 | Values: 150.0 150.0 149.0 149.0 150.0 152.0 149.0 150.0 150.0 149.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:35:20 INFO - PID 12133 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 17:35:20 INFO - PID 12133 | Values: 55.0 58.0 56.0 56.0 56.0 56.0 56.0 55.0 55.0 56.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 17:35:20 INFO - PID 12133 | Values: 54.0 54.0 55.0 54.0 56.0 54.0 54.0 54.0 55.0 54.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:1.16 (1.5%) stddev-sans-first:1.22 17:35:20 INFO - PID 12133 | Values: 77.0 77.0 78.0 76.0 80.0 78.0 77.0 77.0 76.0 77.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:133.00 stddev:9.72 (7.3%) stddev-sans-first:10.31 17:35:20 INFO - PID 12133 | Values: 133.0 149.0 129.0 134.0 125.0 129.0 121.0 133.0 123.0 149.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:179.00 stddev:5.91 (3.3%) stddev-sans-first:2.35 17:35:20 INFO - PID 12133 | Values: 196.0 179.0 178.0 177.0 180.0 177.0 184.0 178.0 179.0 176.0 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:2.41 (3.4%) stddev-sans-first:2.55 17:35:20 INFO - PID 12133 | Values: 71.0 70.0 76.0 73.0 71.0 69.0 70.0 71.0 68.0 68.0 17:35:20 INFO - PID 12133 | -------- Summary: end -------- 17:35:20 INFO - PID 12133 | 17:35:20 INFO - PID 12133 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:35:21 INFO - TEST-INFO | 12133: exit 0 17:35:21 INFO - TEST-OK | kraken | took 61182ms 17:35:21 INFO - SUITE-END | took 1171s 17:35:21 INFO - Completed test suite (00:19:32) 17:35:21 INFO - javascript benchmark 17:35:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8329.477945834073, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.9380812383765, 3152.4956007038872, 3170.984145079274, 3175.3966746318197, 3210.133264018715, 6055.122007308938, 6092.817215483537, 6126.356732543086, 6138.048602466619, 6160.907586386196, 6154.692265386724, 6191.752329906798, 6199.752009919598, 6199.876002479948, 6216.409441103088, 5619.7471113799975, 5636.15457681347, 5648.435156484339, 5661.433856614347, 5685.317761868561, 5660.462256085665, 5666.688332141731, 5676.631018983753, 5687.8578035549235, 5690.174924635925, 5662.631928924628, 5663.8584035399035, 5667.8583035424235, 5679.943200568004, 5691.772329106851, 5659.51894089003, 5671.7447714852515, 5682.090865461527, 5686.289213848289, 5693.402192769741, 5529.778808847641, 5656.575756818255, 5671.489565939044, 5677.574181936371, 5747.195392645033, 6108.633481991051, 6126.785562505291, 6173.506119510428, 6186.9381306186815, 6250.7812226572305, 6479.838004049937, 6546.214454265519, 6568.901466478007, 6658.300878407746, 6669.966650166767, 6591.93408065918, 6619.437347825441, 6626.370494802986, 6632.63520506372, 6640.33596640337, 6087.969560152215, 6114.8777024459705, 6142.293636231846, 6155.261368635747, 6158.938410615881, 6771.5259931805285, 6775.186977562675, 6779.559328643622, 6827.2831352708245, 6855.108835851407, 6359.777407790705, 6416.230052393743, 6421.197350331208, 6458.644774537445, 6530.379613936669, 6393.488520918316, 6596.142501474777, 6650.900236496456, 6661.866762664817, 6676.232233293234, 6441.033844923205, 6443.48452123829, 6447.9355206447335, 6485.578437401554, 6488.026795980641, 6543.541952063405, 6547.705353259114, 6579.374959378852, 6633.137692100093, 6650.567713098633, 5211.114110601206, 5254.816081437131, 5284.207368894697, 5355.009323275207, 5362.383325917492, 4509.233430316854, 4530.320451932171, 4558.566936141061, 4565.611922986517, 4567.497575266718, 5728.312602487728, 5749.3963133871175, 5760.36635970043, 5760.913586296209, 5762.423757624204, 6585.80242592723, 6586.242582103024, 6597.208334999735, 6597.80206593803, 6610.471162307004, 5644.463775941361, 5719.170720245541, 5741.913871291934, 5743.023685973395, 5758.568107391879, 5765.942340576625, 5825.0388685866355, 5833.854153646108, 5839.328477225174, 5840.5035571976005, 5402.162664786964, 6343.619382836952, 6426.485881129498, 6451.1290975717675, 6483.0275458680635, 6633.237177724527, 6638.336166383516, 6684.966575167093, 6703.363180497845, 6715.56348837324, 6369.585976911486, 6381.680915954276, 6457.321981191907, 6471.838204044937, 6492.870142597028, 6416.13382193398, 6444.645544495098, 6497.057926600711, 6520.869582608416, 6547.770828021187, 5630.549556035426, 6601.306862779339, 6628.767993120217, 6665.900011499734, 6750.29121942189, 6420.711068002044, 6443.226812782496, 6490.675466226576, 6513.641749703812, 6522.836929076621, 6426.871462570629, 6455.9677201613695, 6500.609963402211, 6535.967320163369, 6557.540972131905, 6301.212348456443, 6371.808845734636, 6392.488600912009, 6393.200849893763, 6421.068945003042, 6408.0, 6411.0397448699305, 6434.549581529435, 6443.291237963726, 6461.127747753993, 5375.16424865552, 6270.122182894307, 6278.654673992792, 6287.779927702692, 6354.872902541831], "value": 6011.712893237393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.1095940351279, 772.119783446871, 784.3607459920165, 808.6926967752255, 815.188887057378, 41046.38430423542, 41621.3756793648, 41871.58128418715, 41873.37189942153, 41934.370984435256, 38258.23483530328, 38505.807470962674, 38591.0, 38704.80647596765, 38725.41911871317, 6802.7959161225, 6900.275471075515, 6918.75784347548, 6935.479839012069, 6951.2701166377565, 6788.355106264897, 6890.793276201722, 6893.448524118058, 6900.551464154839, 6903.689333979958, 6870.4503639708955, 6884.586924784504, 6890.7588234411805, 6890.896636550456, 6920.4809639277255, 6795.7961261162245, 6830.726770929182, 6841.2132604750095, 6849.7602583909575, 6867.244603093655, 6230.2523697156175, 6233.470155036827, 6291.748330066792, 6294.402031806971, 6302.149209856657, 34201.82899085514, 34613.480797788055, 34666.306673866384, 34885.12787180315, 35027.82486087553, 3417.5044618530424, 3462.8441720122655, 3468.7225021998433, 3583.426651735736, 3673.1918977824835, 31255.68744312573, 31283.530747038814, 31347.37305253882, 31452.0, 31664.36671266562, 4864.075825593126, 4869.14789911764, 4938.80244790208, 4942.827001054981, 5018.422881368653, 193757.0, 195962.0, 196743.0, 198410.00794996077, 199184.0, 47730.761346193045, 48521.0, 48690.0, 48908.7554562232, 48922.0, 50743.492565074615, 50862.491375085774, 50872.0, 50879.74560127176, 51314.74342628263, 16301.266443010092, 16425.1787410629, 16456.09491477956, 16478.34086636521, 16542.0, 13667.521636742866, 13685.178889266477, 13734.244616546186, 13761.243131627656, 13795.517156899461, 14143.949127376678, 14241.145531268157, 14275.571732848031, 14362.0, 14480.565583032527, 5685.488306052475, 5755.740991655385, 5784.1902133701315, 5794.768209271582, 5830.542364408898, 972.003696211389, 979.9314048016571, 1002.293383164867, 1010.4897027001317, 1035.4874337202982, 22447.32658020262, 22992.540149197255, 22999.770002299763, 23266.0, 23387.298381048597, 1093.4040947683532, 1095.769888323445, 1109.2678831970861, 1111.1666250312267, 1117.9944100279608, 12026.684298303764, 12072.3360215189, 12557.811632825515, 15639.843601564065, 16091.678166436606, 233468.0, 235176.0, 236041.0, 236554.0, 236791.0, 57258.0, 57276.42723572711, 57284.42715572874, 57531.13703294454, 57636.135457968165, 1408.2114016150988, 1477.4016523308078, 1499.9625009374636, 1504.1877386211324, 1507.2237797534278, 26676.466470670865, 27603.72396276092, 27866.721332787223, 27871.72128278691, 27932.44135117327, 37953.62046379501, 38296.61703382931, 38324.6167538321, 38439.0, 38512.422313664756, 199238.0, 204387.0, 204614.0, 205129.0, 205668.0, 29934.70065299319, 30400.84799575988, 33403.16492087717, 33959.0, 34939.30121397608, 40854.0, 44587.554124458344, 45303.54696452993, 45342.0, 45982.0, 30988.380232394775, 32161.517577235893, 32295.838520808185, 32794.83602581972, 33235.169120772174, 31471.0, 32005.839970799996, 32199.034028979167, 32768.344633106724, 33589.16027099342, 37579.06052348604, 37868.431973519866, 38060.80969595134, 38187.2362552753, 38566.42150367691, 31083.912063077685, 33191.0, 33264.334713305114, 33369.499457508646, 34083.0, 24481.143159989315, 24707.135250266154, 24782.256532304058, 24876.12933547317, 24910.501789963735], "value": 17037.89037920286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9802606908759, 571.1603942204957, 577.8526475748683, 581.4737662415514, 601.359552077038, 22161.55676886461, 23118.65322020169, 23171.0, 23206.65190022151, 23216.41958951027, 23889.402764930885, 25182.496350072986, 25976.35059123523, 26235.606465903027, 26339.60490592638, 6462.612243265396, 6605.834854128661, 6606.603603783764, 6608.339166083378, 6627.668616569176, 6501.284858665543, 6521.510886683494, 6546.476281897437, 6551.475881929434, 6574.835629109262, 5667.121596152582, 6174.783882564111, 6183.845403864894, 6533.738650453976, 6546.0, 6297.968510157443, 6345.333739957284, 6348.746050157988, 6349.841253968688, 6356.745730170787, 5851.795187168471, 5863.794767183171, 5865.266841644794, 5885.470307672287, 5895.587308888379, 29034.693438795304, 29074.70925290741, 29605.0, 29690.0, 29766.851165744032, 1905.9904700476548, 1952.492351988479, 1957.1877670766614, 1959.4513536209884, 1964.6463636545416, 18305.450836474927, 18954.14706338218, 19028.904855475772, 19071.2371505141, 19129.521761955923, 2279.065583110933, 2285.931422057341, 2347.3779448446176, 2394.928152155438, 2395.3173345596597, 136142.0, 138508.30745846208, 139419.0, 140592.0, 143658.0, 14282.714345713028, 14766.0, 14955.130608673915, 15119.749253910462, 15270.31283592241, 23796.405089872893, 23799.40501487442, 23860.284191474282, 23962.161324353565, 24006.87996560006, 10449.111825494767, 10570.577176912837, 10590.57637694499, 10595.682129536126, 10621.256512044238, 9802.852957205647, 9873.0, 9910.10809027191, 9938.403695778277, 9974.650887218913, 8980.820383592421, 9150.313726470542, 9181.678641247525, 9284.118008789153, 9580.13778759915, 2571.614257861336, 2575.2531765788085, 2706.6751989761356, 2736.0834120569434, 2879.4385094906293, 928.3084102343797, 948.7201275623707, 954.71358592422, 983.1201075037944, 1000.1948431512702, 19789.0, 19797.697942099814, 19945.301914433214, 20582.794172058388, 20676.06957686908, 1011.7066050845173, 1017.2472370445817, 1042.4527123260198, 1044.0916402729522, 1050.1703654113164, 10951.0, 11013.724656883642, 11015.228933974546, 11115.777684446266, 11258.16586046982, 470860.0, 480222.0, 480229.0, 487240.0, 487666.0, 110843.0, 113580.43209783899, 114038.0, 114259.42870285595, 114831.42584287192, 1175.5591653130077, 1182.131133616791, 1197.9520819167135, 1201.1351826684772, 1211.54567037361, 17026.0, 17748.3788067417, 17886.5528361792, 18466.169022393755, 18467.445976620722, 52546.73726631342, 52872.471275286756, 53405.0, 54480.45519544754, 56084.719576401854, 68869.0, 71202.93195601966, 71421.6428917852, 71791.0, 72038.63980680062, 14460.783088253895, 14467.421303147756, 14671.413143474141, 14678.633034173803, 14732.55802325932, 22630.434239144153, 23063.19278825233, 23156.421089472897, 23188.072477101403, 23384.883075584512, 19222.711659324843, 19276.22895084181, 19449.8055019448, 19475.123619437443, 19656.508587285432, 15197.316120774813, 16983.79210702601, 17213.56966075808, 17572.209250584012, 18086.095695214924, 18806.623867522845, 19020.619587608446, 19028.524286892938, 19104.522386939883, 20457.18171273192, 14881.85118148848, 15138.0, 15200.847991520386, 15202.239888005777, 15214.847851521787, 18513.9074304633, 19301.90349048246, 19415.2233910642, 19440.416787496397, 19603.411897643095], "value": 11992.11602044557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.7203387288669, 1382.5506710319148, 1388.8333399992002, 1416.2847761880244, 1421.815164028676, 13237.271950042743, 13930.651733706638, 14014.579562613113, 14022.509212177576, 14023.298835058244, 13657.863421365784, 14096.78854817176, 14453.349599268033, 14465.63835904103, 14498.347574359153, 2535.201411555359, 2601.3756698392344, 2604.28382194897, 2616.921492355232, 2618.515574618692, 2524.936876578091, 2554.0, 2555.501677172952, 2561.180422264876, 2564.1538292363475, 2528.8609126498036, 2539.162076514755, 2561.4236796720684, 2572.164046684835, 2581.5224183526016, 2514.6228065790187, 2645.6163856240833, 2738.835669859815, 2742.1773467959533, 2742.5886117082396, 2593.9481210375875, 2599.285196570939, 2635.4729054189047, 2648.0599387217453, 2650.045983445958, 13402.46390144393, 13534.120282181626, 13652.726945461134, 13653.522126725617, 13736.65658358539, 7147.571145731221, 7400.962995184989, 7427.888581671279, 7442.03253577037, 7442.925570744277, 4893.657443978923, 5020.623453240985, 5132.435432102466, 5149.588032957355, 5151.484851514856, 1718.6133120048014, 1798.0919635583946, 1823.2889173222454, 1852.6202128563611, 1860.7301941218448, 22350.441238968993, 22679.319620411414, 22703.886480567493, 22721.091156353727, 22737.88631056834, 5961.821145365646, 6008.519318454601, 6078.696065196723, 6133.202683651186, 6197.96901015492, 15253.0, 15304.158271294962, 15311.540653780405, 15371.308291126927, 15385.0, 7163.928360716326, 7325.2308507607, 7329.267073292628, 7334.3765779908235, 7339.559626422431, 6687.130673012574, 6717.966410167918, 6745.93254067453, 6766.661666916634, 6858.5199036068, 4630.560096790799, 4753.168195565762, 4818.301346304766, 4881.365422495124, 4885.096257192431, 1351.8039884216732, 1352.8241328627216, 1357.0432844844559, 1367.699106196635, 1371.067673981682, 870.6256309786852, 873.9563021848882, 907.3240435875183, 921.6866265469772, 923.6490133749267, 8064.879026814602, 8079.555624440594, 8177.304929080976, 8266.008079030435, 8547.316214702809, 980.857775622545, 980.9852852207223, 998.0468652436905, 998.3410948773775, 1001.6744558018673, 5095.108356037678, 5166.741662916839, 5195.402528709171, 5223.399309079505, 5354.598405119632, 18066.548336291435, 18356.958024002102, 19123.139458724392, 19146.138423770964, 19444.51388715265, 19096.140673669717, 19433.31983380575, 19476.318328858422, 19565.902170489342, 19569.706454403196, 10329.586816527404, 10808.081313088476, 10854.131669466424, 11032.44837758109, 11055.447227638746, 7745.22547745221, 8356.33149348063, 8434.325253979545, 8534.402591818513, 8630.870536941826, 16077.67844643124, 16186.514404567883, 16499.010059396474, 16700.331986720394, 16863.409780657617, 16395.180240988142, 16721.832781672027, 17286.22212000488, 17326.30694772195, 17397.913010434866, 10899.0, 11124.054455371384, 11185.32888026721, 11186.272892261977, 11197.0, 12968.546100886424, 13096.541621043218, 13101.606951791462, 13112.278824664734, 13118.147320424141, 9959.701208963743, 10054.748631284276, 10504.317219380715, 10687.679369618923, 10804.67585972422, 9824.361416507903, 10369.63706270277, 10382.844257336297, 10387.169026477712, 10422.114120299557, 9384.436933783994, 9492.57283422234, 9500.334976551852, 9546.427214366882, 9548.42709437436, 6907.6891539879825, 7049.506534542533, 7109.537880037781, 7129.215786263403, 7271.781846544613, 6922.480813938874, 7304.926950730637, 7305.086864141982, 7361.190269070291, 7365.447591430771], "value": 6284.4656852822945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.51157563497435, 489.1928318274847, 499.32341677027625, 502.9119904016797, 508.4483335580895, 6000.249968753906, 6009.0685943678745, 6048.193734015351, 6067.0, 6145.231846019242, 5774.971125144379, 6047.727852246649, 6058.878822423549, 6068.6965651717455, 6088.782243551285, 4882.951170488285, 4937.5065591876055, 4955.4548999610015, 4956.553910148086, 4971.433998290545, 4882.731449770261, 4897.094037603037, 4899.828506002291, 4929.309896614477, 4936.876578085541, 4801.879953001168, 4839.927401088987, 4868.0750657375165, 4874.927515946504, 4894.241392584137, 4644.465886423054, 4798.424189097331, 4804.183288840905, 4878.0, 4894.535019173173, 4312.935305970413, 4318.114786468766, 4341.392205091258, 4367.410399596046, 4385.0, 5859.355470898197, 5882.323532793741, 5919.644821310692, 5961.5230781537375, 5982.760689572412, 5475.056354994, 5497.422770609069, 5532.225488431623, 5539.723013849291, 5601.851620417805, 6347.270063942659, 6367.5861069030825, 6438.517111216631, 6458.90311645321, 6460.126563296639, 4697.436307643071, 4731.739754313511, 4752.4297084349755, 4777.28340748887, 4791.712497250176, 6605.70274337656, 6624.966875165642, 6675.499337549703, 6680.465562755016, 6705.6982435790505, 4815.3499277597775, 4901.3383193269165, 4912.140375434285, 4925.13810083234, 4925.532074452921, 4953.526353379464, 4959.404871415453, 4970.875728106754, 4988.251762235694, 5011.173156429149, 5479.150731636602, 5486.670799752028, 5491.341039075336, 5511.614187006951, 5569.275994120739, 6407.807765767035, 6433.5496515243485, 6434.806955791334, 6469.897283382826, 6470.9029364559565, 1697.2532085882171, 1703.872209584286, 1704.5994191365019, 1707.846293833561, 1715.7254839225664, 1101.6750058732694, 1190.7678002789373, 1201.1831954271179, 1201.597464849268, 1204.981790387139, 5460.672359658433, 5559.831665650399, 5615.213870058195, 5658.462446067617, 5684.204211410406, 6476.902846457307, 6550.246721626979, 6574.243961944342, 6580.676758237059, 6621.702637889669, 5618.0449323615085, 5648.881669373985, 5664.0, 5667.291588551431, 5721.628094173865, 3408.7954722716718, 3427.4687423449404, 3478.243497023209, 3485.877994270239, 3556.519869817593, 6253.249610046823, 6273.937260627426, 6286.339934306832, 6331.497175846636, 6434.806955791334, 6577.736890524421, 6639.170103737033, 6665.900011499832, 6770.52606317553, 6773.221079575912, 6292.811215663537, 6334.873302533923, 6348.904766428415, 6367.140436041075, 6373.936260637334, 6484.351564843478, 6498.285188629342, 6563.7702680405955, 6564.409203171737, 6634.900476492953, 6361.491080713625, 6374.840628984312, 6464.709088091141, 6470.255920569195, 6523.347665233438, 6261.812145635638, 6294.527910406646, 6328.303886572381, 6337.96831015842, 6362.681865906594, 4866.197077482318, 4877.487863774252, 4903.215485522299, 4908.214685650421, 4918.188498897642, 6545.345465453607, 6584.62122688426, 6584.736610535525, 6586.946088625797, 6649.368310010541, 6317.210348706411, 6344.492440604833, 6388.265349484869, 6393.520485963479, 6400.167978162809, 6327.841803954938, 6334.968325158345, 6343.143675603735, 6394.145697747601, 6408.61010208009, 6226.813195604139, 6230.937690623217, 6242.531810114168, 6295.931774921232, 6318.925782616874, 6296.779612713533, 6323.715432805443, 6346.446858998376, 6377.362263773585, 6431.485481161402, 6127.938720612737, 6221.377862213742, 6222.906656400248, 6240.375962403723, 6281.0], "value": 4926.636901170606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.3469569257979, 919.7102912582536, 932.7201839448164, 937.5640327247828, 938.4088024544534, 16586.33654653814, 16677.332906683747, 16729.0, 16768.07775572343, 18858.33995810147, 19933.20267189311, 20740.0, 21496.140154393845, 21532.354029379105, 21539.24612638558, 1008.2337423558075, 1024.1499555369064, 1032.6747074671491, 1035.0684384054373, 1038.392540363888, 1036.8341065429534, 1037.2272656870641, 1043.1029314789275, 1043.2853495355705, 1046.3512622174262, 783.8824176373532, 965.0, 1032.1433210435357, 1093.3276035238312, 1105.8451816745662, 1085.0560012788924, 1086.3156211586688, 1087.690008347617, 1090.0189829153746, 1094.60047082815, 799.2007992007992, 800.1518390506083, 800.6917336825306, 805.1827395193883, 809.5062012172571, 18963.33628323002, 19436.80563194364, 19739.309124180585, 19821.603567928705, 19961.600767984703, 18386.90806545972, 18656.906715466335, 18897.81102188988, 18977.620447591107, 18981.62036759257, 15716.135612541306, 16356.672866542602, 16421.671566568602, 16425.0, 16432.589185270343, 3534.1341371363924, 3546.929061418783, 3571.2678900825267, 3572.964270357289, 3589.2821435712963, 122823.38588307002, 125865.0, 130453.34773326167, 130755.34622326923, 132202.0, 14898.25508724581, 15805.051696898223, 15945.202739863193, 16082.195890205443, 16176.433824816075, 28125.718742812718, 28138.85930570334, 28170.0, 28442.857785710938, 28450.715492845222, 8249.587520623945, 8391.035030971516, 8614.138586141336, 8621.741347759576, 8671.393002489765, 3947.743396679207, 4031.475908131924, 4123.422720819088, 4129.752214867118, 4130.359794231838, 5131.743412829418, 5160.819371321985, 5182.067227898939, 5188.351456067991, 5259.8422047338645, 947.8199142162968, 950.8193443245762, 968.1577027985697, 971.4511301114848, 988.5255077562811, 604.3080672629815, 674.4638012779852, 690.8169335126196, 699.2727563334075, 701.7158050989358, 10901.781964360669, 11145.442727863574, 11276.718082048015, 11319.434028298552, 11518.193726439236, 601.6931365003792, 639.9072134540465, 661.3981277037873, 665.0489799586541, 675.0684056002783, 5390.946090539122, 5411.080116380225, 5450.0, 5473.698946557977, 5477.67133971963, 97083.0, 103929.0, 104712.0, 110304.0, 111730.0, 84890.0, 89715.0, 91697.0, 92074.0, 92092.53953730188, 82025.0, 82179.0, 82463.58768206241, 84549.57725211335, 85517.57241213879, 11241.269317494336, 11763.764724705286, 11839.76320473603, 12349.135560510678, 12378.0, 34341.656583434844, 35851.28297433985, 36120.0, 36492.81753591215, 37580.0, 45619.0, 47185.52814471811, 47345.0, 47476.7626161867, 49003.75498122487, 17584.0, 18006.72989905179, 18131.36540221086, 18486.260549577866, 18554.44336669902, 20367.69448458304, 20495.0, 20578.58842823105, 20622.38132856017, 20865.165393384093, 15118.697626047637, 15827.208639567745, 15863.52409427719, 16027.839721602635, 16210.0, 18255.726164107284, 18361.265549377877, 18446.81553184451, 18538.907305463385, 19053.333133340268, 18136.18387172607, 18241.0, 18252.908735456767, 18351.449456516326, 18407.355742549484, 12027.338496382783, 12261.938690306491, 12815.551455699006, 12940.029497787891, 12987.610371688865, 12576.559820406243, 12818.166819156724, 12850.742985140432, 12895.935520322339, 13001.479940802263], "value": 8781.123588654367, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 111.0, 103.0, 108.0, 108.0, 110.0, 108.0, 98.0, 108.0, 109.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 146.0, 178.0, 117.0, 153.0, 151.0, 122.0, 177.0, 124.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 164.0, 163.0, 170.0, 162.0, 170.0, 171.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 167.0, 75.0, 74.0, 75.0, 74.0, 109.0, 75.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 130.0, 81.0, 79.0, 80.0, 133.0, 81.0, 80.0, 134.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 150.0, 152.0, 149.0, 150.0, 150.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 76.0, 80.0, 78.0, 77.0, 77.0, 76.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 149.0, 129.0, 134.0, 125.0, 129.0, 121.0, 133.0, 123.0, 149.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 179.0, 178.0, 177.0, 180.0, 177.0, 184.0, 178.0, 179.0, 176.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 76.0, 73.0, 71.0, 69.0, 70.0, 71.0, 68.0, 68.0], "value": 70.7, "unit": "score"}]}]} 17:35:21 INFO - Return code: 0 17:35:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:21 INFO - # TBPL SUCCESS # 17:35:21 INFO - Running post-action listener: _package_coverage_data 17:35:21 INFO - Running post-action listener: _resource_record_post_action 17:35:21 INFO - [mozharness: 2017-07-19 00:35:21.601135Z] Finished run-tests step (success) 17:35:21 INFO - Running post-run listener: _resource_record_post_run 17:35:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 441204736; Read time: 320; Write time: 294008 17:35:21 INFO - TinderboxPrint: CPU usage
13.1% 17:35:21 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 17:35:21 INFO - TinderboxPrint: I/O write bytes / time
441,204,736 / 294,008 17:35:21 INFO - TinderboxPrint: CPU idle
8,251.3 (86.9%) 17:35:21 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 17:35:21 INFO - TinderboxPrint: Swap in / out
0 / 0 17:35:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109654016; Read time: 140; Write time: 78628 17:35:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:35:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331550720; Read time: 168; Write time: 215380 17:35:22 INFO - Running post-run listener: _upload_blobber_files 17:35:22 INFO - Blob upload gear active. 17:35:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:22 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 17:35:22 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'] 17:35:22 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 17:35:22 INFO - Traceback (most recent call last): 17:35:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 17:35:22 INFO - main() 17:35:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 17:35:22 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 17:35:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 17:35:22 INFO - return set(response.json().get('whitelist', [])) 17:35:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 17:35:22 INFO - return json.loads(self.text or self.content, **kwargs) 17:35:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 17:35:22 INFO - return _default_decoder.decode(s) 17:35:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 17:35:22 INFO - obj, end = self.raw_decode(s) 17:35:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 17:35:22 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 17:35:22 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 17:35:22 ERROR - Return code: 1 17:35:22 INFO - Setting buildbot property blobber_files to {} 17:35:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:22 INFO - Contents: 17:35:22 INFO - blobber_files:{} 17:35:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:22 INFO - Copying logs to upload dir... 17:35:22 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.924966 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-18 17:35:22.438240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:22.442024) ========= 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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:22.505272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:22.505604) ========= 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=bb9b54edd4a927dc735d112f000001d9-1500423236.873224-2103802798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:22.599838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:35:22.600146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:35:22.600427) ========= ========= Total master_lag: 0.21 =========