builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-083 starttime: 1500341552.25 results: success (0) revision: 5e73b9798464c3f7106f0161dc9a49b234f42f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.247021) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.247714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.247998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.281972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.282336) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 18:32:32-- 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% 103M=0s 2017-07-17 18:32:32 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126919 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.439179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.441415) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015453 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.493671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:32.494061) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e73b9798464c3f7106f0161dc9a49b234f42f9c --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 5e73b9798464c3f7106f0161dc9a49b234f42f9c --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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 18:32:33,111 truncating revision to first 12 chars 2017-07-17 18:32:33,111 Setting DEBUG logging. 2017-07-17 18:32:33,111 attempt 1/10 2017-07-17 18:32:33,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e73b9798464?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 18:32:33,466 unpacking tar archive at: mozilla-central-5e73b9798464/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:33.228180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:33.228506) ========= script_repo_revision: 5e73b9798464c3f7106f0161dc9a49b234f42f9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:33.228911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:33.229183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:33.238032) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-07-17 18:32:33.238306) ========= /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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:32:33 INFO - MultiFileLogger online at 20170717 18:32:33 in /builds/slave/test 18:32:33 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 18:32:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:33 INFO - {'append_to_log': False, 18:32:33 INFO - 'base_work_dir': '/builds/slave/test', 18:32:33 INFO - 'blob_upload_branch': 'Firefox', 18:32:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:33 INFO - 'branch': 'Firefox', 18:32:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:33 INFO - 'code_coverage': False, 18:32:33 INFO - 'config_files': ('talos/linux_config.py',), 18:32:33 INFO - 'default_actions': ('clobber', 18:32:33 INFO - 'read-buildbot-config', 18:32:33 INFO - 'download-and-extract', 18:32:33 INFO - 'populate-webroot', 18:32:33 INFO - 'create-virtualenv', 18:32:33 INFO - 'install', 18:32:33 INFO - 'setup-mitmproxy', 18:32:33 INFO - 'run-tests'), 18:32:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:33 INFO - 'disable_ccov_upload': False, 18:32:33 INFO - 'download_minidump_stackwalk': True, 18:32:33 INFO - 'download_symbols': 'ondemand', 18:32:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:33 INFO - 'gecko_profile': False, 18:32:33 INFO - 'gecko_profile_interval': 0, 18:32:33 INFO - 'installer_path': 'installer.exe', 18:32:33 INFO - 'log_level': 'info', 18:32:33 INFO - 'log_name': 'talos', 18:32:33 INFO - 'log_to_console': True, 18:32:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:32:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:32:33 INFO - 'opt_config_files': (), 18:32:33 INFO - 'pip_index': False, 18:32:33 INFO - 'suite': 'dromaeojs-e10s', 18:32:33 INFO - 'system_bits': '32', 18:32:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:33 INFO - 'title': 'talos-linux64-ix-083', 18:32:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:33 INFO - 'use_talos_json': True, 18:32:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:33 INFO - 'work_dir': 'build'} 18:32:33 INFO - [mozharness: 2017-07-18 01:32:33.960906Z] Running clobber step. 18:32:33 INFO - Running pre-action listener: _resource_record_pre_action 18:32:33 INFO - Running main action method: clobber 18:32:33 INFO - rmtree: /builds/slave/test/build 18:32:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:35 INFO - Running post-action listener: _resource_record_post_action 18:32:35 INFO - [mozharness: 2017-07-18 01:32:35.542758Z] Finished clobber step (success) 18:32:35 INFO - [mozharness: 2017-07-18 01:32:35.542859Z] Running read-buildbot-config step. 18:32:35 INFO - Running pre-action listener: _resource_record_pre_action 18:32:35 INFO - Running main action method: read_buildbot_config 18:32:35 INFO - Using buildbot properties: 18:32:35 INFO - { 18:32:35 INFO - "project": "", 18:32:35 INFO - "product": "firefox", 18:32:35 INFO - "who": "kwierso@gmail.com", 18:32:35 INFO - "installer_path": "public/build/target.tar.bz2", 18:32:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:32:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:32:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:32:35 INFO - "stage_platform": "linux64-pgo", 18:32:35 INFO - "basedir": "/builds/slave/test", 18:32:35 INFO - "buildnumber": 75, 18:32:35 INFO - "platform": "ubuntu64_hw", 18:32:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:32:35 INFO - "slavebuilddir": "test", 18:32:35 INFO - "taskId": "Z7ACdpU_T9-eNzRgrWkZnA", 18:32:35 INFO - "branch": "mozilla-central", 18:32:35 INFO - "script_repo_revision": "production", 18:32:35 INFO - "revision": "5e73b9798464c3f7106f0161dc9a49b234f42f9c", 18:32:35 INFO - "slavename": "talos-linux64-ix-083", 18:32:35 INFO - "repo_path": "mozilla-central" 18:32:35 INFO - } 18:32:35 INFO - Finding installer, test and symbols from parent task. 18:32:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7ACdpU_T9-eNzRgrWkZnA'}, attempt #1 18:32:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7ACdpU_T9-eNzRgrWkZnA'}, attempt #1 18:32:36 INFO - Task dependencies: MmFQO4FmRwC1WR2gsYoksA 18:32:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA'}, attempt #1 18:32:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 18:32:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/test_packages.json 18:32:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.crashreporter-symbols.zip 18:32:36 INFO - Running post-action listener: _resource_record_post_action 18:32:36 INFO - [mozharness: 2017-07-18 01:32:36.897340Z] Finished read-buildbot-config step (success) 18:32:36 INFO - [mozharness: 2017-07-18 01:32:36.897565Z] Running download-and-extract step. 18:32:36 INFO - Running pre-action listener: _resource_record_pre_action 18:32:36 INFO - Running main action method: download_and_extract 18:32:36 INFO - mkdir: /builds/slave/test/build/tests 18:32:36 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')]} 18:32:36 INFO - trying https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.test_packages.json 18:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:32:37 INFO - Downloaded 989 bytes. 18:32:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:32:37 INFO - Using the following test package requirements: 18:32:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:32:37 INFO - u'common': [u'target.common.tests.zip'], 18:32:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:32:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:32:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:32:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:32:37 INFO - u'mozbase': [u'target.common.tests.zip'], 18:32:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:32:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:32:37 INFO - u'web-platform': [u'target.common.tests.zip', 18:32:37 INFO - u'target.web-platform.tests.tar.gz'], 18:32:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:32:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:32:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip 18:32:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:32:37 INFO - Fetch https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip into memory 18:32:38 INFO - Content-Length response header: 73395336 18:32:38 INFO - Bytes received: 73395336 18:32:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:32:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip 18:32:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:32:50 INFO - Fetch https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.common.tests.zip into memory 18:32:51 INFO - Content-Length response header: 73395336 18:32:51 INFO - Bytes received: 73395336 18:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.talos.tests.zip 18:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.talos.tests.zip into memory 18:33:04 INFO - Content-Length response header: 14495033 18:33:04 INFO - Bytes received: 14495033 18:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:04 INFO - trying https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 18:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:33:05 INFO - Downloaded 62757822 bytes. 18:33:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 18:33:05 INFO - mkdir: /builds/slave/test/properties 18:33:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:05 INFO - Contents: 18:33:05 INFO - build_url:https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 18:33:05 INFO - Running post-action listener: _resource_record_post_action 18:33:05 INFO - Running post-action listener: set_extra_try_arguments 18:33:05 INFO - [mozharness: 2017-07-18 01:33:05.835346Z] Finished download-and-extract step (success) 18:33:05 INFO - [mozharness: 2017-07-18 01:33:05.835444Z] Running populate-webroot step. 18:33:05 INFO - Running pre-action listener: _resource_record_pre_action 18:33:05 INFO - Running main action method: populate_webroot 18:33:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:05 INFO - '--tppagecycles', 18:33:05 INFO - '7'], 18:33:05 INFO - 'tests': ['tsvgm']}}, 18:33:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['damp', 'tps']}, 18:33:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'tests': ['damp', 'tps']}, 18:33:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['dromaeo_dom']}, 18:33:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:33:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:33:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:33:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_many_windows', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_many_windows', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_many_windows', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['a11yr', 18:33:05 INFO - 'ts_paint', 18:33:05 INFO - 'tpaint', 18:33:05 INFO - 'sessionrestore', 18:33:05 INFO - 'sessionrestore_no_auto_restore', 18:33:05 INFO - 'tabpaint']}, 18:33:05 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 18:33:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:33:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:33:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:33:05 INFO - 'talos_options': ['--mitmproxy', 18:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:33:05 INFO - '--firstNonBlankPaint'], 18:33:05 INFO - 'tests': ['quantum_pageload_google', 18:33:05 INFO - 'quantum_pageload_youtube', 18:33:05 INFO - 'quantum_pageload_amazon', 18:33:05 INFO - 'quantum_pageload_facebook']}, 18:33:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['tsvgx', 18:33:05 INFO - 'tsvgr_opacity', 18:33:05 INFO - 'tart', 18:33:05 INFO - 'tscrollx', 18:33:05 INFO - 'cart', 18:33:05 INFO - 'tsvg_static']}, 18:33:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:05 INFO - 'tsvgr_opacity', 18:33:05 INFO - 'tart', 18:33:05 INFO - 'tscrollx', 18:33:05 INFO - 'cart', 18:33:05 INFO - 'tsvg_static']}, 18:33:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'talos_options': ['--disable-e10s'], 18:33:05 INFO - 'tests': ['tp5o']}, 18:33:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:33:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'talos_options': ['--disable-e10s', 18:33:05 INFO - '--xperf_path', 18:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:05 INFO - 'tests': ['tp5n']}, 18:33:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:33:05 INFO - 'talos_options': ['--xperf_path', 18:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:05 INFO - 'tests': ['tp5n']}}, 18:33:05 INFO - 'talos.zip': {'path': '', 18:33:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:05 INFO - Running post-action listener: _resource_record_post_action 18:33:05 INFO - [mozharness: 2017-07-18 01:33:05.850960Z] Finished populate-webroot step (success) 18:33:05 INFO - [mozharness: 2017-07-18 01:33:05.851052Z] Running create-virtualenv step. 18:33:05 INFO - Running pre-action listener: _resource_record_pre_action 18:33:05 INFO - Running main action method: create_virtualenv 18:33:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:05 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 18:33:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:33:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:05 INFO - Using real prefix '/usr' 18:33:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:08 INFO - Installing pip.................done. 18:33:08 INFO - Return code: 0 18:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:33:08 INFO - Reading from file tmpfile_stdout 18:33:08 INFO - Output received: 18:33:08 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) 18:33:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:08 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:08 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 18:33:08 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 18:33:08 INFO - Using env: {'DISPLAY': ':0', 18:33:08 INFO - 'HOME': '/home/cltbld', 18:33:08 INFO - 'LANG': 'en_US.UTF-8', 18:33:08 INFO - 'LANGUAGE': 'en_US:en', 18:33:08 INFO - 'LOGNAME': 'cltbld', 18:33:08 INFO - 'MAIL': '/var/mail/cltbld', 18:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:08 INFO - 'MOZ_NO_REMOTE': '1', 18:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:08 INFO - 'NO_EM_RESTART': '1', 18:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:08 INFO - 'PWD': '/builds/slave/test', 18:33:08 INFO - 'SHELL': '/bin/bash', 18:33:08 INFO - 'SHLVL': '1', 18:33:08 INFO - 'TERM': 'linux', 18:33:08 INFO - 'TMOUT': '86400', 18:33:08 INFO - 'USER': 'cltbld', 18:33:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:08 INFO - '_': '/tools/buildbot/bin/python'} 18:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:08 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 18:33:08 INFO - Cleaning up... 18:33:08 INFO - Return code: 0 18:33:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:08 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:08 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 18:33:08 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 18:33:08 INFO - Using env: {'DISPLAY': ':0', 18:33:08 INFO - 'HOME': '/home/cltbld', 18:33:08 INFO - 'LANG': 'en_US.UTF-8', 18:33:08 INFO - 'LANGUAGE': 'en_US:en', 18:33:08 INFO - 'LOGNAME': 'cltbld', 18:33:08 INFO - 'MAIL': '/var/mail/cltbld', 18:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:08 INFO - 'MOZ_NO_REMOTE': '1', 18:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:08 INFO - 'NO_EM_RESTART': '1', 18:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:08 INFO - 'PWD': '/builds/slave/test', 18:33:08 INFO - 'SHELL': '/bin/bash', 18:33:08 INFO - 'SHLVL': '1', 18:33:08 INFO - 'TERM': 'linux', 18:33:08 INFO - 'TMOUT': '86400', 18:33:08 INFO - 'USER': 'cltbld', 18:33:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:08 INFO - '_': '/tools/buildbot/bin/python'} 18:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:09 INFO - Downloading/unpacking psutil>=3.1.1 18:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:10 INFO - Installing collected packages: psutil 18:33:10 INFO - Running setup.py install for psutil 18:33:10 INFO - building 'psutil._psutil_linux' extension 18:33:10 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 18:33:10 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 18:33:10 INFO - building 'psutil._psutil_posix' extension 18:33:10 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 18:33:10 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 18:33:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:10 INFO - Successfully installed psutil 18:33:10 INFO - Cleaning up... 18:33:10 INFO - Return code: 0 18:33:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:33:10 INFO - Using env: {'DISPLAY': ':0', 18:33:10 INFO - 'HOME': '/home/cltbld', 18:33:10 INFO - 'LANG': 'en_US.UTF-8', 18:33:10 INFO - 'LANGUAGE': 'en_US:en', 18:33:10 INFO - 'LOGNAME': 'cltbld', 18:33:10 INFO - 'MAIL': '/var/mail/cltbld', 18:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:10 INFO - 'MOZ_NO_REMOTE': '1', 18:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:10 INFO - 'NO_EM_RESTART': '1', 18:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:10 INFO - 'PWD': '/builds/slave/test', 18:33:10 INFO - 'SHELL': '/bin/bash', 18:33:10 INFO - 'SHLVL': '1', 18:33:10 INFO - 'TERM': 'linux', 18:33:10 INFO - 'TMOUT': '86400', 18:33:10 INFO - 'USER': 'cltbld', 18:33:10 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:10 INFO - '_': '/tools/buildbot/bin/python'} 18:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:11 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 18:33:11 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 18:33:11 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 18:33:11 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 18:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:12 INFO - Installing collected packages: mozsystemmonitor 18:33:12 INFO - Running setup.py install for mozsystemmonitor 18:33:12 INFO - Successfully installed mozsystemmonitor 18:33:12 INFO - Cleaning up... 18:33:12 INFO - Return code: 0 18:33:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:12 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')]} 18:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:12 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')]} 18:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:12 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:12 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 18:33:12 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 18:33:12 INFO - Using env: {'DISPLAY': ':0', 18:33:12 INFO - 'HOME': '/home/cltbld', 18:33:12 INFO - 'LANG': 'en_US.UTF-8', 18:33:12 INFO - 'LANGUAGE': 'en_US:en', 18:33:12 INFO - 'LOGNAME': 'cltbld', 18:33:12 INFO - 'MAIL': '/var/mail/cltbld', 18:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:12 INFO - 'MOZ_NO_REMOTE': '1', 18:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:12 INFO - 'NO_EM_RESTART': '1', 18:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:12 INFO - 'PWD': '/builds/slave/test', 18:33:12 INFO - 'SHELL': '/bin/bash', 18:33:12 INFO - 'SHLVL': '1', 18:33:12 INFO - 'TERM': 'linux', 18:33:12 INFO - 'TMOUT': '86400', 18:33:12 INFO - 'USER': 'cltbld', 18:33:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:12 INFO - '_': '/tools/buildbot/bin/python'} 18:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:12 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:12 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 18:33:12 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 18:33:12 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 18:33:12 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 18:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33: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 18:33: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 18:33: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 18:33: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 18:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:13 INFO - warning: no files found matching '*.txt' 18:33:13 INFO - no previously-included directories found matching 'build' 18:33:13 INFO - no previously-included directories found matching 'dist' 18:33:13 INFO - no previously-included directories found matching '.git*' 18:33:13 INFO - Installing collected packages: jsonschema, functools32 18:33:13 INFO - Running setup.py install for functools32 18:33:13 INFO - warning: no files found matching '*.txt' 18:33:13 INFO - no previously-included directories found matching 'build' 18:33:13 INFO - no previously-included directories found matching 'dist' 18:33:13 INFO - no previously-included directories found matching '.git*' 18:33:13 INFO - Successfully installed jsonschema functools32 18:33:13 INFO - Cleaning up... 18:33:13 INFO - Return code: 0 18:33:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33: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')]} 18:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33: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', '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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:33: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 functools32==3.2.3-2 18:33:13 INFO - Using env: {'DISPLAY': ':0', 18:33:13 INFO - 'HOME': '/home/cltbld', 18:33:13 INFO - 'LANG': 'en_US.UTF-8', 18:33:13 INFO - 'LANGUAGE': 'en_US:en', 18:33:13 INFO - 'LOGNAME': 'cltbld', 18:33:13 INFO - 'MAIL': '/var/mail/cltbld', 18:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:13 INFO - 'MOZ_NO_REMOTE': '1', 18:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:13 INFO - 'NO_EM_RESTART': '1', 18:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:13 INFO - 'PWD': '/builds/slave/test', 18:33:13 INFO - 'SHELL': '/bin/bash', 18:33:13 INFO - 'SHLVL': '1', 18:33:13 INFO - 'TERM': 'linux', 18:33:13 INFO - 'TMOUT': '86400', 18:33:13 INFO - 'USER': 'cltbld', 18:33:13 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:13 INFO - '_': '/tools/buildbot/bin/python'} 18:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:33:14 INFO - Cleaning up... 18:33:14 INFO - Return code: 0 18:33:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:14 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:14 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 18:33:14 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 18:33:14 INFO - Using env: {'DISPLAY': ':0', 18:33:14 INFO - 'HOME': '/home/cltbld', 18:33:14 INFO - 'LANG': 'en_US.UTF-8', 18:33:14 INFO - 'LANGUAGE': 'en_US:en', 18:33:14 INFO - 'LOGNAME': 'cltbld', 18:33:14 INFO - 'MAIL': '/var/mail/cltbld', 18:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:14 INFO - 'MOZ_NO_REMOTE': '1', 18:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:14 INFO - 'NO_EM_RESTART': '1', 18:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:14 INFO - 'PWD': '/builds/slave/test', 18:33:14 INFO - 'SHELL': '/bin/bash', 18:33:14 INFO - 'SHLVL': '1', 18:33:14 INFO - 'TERM': 'linux', 18:33:14 INFO - 'TMOUT': '86400', 18:33:14 INFO - 'USER': 'cltbld', 18:33:14 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:14 INFO - '_': '/tools/buildbot/bin/python'} 18:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:14 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 18:33:14 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 18:33:14 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 18:33:14 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 18:33:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33: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 18:33: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 18:33: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 18:33: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 18:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33: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 18:33: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 18:33: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 18:33: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 18:33:16 INFO - Downloading docopt-0.6.1.tar.gz 18:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:16 INFO - Running setup.py install for blobuploader 18:33:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:16 INFO - Running setup.py install for requests 18:33:16 INFO - Running setup.py install for docopt 18:33:16 INFO - Successfully installed blobuploader requests docopt 18:33:16 INFO - Cleaning up... 18:33:16 INFO - Return code: 0 18:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33: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')]} 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:16 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:16 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 18:33:16 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 18:33:16 INFO - Using env: {'DISPLAY': ':0', 18:33:16 INFO - 'HOME': '/home/cltbld', 18:33:16 INFO - 'LANG': 'en_US.UTF-8', 18:33:16 INFO - 'LANGUAGE': 'en_US:en', 18:33:16 INFO - 'LOGNAME': 'cltbld', 18:33:16 INFO - 'MAIL': '/var/mail/cltbld', 18:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:16 INFO - 'MOZ_NO_REMOTE': '1', 18:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:16 INFO - 'NO_EM_RESTART': '1', 18:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:16 INFO - 'PWD': '/builds/slave/test', 18:33:16 INFO - 'SHELL': '/bin/bash', 18:33:16 INFO - 'SHLVL': '1', 18:33:16 INFO - 'TERM': 'linux', 18:33:16 INFO - 'TMOUT': '86400', 18:33:16 INFO - 'USER': 'cltbld', 18:33:16 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:16 INFO - '_': '/tools/buildbot/bin/python'} 18:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:16 INFO - Running setup.py (path:/tmp/pip-I1vIyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:16 INFO - Running setup.py (path:/tmp/pip-btjAyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:17 INFO - Running setup.py (path:/tmp/pip-bP4qit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:17 INFO - Running setup.py (path:/tmp/pip-WgO07b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:17 INFO - Running setup.py (path:/tmp/pip-07XEwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:17 INFO - Running setup.py (path:/tmp/pip-0mkDeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:17 INFO - Running setup.py (path:/tmp/pip-Bgl6Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:17 INFO - Running setup.py (path:/tmp/pip-2zYr0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:17 INFO - Running setup.py (path:/tmp/pip-LZk6KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:17 INFO - Running setup.py (path:/tmp/pip-vfhZiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:17 INFO - Running setup.py (path:/tmp/pip-MTMXWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:17 INFO - Running setup.py (path:/tmp/pip-MD2SE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:17 INFO - Running setup.py (path:/tmp/pip-h22Mlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:17 INFO - Running setup.py (path:/tmp/pip-BK5l_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:17 INFO - Running setup.py (path:/tmp/pip-qPN_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:17 INFO - Running setup.py (path:/tmp/pip-hl4ZNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:18 INFO - Running setup.py (path:/tmp/pip-wciJET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:18 INFO - Running setup.py install for manifestparser 18:33:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Running setup.py install for mozcrash 18:33:18 INFO - Running setup.py install for mozdebug 18:33:18 INFO - Running setup.py install for mozdevice 18:33:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Running setup.py install for mozfile 18:33:18 INFO - Running setup.py install for mozhttpd 18:33:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Running setup.py install for mozinfo 18:33:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Running setup.py install for mozInstall 18:33:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:18 INFO - Running setup.py install for mozleak 18:33:19 INFO - Running setup.py install for mozlog 18:33:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Running setup.py install for moznetwork 18:33:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Running setup.py install for mozprocess 18:33:19 INFO - Running setup.py install for mozprofile 18:33:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Running setup.py install for mozrunner 18:33:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Running setup.py install for mozscreenshot 18:33:19 INFO - Running setup.py install for moztest 18:33:19 INFO - Running setup.py install for mozversion 18:33:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:19 INFO - Cleaning up... 18:33:19 INFO - Return code: 0 18:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:19 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')]} 18:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:19 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')]} 18:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:19 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:19 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 18:33:19 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 18:33:19 INFO - Using env: {'DISPLAY': ':0', 18:33:19 INFO - 'HOME': '/home/cltbld', 18:33:19 INFO - 'LANG': 'en_US.UTF-8', 18:33:19 INFO - 'LANGUAGE': 'en_US:en', 18:33:19 INFO - 'LOGNAME': 'cltbld', 18:33:19 INFO - 'MAIL': '/var/mail/cltbld', 18:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:19 INFO - 'MOZ_NO_REMOTE': '1', 18:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:19 INFO - 'NO_EM_RESTART': '1', 18:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:19 INFO - 'PWD': '/builds/slave/test', 18:33:19 INFO - 'SHELL': '/bin/bash', 18:33:19 INFO - 'SHLVL': '1', 18:33:19 INFO - 'TERM': 'linux', 18:33:19 INFO - 'TMOUT': '86400', 18:33:19 INFO - 'USER': 'cltbld', 18:33:19 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:19 INFO - '_': '/tools/buildbot/bin/python'} 18:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:20 INFO - Running setup.py (path:/tmp/pip-4YzVYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:20 INFO - Running setup.py (path:/tmp/pip-d9c1o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:20 INFO - Running setup.py (path:/tmp/pip-VjFZqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:20 INFO - Running setup.py (path:/tmp/pip-EdGqwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:20 INFO - Running setup.py (path:/tmp/pip-lj3bBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:20 INFO - Running setup.py (path:/tmp/pip-DoGqLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:20 INFO - Running setup.py (path:/tmp/pip-yfmaeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:20 INFO - Running setup.py (path:/tmp/pip-ZZJpPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:20 INFO - Running setup.py (path:/tmp/pip-S0FgsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:20 INFO - Running setup.py (path:/tmp/pip-ljb4Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:20 INFO - Running setup.py (path:/tmp/pip-lT3L4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:20 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)) 18:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:20 INFO - Running setup.py (path:/tmp/pip-_2yxbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:21 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)) 18:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:21 INFO - Running setup.py (path:/tmp/pip-zUSMwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:21 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)) 18:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:21 INFO - Running setup.py (path:/tmp/pip-6vbQE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:21 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)) 18:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:21 INFO - Running setup.py (path:/tmp/pip-o1FEkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:21 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)) 18:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:21 INFO - Running setup.py (path:/tmp/pip-Kqy4b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:21 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)) 18:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:21 INFO - Running setup.py (path:/tmp/pip-9ufhUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:21 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)) 18:33:21 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)) 18:33:21 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)) 18:33:21 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)) 18:33:21 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)) 18:33:21 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)) 18:33:21 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)) 18:33:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 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 18:33:22 INFO - Downloading blessings-1.6.tar.gz 18:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:22 INFO - Installing collected packages: blessings 18:33:22 INFO - Running setup.py install for blessings 18:33:22 INFO - Successfully installed blessings 18:33:22 INFO - Cleaning up... 18:33:22 INFO - Return code: 0 18:33:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:22 INFO - Reading from file tmpfile_stdout 18:33:22 INFO - Current package versions: 18:33:22 INFO - argparse == 1.2.1 18:33:22 INFO - blessings == 1.6 18:33:22 INFO - blobuploader == 1.2.4 18:33:22 INFO - docopt == 0.6.1 18:33:22 INFO - functools32 == 3.2.3-2 18:33:22 INFO - jsonschema == 2.5.1 18:33:22 INFO - manifestparser == 1.1 18:33:22 INFO - mozInstall == 1.13 18:33:22 INFO - mozcrash == 1.0 18:33:22 INFO - mozdebug == 0.1 18:33:22 INFO - mozdevice == 0.51 18:33:22 INFO - mozfile == 1.2 18:33:22 INFO - mozhttpd == 0.7 18:33:22 INFO - mozinfo == 0.10 18:33:22 INFO - mozleak == 0.1 18:33:22 INFO - mozlog == 3.5 18:33:22 INFO - moznetwork == 0.27 18:33:22 INFO - mozprocess == 0.25 18:33:22 INFO - mozprofile == 0.28 18:33:22 INFO - mozrunner == 6.13 18:33:22 INFO - mozscreenshot == 0.1 18:33:22 INFO - mozsystemmonitor == 0.3 18:33:22 INFO - moztest == 0.8 18:33:22 INFO - mozversion == 1.4 18:33:22 INFO - psutil == 3.1.1 18:33:22 INFO - requests == 1.2.3 18:33:22 INFO - wsgiref == 0.1.2 18:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:22 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')]} 18:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:22 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')]} 18:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:22 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 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:22 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 18:33:22 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 18:33:22 INFO - Using env: {'DISPLAY': ':0', 18:33:22 INFO - 'HOME': '/home/cltbld', 18:33:22 INFO - 'LANG': 'en_US.UTF-8', 18:33:22 INFO - 'LANGUAGE': 'en_US:en', 18:33:22 INFO - 'LOGNAME': 'cltbld', 18:33:22 INFO - 'MAIL': '/var/mail/cltbld', 18:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:22 INFO - 'MOZ_NO_REMOTE': '1', 18:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:22 INFO - 'NO_EM_RESTART': '1', 18:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:22 INFO - 'PWD': '/builds/slave/test', 18:33:22 INFO - 'SHELL': '/bin/bash', 18:33:22 INFO - 'SHLVL': '1', 18:33:22 INFO - 'TERM': 'linux', 18:33:22 INFO - 'TMOUT': '86400', 18:33:22 INFO - 'USER': 'cltbld', 18:33:22 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:22 INFO - '_': '/tools/buildbot/bin/python'} 18:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 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)) 18:33:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:33:23 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 18:33:23 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 18:33:23 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 18:33:23 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 18:33:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:33:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:33:24 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 18:33:24 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 18:33:24 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 18:33:24 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 18:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:33:24 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)) 18:33:24 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)) 18:33:24 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)) 18:33:24 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)) 18:33:24 INFO - Installing collected packages: marionette-driver, simplejson 18:33:24 INFO - Running setup.py install for marionette-driver 18:33:24 INFO - Running setup.py install for simplejson 18:33:24 INFO - building 'simplejson._speedups' extension 18:33:24 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 18:33:25 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 18:33:25 INFO - Successfully installed marionette-driver simplejson 18:33:25 INFO - Cleaning up... 18:33:25 INFO - Return code: 0 18:33:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7eb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, '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': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', '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 18:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:33:25 INFO - Using env: {'DISPLAY': ':0', 18:33:25 INFO - 'HOME': '/home/cltbld', 18:33:25 INFO - 'LANG': 'en_US.UTF-8', 18:33:25 INFO - 'LANGUAGE': 'en_US:en', 18:33:25 INFO - 'LOGNAME': 'cltbld', 18:33:25 INFO - 'MAIL': '/var/mail/cltbld', 18:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:25 INFO - 'MOZ_NO_REMOTE': '1', 18:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:25 INFO - 'NO_EM_RESTART': '1', 18:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:25 INFO - 'PWD': '/builds/slave/test', 18:33:25 INFO - 'SHELL': '/bin/bash', 18:33:25 INFO - 'SHLVL': '1', 18:33:25 INFO - 'TERM': 'linux', 18:33:25 INFO - 'TMOUT': '86400', 18:33:25 INFO - 'USER': 'cltbld', 18:33:25 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:25 INFO - '_': '/tools/buildbot/bin/python'} 18:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:25 INFO - Cleaning up... 18:33:25 INFO - Return code: 0 18:33:25 INFO - Running post-action listener: _resource_record_post_action 18:33:25 INFO - Running post-action listener: _start_resource_monitoring 18:33:25 INFO - Starting resource monitoring. 18:33:25 INFO - [mozharness: 2017-07-18 01:33:25.939042Z] Finished create-virtualenv step (success) 18:33:25 INFO - [mozharness: 2017-07-18 01:33:25.939561Z] Running install step. 18:33:25 INFO - Running pre-action listener: _resource_record_pre_action 18:33:25 INFO - Running main action method: install 18:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:26 INFO - Reading from file tmpfile_stdout 18:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:26 INFO - Reading from file tmpfile_stdout 18:33:26 INFO - Output received: 18:33:26 INFO - Usage: mozinstall [options] installer 18:33:26 INFO - Options: 18:33:26 INFO - -h, --help show this help message and exit 18:33:26 INFO - -d DEST, --destination=DEST 18:33:26 INFO - Directory to install application into. [default: 18:33:26 INFO - "/builds/slave/test"] 18:33:26 INFO - --app=APP Application being installed. [default: firefox] 18:33:26 INFO - mkdir: /builds/slave/test/build/application 18:33:26 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'] 18:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:33:44 INFO - Reading from file tmpfile_stdout 18:33:44 INFO - Output received: 18:33:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:33:44 INFO - Running post-action listener: _resource_record_post_action 18:33:44 INFO - [mozharness: 2017-07-18 01:33:44.043574Z] Finished install step (success) 18:33:44 INFO - [mozharness: 2017-07-18 01:33:44.043830Z] Running setup-mitmproxy step. 18:33:44 INFO - Running pre-action listener: _resource_record_pre_action 18:33:44 INFO - Running main action method: setup_mitmproxy 18:33:44 INFO - Skipping: mitmproxy is not required 18:33:44 INFO - Running post-action listener: _resource_record_post_action 18:33:44 INFO - [mozharness: 2017-07-18 01:33:44.044979Z] Finished setup-mitmproxy step (success) 18:33:44 INFO - [mozharness: 2017-07-18 01:33:44.045266Z] Running run-tests step. 18:33:44 INFO - Running pre-action listener: _resource_record_pre_action 18:33:44 INFO - Running pre-action listener: _set_gcov_prefix 18:33:44 INFO - Running main action method: run_tests 18:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:33:44 INFO - Python 2.7.3 18:33:44 INFO - Return code: 0 18:33:44 INFO - grabbing minidump binary from tooltool 18:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:44 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 0x2b7bd00>, '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 0x2b7cc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:33:44 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 18:33:44 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 18:33:44 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 18:33:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:33:44 INFO - Return code: 0 18:33:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:33:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:33:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:33:44 INFO - ENV: RUST_BACKTRACE is now 1 18:33:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:33:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:33:44 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/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 18:33:44 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/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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 18:33:44 INFO - Using env: {'DISPLAY': ':0', 18:33:44 INFO - 'HOME': '/home/cltbld', 18:33:44 INFO - 'LANG': 'en_US.UTF-8', 18:33:44 INFO - 'LANGUAGE': 'en_US:en', 18:33:44 INFO - 'LOGNAME': 'cltbld', 18:33:44 INFO - 'MAIL': '/var/mail/cltbld', 18:33:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:33:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:44 INFO - 'MOZ_NO_REMOTE': '1', 18:33:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:44 INFO - 'NO_EM_RESTART': '1', 18:33:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:44 INFO - 'PWD': '/builds/slave/test', 18:33:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:33:44 INFO - 'RUST_BACKTRACE': '1', 18:33:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:33:44 INFO - 'SHELL': '/bin/bash', 18:33:44 INFO - 'SHLVL': '1', 18:33:44 INFO - 'TERM': 'linux', 18:33:44 INFO - 'TMOUT': '86400', 18:33:44 INFO - 'USER': 'cltbld', 18:33:44 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896', 18:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:44 INFO - '_': '/tools/buildbot/bin/python'} 18:33:44 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/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 18:33:44 INFO - mozversion application_buildid: 20170718002759 18:33:44 INFO - mozversion application_changeset: 5e73b9798464c3f7106f0161dc9a49b234f42f9c 18:33:44 INFO - mozversion application_display_name: Nightly 18:33:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:33:44 INFO - mozversion application_name: Firefox 18:33:44 INFO - mozversion application_remotingname: firefox 18:33:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:33:44 INFO - mozversion application_vendor: Mozilla 18:33:44 INFO - mozversion application_version: 56.0a1 18:33:44 INFO - mozversion platform_buildid: 20170718002759 18:33:44 INFO - mozversion platform_changeset: 5e73b9798464c3f7106f0161dc9a49b234f42f9c 18:33:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:33:44 INFO - mozversion platform_version: 56.0a1 18:33:44 INFO - using testdate: 1500341624 18:33:44 INFO - actual date: 1500341624 18:33:44 INFO - starting webserver on 'localhost:58247' 18:33:44 INFO - SUITE-START | Running 2 tests 18:33:44 INFO - TEST-START | dromaeo_css 18:33:44 INFO - Initialising browser for dromaeo_css test... 18:33:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58247/getInfo.html -profile /tmp/tmpRk35M0/profile 18:33:44 INFO - TEST-INFO | started process 31112 (/builds/slave/test/build/application/firefox/firefox http://localhost:58247/getInfo.html) 18:33:50 INFO - TEST-INFO | 31112: exit 0 18:33:50 INFO - Browser initialized. 18:33:50 INFO - Running cycle 1/1 for dromaeo_css test... 18:33:50 INFO - TEST-INFO | started process 31321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRk35M0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:01 INFO - PID 31321 | RSS: Main: 160739328 18:34:01 INFO - PID 31321 | 18:36:59 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58247/tests/dromaeo/cssquery-ext.html) 18:37:00 INFO - PID 31321 | RSS: Main: 169222144 18:37:00 INFO - PID 31321 | 18:40:02 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-ext.html (next: http://localhost:58247/tests/dromaeo/cssquery-jquery.html) 18:40:03 INFO - PID 31321 | RSS: Main: 167038976 18:40:03 INFO - PID 31321 | 18:43:04 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58247/tests/dromaeo/cssquery-mootools.html) 18:43:05 INFO - PID 31321 | RSS: Main: 168423424 18:43:05 INFO - PID 31321 | 18:46:06 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58247/tests/dromaeo/cssquery-prototype.html) 18:46:07 INFO - PID 31321 | RSS: Main: 167899136 18:46:07 INFO - PID 31321 | 18:49:10 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58247/tests/dromaeo/cssquery-yui.html) 18:49:10 INFO - PID 31321 | RSS: Main: 167677952 18:49:10 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:58247/tests/dromaeo/cssquery-yui.html (next: http://localhost:58247/tests/dromaeo/cssquery-dojo.html) 18:52:12 INFO - PID 31321 | RSS: Main: 170917888 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | __start_tp_report 18:52:12 INFO - PID 31321 | _x_x_mozilla_page_load 18:52:12 INFO - PID 31321 | _x_x_mozilla_page_load_details 18:52:12 INFO - PID 31321 | |i|pagename|runs| 18:52:12 INFO - PID 31321 | |0;dojo.html;3391.609964854041;3437.6218615952243;3443.913902152446;3450.9137271568225;3468.2023134679025;6244.063390491428;6292.056191571267;6295.024271237954;6301.212348456443;6355.8093257202245;6286.937130628692;6295.307516173229;6319.589226700261;6320.462760665349;6363.777267795628;5503.036968530511;5506.752196151183;5528.917066244009;5551.666899985994;5595.300587426572;5580.330360356763;5580.525655319303;5580.86047848803;5581.079121944895;5592.384837667853;5568.693721845297;5575.024370735126;5583.720813959306;5590.385057643656;5594.440555944414;5548.44515548446;5582.748776305076;5586.994341018615;5594.720263986805;5607.943920560783;5471.863203419906;5496.955578440124;5516.613837031409;5516.668999860021;5612.186232996233;6224.502039836802;6225.159603453521;6246.6876656167005;6284.18305620271;6297.622142671455;6698.631575263358;6733.09103271057;6772.390484856386;6815.863682726367;6833.487488438387;6797.388235058819;6814.454843612499;6823.420009299166;6825.624590647512;6853.4174595159475;6285.057241413779;6312.116303717483;6312.621242725405;6312.652804095773;6344.49244060474;5905.40945905406;6916.723331066802;6987.475939304572;7006.684699188549;7032.578045317297;6519.380658837403;6686.398224159849;6730.899036514456;6751.594904305757;6756.560823546453;6699.497537684693;6839.965800170968;6842.4868134890085;6861.451083913275;6913.1358580177475;6663.06717059612;6673.566218195801;6674.299198584079;6675.7997260082275;6691.364320389555;6189.473894718909;6698.5980841149685;6719.596824190564;6780.762673306411;6796.932030679729;4999.0501804657;5052.141136006888;5114.411842638145;5114.897702045938;5118.360204974379;4482.9775851121185;4490.550944905483;4491.775411229425;4508.639308855284;4538.410006699174;6392.328805475451;6393.264774550986;6405.48756099511;6414.871702566016;6439.291677915426;6778.457723382117;6780.1524809398825;6811.523193376416;6814.727410903607;6818.147731533559;6324.71538780756;6344.555881088372;6404.519661025442;6416.679166041679;6439.291677915426;5707.743151558107;5719.828405147852;5735.827925162252;5770.134479827975;5845.678487683218;7220.566765994057;7233.168185658611;7297.05138332024;7312.963435182896;7331.926680733124;6834.179898412222;6842.7605033823575;6867.381935625817;6919.481038922202;6936.0636314098965;7077.893831592633;7126.35862772353;7161.892571611325;7230.855382892418;7261.164966028763;5746.885062298814;6711.597304161766;6736.225334086446;6746.190457144978;6760.492963027891;6817.250102488623;6883.655817209019;6949;6977.441804655717;6983.1620205575655;6560.3111673275525;6613.570117942319;6669.7665581704405;6688.398044176048;6692.063111164538;6451.548391612542;6528.771492997722;6613.27254002069;6625.900611490735;6709.597424154371;6564.4748420125325;6589.275179730322;6592.670366481752;6597.175353080865;6597.9113446282745;5711.828645140652;6589.571677840925;6611.537192396486;6724.4284235840505;6806.523543352116;6492.448141907991;6494;6556.967215163893;6571.047198156336;6573.737050518117 18:52:12 INFO - PID 31321 | |1;ext.html;865.1532836283079;899.0039275420758;920.8388532006899;940.6801687426274;940.8118376324737;41880.37179442307;42813.78593107038;43016.3547546787;43019.139617207635;43083.78458107713;44532;45408.3188752169;45470.77264613672;45471.545284547145;45537.544624553746;7365;7511.924880751205;7515.774526764206;7517.849643007136;7524.247575242459;7292;7420.369268612175;7420.4805663603565;7420.888686669704;7443.516171448839;7453.478256522046;7460.179380268193;7479.513831600956;7495;7497.437692173082;7401.296876796696;7436.516626419292;7442.553446793209;7442.665080071382;7484.550926944401;7194.748183813594;7231.3130252625915;7238.2761723827725;7238.733221686237;7244.637768111626;38704;38768.22463550742;38809.61190388088;38852.41721374181;39896.80051599752;3552.2007548301426;3554.662307080823;3567.357875582394;3580.874669386585;3582.7133829293593;32004.199895002577;32231;32380;32436;32499.51250731241;4892.706437613754;4991.226359914219;5009.2486127080865;5009.599232061463;5096.566791822699;205255;210229;210512;211823;212182;42343.36484952728;51151;52180.21729674058;52418.73790631023;52603.73698131485;54710.72644636752;54747.45252547503;55034.44965550293;55205.51575179127;55286;16710.08094554787;16766.497005089623;16866.662666746597;16889.662206755795;16920.238589263514;13726.107802992774;13754.587362379145;13776.793348099787;13863.4454621814;13890.791638125234;13746.037777355688;13930.58208253754;13948;14006.649833754238;14153;5202.947970520322;5213.191955246943;5214.556762675215;5311.176767601028;5324.440933701983;1049.2340591368343;1051.1538211739623;1062.8193207154802;1078.396098185019;1095.1567293184203;23931.880340598185;24261.514769704507;24262.514749704907;24296.635550466755;24787.00851965901;1169.3743847041962;1178.1080678033607;1191.112621097288;1196.5572738086964;1201.177193622354;12806.231626102277;13076.542321018718;13079.084464087422;13112.147710398793;13140.671483212805;293662;294706;295227;295630;296651;56017.439825602036;56090;56203;56277.71861140668;56501.43498564962;1446.8914831387688;1496.0425327790224;1497.2513743128436;1508.2081906998912;1515.113658509762;24065.639015414432;29775.404491910474;30075.849620751756;30238.54642180413;30493.54259686062;53862;54145.45854541562;54201.728991354794;54224.728876355366;54346;238600;238836;239658;239926;240530;32456.67543324631;32612.184695381857;32870.02779833218;32934.83532582322;34423.655763442046;41334;45242;46072.76963615161;46341.304880427495;46574;32766;32966;33477.83261083679;33566.664333356355;33628.831855840566;33127.503087453224;33340.816234903126;33488.16279593029;33505.32989340151;33900.49149262813;37710.24579508339;38480.615193847705;38994.6100538991;39000.41499377568;39104.41343379795;30642;32132.678673213904;32296.677033229367;32364;32764.344713106082;24540.361713717808;24560;25014.624780627943;25266.36834079163;25604.871975640002 18:52:12 INFO - PID 31321 | |2;jquery.html;557.4342042826535;558.4666643355594;565.375260337327;570.1675553691608;591.3760982163818;21832.89083554582;22784.088636454562;22939.311820645406;23019.884900575475;23027.654585181215;25398.74601253987;26258.6061209082;27523.862380688068;27727.306817329576;27792.861035694845;5994.400559944003;6042.274927008743;6043;6051.062085376773;6086.330503644595;6024.5180385569265;6056.242969628796;6056.727447264861;6068.180795592582;6105.511559075286;6025.819225423223;6075.149479072933;6154.476869466078;6622.8675426491445;6697.698603562827;6510.707018184193;6610.570312929644;6619.404253617174;6645.4683625310345;6668.533202675814;6529.249136349333;6570.375814297634;6570.375814297634;6571;6579.835504112388;31034.689653103407;32256.193595160075;32739.345213095843;33283.500747488804;33373.833130834435;2216.612092883739;2236.731592208945;2242.495438526335;2244.9663255051187;2251.5159240763314;20786.168553257852;20799.480012999644;21085.8945705272;21234.5753084939;21271.8936405317;2100.3698890332994;2111.915523379063;2167.295628920607;2183.54145629418;2195.3523710505438;154389;159143;159253;159459.2027039869;159559;22411.775882241294;22574.774252257597;23703.881480592485;24876;25500.872495637403;49358.25962610564;49534.75232623814;49547.50452495429;49550;49800.750996245515;12206.816897746541;12685.556005539762;12837.935810320889;12863.549775757803;12913.225206487454;10472.476376181161;10526.789464210826;10546.209034322457;10581.36511809294;10649;12130.393480325949;12364.505419783109;12626.621201363974;12634.936825316;12645.292885460345;2731.7951153663553;2758.517259479583;2859.099383694171;4562.498125206224;4796.736179510091;1006.4112494190834;1011.2415688233824;1041.3959903256093;1057.1595581512715;1057.5716834681966;21114.366569002956;21438;21558.353249402542;21762.476626635984;22364.776352236593;1064.6805958212506;1090.86909570852;1094.7755710079573;1101.427257825942;1116.062507493693;11743.88256117445;11772.88227117735;11795.115366347558;11881.524739010516;12045.859516548577;556900;562949;568241;568398;572774;121577;135238;135920.32039839934;137752;138865;1226.4726167747954;1255.7551277500982;1278.4822147030281;1282.24347634894;1283.3775618824861;17944;19003.14485848168;19013.61972760565;19066.809331906505;19132.23471061142;58266.7086664564;61378.38621613727;61801.69099154655;62076.379236208864;62506;75582.62208688921;78082;78197;78508.21491785008;78965;14776.704465910836;14850.851491485379;14994.100353978796;15054.849451505344;15112.244387780787;23546.175883843982;23843.523129537658;23901.163459278843;24137.758622414254;24339.26982190537;19319;19358.516037099183;19575.119119639934;19733;19925.701114483003;17250;17351.351891249877;17360.479185624452;18035.18841652155;18259.360922367654;19361;19878.10548525291;20072;20248.89875550613;20596.897015514827;14685;14831.184284864004;14930.402783888523;14941.327640256432;14944.7758283628;18580.2567897288;19623;19741.506462338555;19784.406467805988;19841.611087223755 18:52:12 INFO - PID 31321 | |3;mootools.html;1420.602231375215;1433.7132573485299;1474.1966025072243;1476.2987580899073;1492.5522343297002;14838.258087095643;15423;15587.688246235082;15592.14243216624;15604.453844115458;14943;15459.30433130509;15850;15909.124998125099;15982;2523.1295203154973;2588.094167041539;2599.54507961107;2607.5958226474927;2612;2671.1585850457045;2717.076194094008;2717.334253107991;2721.8502982335963;2730.194592595189;2463.876806159694;2470.7405722399158;2486.8010559155314;2495.4759500504915;2497.438076432797;2489.987550062247;2559.1298958354155;2564.5640241158862;2568.524822907768;2569.177863083814;2346.636271377939;2379.167291447997;2381.7856392924546;2386.809055275574;2386.880655967195;15173.468928587557;15280.465183718628;15334.309956051893;15346.693066138727;15381.307841147063;7978.800529986739;8263.380246481478;8333.95833020831;8346.874796878052;8350;5009.148444764399;5180.507851754077;5314.521693047605;5357.330333708286;5367;1810.2651277921918;1815.373696074852;1848.92604295828;1906.8951207683572;1912.1108684461653;26760.59859102115;26789.732102678918;26802.86598567014;26892.731072689217;26911;6702.463802895757;6749.2238392584495;6758.864822703518;6980.197277313073;7019;18117.275308987493;18218.817811821977;18298.085095745424;18321.816781832276;18337.083145842655;7887;8124.918750812416;8132.959335203286;8146.389020823462;8163.428560000862;7460.552366857897;7475.25247475259;7488.4009279257525;7557.05536807899;7677.731279405306;5071.7971281149075;5175.094358487249;5186.988537235203;5213.191955246943;5275.498827611371;1513.8259100203397;1530.8086489188852;1533.7162624914426;1544.8995815272197;1564.1866229560792;929.1776777551916;935.2004036548789;944.1596978688972;951.9190868776232;964.3153361113548;7925.643346049442;7986.7603971880935;7988.360931125496;8114;8169.918300817035;727.0185249912576;729.3836707981746;743.2901578992049;753.7135888362496;754.1779460388094;5384.623076384615;5466.262054622575;5659.830205093854;5667.319921609434;5783.161441590946;20369.694454583194;21340.893295533424;22227.333180004625;22363;22377.552448951257;20717.89641051815;21348.466288342606;21560.460988475414;21654.89172554127;21720.674189887166;11435.771284574428;11965.222260553037;12114.757704845853;12186.756264874653;12200.755984880252;8566.443181193203;8683.348748843735;8920.509371984344;8953.910460895568;8978.775530611787;17824.91087544554;18401.171947262672;18854.434366969013;18901.149448275137;19091;19436.708449373553;19748;20133.49666258355;20137;20255.4936126598;12310.692232694255;12374.62876113718;12572.994160467324;12816.487340506275;13019.544315949275;14221.217833019284;14411.567652970427;14481.782773258199;14486.768624667022;14489.406165321596;11034.668959931216;11435.942820285845;11491.080713543064;11637.592684256011;11954.462049207632;11440.771184576428;11449.656510304705;11528.02011829004;11706.180567360543;11817.231879927776;9864.950675246579;9979;10007.349522281029;10014.298999069995;10043.196544276587;6936.271691472524;7337.669804858688;7360.39468493621;7486.5508069516;7556.8866467001935;7364;7475.551466912003;7484.775456736306;7507.099148102263;7669.118051424158 18:52:12 INFO - PID 31321 | |4;prototype.html;496.14910428614917;501.4759576242825;529.7589596733486;533.0671325180931;537.8924215156969;6075.696215189239;6088.0259158534645;6089.269287685478;6147.1701320321745;6149.3235744068115;5819.352194751388;6000.339962604121;6033.396660333975;6050.636961782297;6053.969730151354;4695.624350052005;4748.646635708824;4758.595519380848;4798.352222449959;4829.51704829516;4709.199436095855;4792.784324705397;4794.544518270759;4797.208460603996;4840.951590484103;4580.1984652685815;4683.953160468386;4747.810087596492;4768.189407800664;4779.044191161782;4731.78706958186;4737.50256223095;4765.118453086156;4786.8085276589245;4813.08551375241;4320.33034879591;4334.436523251957;4348.586884245991;4350;4357.782110894443;5911.733971971272;5936.97031514844;5984.640921544721;5992.101184822268;6002.0996850472775;5642.175939571689;5688.345840228385;5722.599418040739;5733.312002559678;5743.655380677173;6523.478121750249;6524.651125594782;6536.215654121488;6554;6562.9671851640915;4921.474342953696;4938.530839570235;4952.62855285855;4964.35463389757;4976.701397916137;6809.863802723968;6841.418479429254;6842.726290948356;6864.313568643146;6893.241743408221;5055.266986287042;5066;5070.822521211814;5103.387593488731;5105.361829771278;5079.161938280143;5082.33929589151;5097.770600322994;5099.36257967754;5160.432352441228;5645.5483561314995;5710.114932185518;5718.342390625131;5745.454181852718;5751.654900705971;6555.3772391622715;6564.409203171642;6582.45312351597;6616;6616.14747870597;1770.106096421299;1779.9822001780076;1791.3551121596477;1793.5695433096223;1808.2857271377732;1149.7183190118474;1152.6599653102187;1237.4740735187509;1239.021173273104;1258.5028913579085;6033.78881739137;6128.601640893327;6131.724072416752;6165.938340616536;6289.779857704958;6546.378094081055;6658.966705166443;6671.232808227116;6711.362420570038;6712.899306510406;6163.825629800656;6192.845178870564;6254.781082662085;6264.906026409516;6291.182146320949;3499.4575840744214;3511.631278715749;3517.50754894315;3517.8416971236356;3568.6439153121646;6874.9656251718425;6879.690413931385;6997.615131167733;7098.1482222132645;7121.287871212838;6828.9658551706925;6853.143357080365;6864.141982252218;6867.450603951672;6912.481563882729;6987.685554150075;6988.371046605626;7070.46971477131;7086.610236437045;7111.53775004623;6638.402543771083;6640.867182656417;6661.2006559213205;6677.866442671217;6701.8166370973395;6571.605703657796;6575.934240657532;6588.07766912623;6621.470282377302;6645.435138013323;6887.483438742214;6993.510454268152;6996.685149168198;7004.404625606677;7021;5004.274380214775;5041;5046.596272298134;5051.8633307505515;5091.523458197082;6645.700943457653;6675.9666201670625;6708.429783468265;6727.159105111861;6776.390124888783;6473.579217350857;6518.706658200487;6541.967290163519;6546.901796472961;6549.967250163719;6398.5201109916015;6413.761050669382;6441.903371449338;6481.740730370732;6560.343965603402;6446.774362897276;6451.967740161457;6460.547761656639;6492.480601551959;6516.934830651822;5869.882602348014;6271.498280137669;6291.716872740646;6443.903341449975;6498.252700939263;6120.571559990758;6227.626342419469;6283.937160628335;6294.622322660655;6323.20959880015 18:52:12 INFO - PID 31321 | |5;yui.html;902.8374892519348;945.1729736480579;946.9763255918601;949.6581230756926;953.5184731710485;17298.221580028898;21413.67879481807;22119.004644791003;23144.42138946527;23469.530609387803;19220.903895480504;19706.11322490488;19768.604627907433;19847.702284465708;19855.702164467508;1034.5292891734243;1053.210092430677;1058.8994045565698;1059.422614675004;1059.7774467361862;1065.0148612533415;1065.8134826405387;1065.8614380130573;1065.9093977011923;1068.1081297116878;999.1207737191262;1121.0695123047892;1125.2629527659396;1131;1132.1282612388457;1014.3254735600816;1091.241587096968;1093.5243169221415;1093.907017903479;1094.545763508147;795.1412474527555;805.1867613710136;807.5477732469835;809.0857331215689;813.7762115418249;18917.90541047286;19279.036048197675;20181.29365472216;20274.797252027438;20586.58826823455;20889.477763055893;21019.474513137142;21548.89225553878;21685.13259469619;21703.56592868134;15189.316480758282;15326.923365383213;15341;15347.693046139015;16897.15514224284;3665.321915445651;3677.7425580209397;3682.171511409938;3709.239605880788;3724.4599533067826;104909;143807;144452.27773861063;148354;150223.24888375596;12981.156224845356;13310.334483275798;15499.070055796688;16171.919140404458;17221.56946076358;30717.38565228683;31059;31713.682863171536;32009.199770005936;32203.194920127185;9486.667966621135;9491.477968711788;9503.809923801624;9545.713628591153;9562.61749530025;4372.060007098489;4523.5928766410525;4524.886877828015;4533.705309154961;4539.31910213464;4810.302506136661;4816;4982.676126051868;5009.423916249605;5033.640916952402;1075.499892549968;1086.6794295682791;1095.5836782022939;1115.2360632966445;1115.743379022813;690.5097380859646;693.7121094745725;709.8935159726083;712.2592503796097;743.695085015152;12723.936380318224;13325.93337033328;13698.45206191741;13913.165210087427;14094.929525352307;690.9032735417046;720.1106633307861;721.6319676964681;724.5073350121862;728.8542291541713;5778.422157784272;5802.680852553066;5834.883302334015;5849.61977471463;5870.7945221917025;125776;128788;129118;130796;132829.33585332206;112661;114564;114761.42619287017;115337.4233128829;117234;98899.99999999856;102695;103769;105924.47037764762;106585.46707266413;13595.52415665447;13608.65978350549;14119.39287706136;14148.109269950433;14427;44283.77858110818;45041.32438013367;46091.769541152076;47024.059518810114;49693.25460118029;85201;85266.1473385283;86917.56541217254;87442;88861.55569222113;18170;18614.16236269344;18658.34695785641;18756.6248675023;18996.43010709681;22258.77741222567;22354.77645223527;22531;23214.419639508473;23613.881930590236;19347.613047739247;20037.848714990978;20040.699389508878;20170.596588067863;20215.090320935888;20532.897335513226;21394;21747.23884664029;21797;21878.343649690534;18835.623287534447;18900;18908.43274701761;19004.619907602046;19059.14233859452;12259.938700306442;12612.117151799654;12631.368431578201;12643.557475488315;12713.427895744899;13099.672508187372;13158;13317.334133293103;13374.598762037154;13489.460421583026 18:52:12 INFO - PID 31321 | __end_tp_report 18:52:12 INFO - PID 31321 | __start_cc_report 18:52:12 INFO - PID 31321 | _x_x_mozilla_cycle_collect,297 18:52:12 INFO - PID 31321 | __end_cc_report 18:52:12 INFO - PID 31321 | __startTimestamp1500342732679__endTimestamp 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | ------- Summary: start ------- 18:52:12 INFO - PID 31321 | Number of tests: 6 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#0] dojo.html Cycles:165 Average:6248.50 Median:6519.38 stddev:800.26 (12.3%) stddev-sans-first:770.69 18:52:12 INFO - PID 31321 | Values: 3391.6 3437.6 3443.9 3450.9 3468.2 6244.1 6292.1 6295.0 6301.2 6355.8 6286.9 6295.3 6319.6 6320.5 6363.8 5503.0 5506.8 5528.9 5551.7 5595.3 5580.3 5580.5 5580.9 5581.1 5592.4 5568.7 5575.0 5583.7 5590.4 5594.4 5548.4 5582.7 5587.0 5594.7 5607.9 5471.9 5497.0 5516.6 5516.7 5612.2 6224.5 6225.2 6246.7 6284.2 6297.6 6698.6 6733.1 6772.4 6815.9 6833.5 6797.4 6814.5 6823.4 6825.6 6853.4 6285.1 6312.1 6312.6 6312.7 6344.5 5905.4 6916.7 6987.5 7006.7 7032.6 6519.4 6686.4 6730.9 6751.6 6756.6 6699.5 6840.0 6842.5 6861.5 6913.1 6663.1 6673.6 6674.3 6675.8 6691.4 6189.5 6698.6 6719.6 6780.8 6796.9 4999.1 5052.1 5114.4 5114.9 5118.4 4483.0 4490.6 4491.8 4508.6 4538.4 6392.3 6393.3 6405.5 6414.9 6439.3 6778.5 6780.2 6811.5 6814.7 6818.1 6324.7 6344.6 6404.5 6416.7 6439.3 5707.7 5719.8 5735.8 5770.1 5845.7 7220.6 7233.2 7297.1 7313.0 7331.9 6834.2 6842.8 6867.4 6919.5 6936.1 7077.9 7126.4 7161.9 7230.9 7261.2 5746.9 6711.6 6736.2 6746.2 6760.5 6817.3 6883.7 6949.0 6977.4 6983.2 6560.3 6613.6 6669.8 6688.4 6692.1 6451.5 6528.8 6613.3 6625.9 6709.6 6564.5 6589.3 6592.7 6597.2 6597.9 5711.8 6589.6 6611.5 6724.4 6806.5 6492.4 6494.0 6557.0 6571.0 6573.7 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#1] ext.html Cycles:180 Average:42404.61 Median:3553.43 stddev:65392.21 (1840.3%) stddev-sans-first:65501.27 18:52:12 INFO - PID 31321 | Values: 865.2 899.0 920.8 940.7 940.8 41880.4 42813.8 43016.4 43019.1 43083.8 44532.0 45408.3 45470.8 45471.5 45537.5 7365.0 7511.9 7515.8 7517.8 7524.2 7292.0 7420.4 7420.5 7420.9 7443.5 7453.5 7460.2 7479.5 7495.0 7497.4 7401.3 7436.5 7442.6 7442.7 7484.6 7194.7 7231.3 7238.3 7238.7 7244.6 38704.0 38768.2 38809.6 38852.4 39896.8 3552.2 3554.7 3567.4 3580.9 3582.7 32004.2 32231.0 32380.0 32436.0 32499.5 4892.7 4991.2 5009.2 5009.6 5096.6 205255.0 210229.0 210512.0 211823.0 212182.0 42343.4 51151.0 52180.2 52418.7 52603.7 54710.7 54747.5 55034.4 55205.5 55286.0 16710.1 16766.5 16866.7 16889.7 16920.2 13726.1 13754.6 13776.8 13863.4 13890.8 13746.0 13930.6 13948.0 14006.6 14153.0 5202.9 5213.2 5214.6 5311.2 5324.4 1049.2 1051.2 1062.8 1078.4 1095.2 23931.9 24261.5 24262.5 24296.6 24787.0 1169.4 1178.1 1191.1 1196.6 1201.2 12806.2 13076.5 13079.1 13112.1 13140.7 293662.0 294706.0 295227.0 295630.0 296651.0 56017.4 56090.0 56203.0 56277.7 56501.4 1446.9 1496.0 1497.3 1508.2 1515.1 24065.6 29775.4 30075.8 30238.5 30493.5 53862.0 54145.5 54201.7 54224.7 54346.0 238600.0 238836.0 239658.0 239926.0 240530.0 32456.7 32612.2 32870.0 32934.8 34423.7 41334.0 45242.0 46072.8 46341.3 46574.0 32766.0 32966.0 33477.8 33566.7 33628.8 33127.5 33340.8 33488.2 33505.3 33900.5 37710.2 38480.6 38994.6 39000.4 39104.4 30642.0 32132.7 32296.7 32364.0 32764.3 24540.4 24560.0 25014.6 25266.4 25604.9 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#2] jquery.html Cycles:180 Average:39885.37 Median:11964.89 stddev:95380.77 (797.2%) stddev-sans-first:95602.63 18:52:12 INFO - PID 31321 | Values: 557.4 558.5 565.4 570.2 591.4 21832.9 22784.1 22939.3 23019.9 23027.7 25398.7 26258.6 27523.9 27727.3 27792.9 5994.4 6042.3 6043.0 6051.1 6086.3 6024.5 6056.2 6056.7 6068.2 6105.5 6025.8 6075.1 6154.5 6622.9 6697.7 6510.7 6610.6 6619.4 6645.5 6668.5 6529.2 6570.4 6570.4 6571.0 6579.8 31034.7 32256.2 32739.3 33283.5 33373.8 2216.6 2236.7 2242.5 2245.0 2251.5 20786.2 20799.5 21085.9 21234.6 21271.9 2100.4 2111.9 2167.3 2183.5 2195.4 154389.0 159143.0 159253.0 159459.2 159559.0 22411.8 22574.8 23703.9 24876.0 25500.9 49358.3 49534.8 49547.5 49550.0 49800.8 12206.8 12685.6 12837.9 12863.5 12913.2 10472.5 10526.8 10546.2 10581.4 10649.0 12130.4 12364.5 12626.6 12634.9 12645.3 2731.8 2758.5 2859.1 4562.5 4796.7 1006.4 1011.2 1041.4 1057.2 1057.6 21114.4 21438.0 21558.4 21762.5 22364.8 1064.7 1090.9 1094.8 1101.4 1116.1 11743.9 11772.9 11795.1 11881.5 12045.9 556900.0 562949.0 568241.0 568398.0 572774.0 121577.0 135238.0 135920.3 137752.0 138865.0 1226.5 1255.8 1278.5 1282.2 1283.4 17944.0 19003.1 19013.6 19066.8 19132.2 58266.7 61378.4 61801.7 62076.4 62506.0 75582.6 78082.0 78197.0 78508.2 78965.0 14776.7 14850.9 14994.1 15054.8 15112.2 23546.2 23843.5 23901.2 24137.8 24339.3 19319.0 19358.5 19575.1 19733.0 19925.7 17250.0 17351.4 17360.5 18035.2 18259.4 19361.0 19878.1 20072.0 20248.9 20596.9 14685.0 14831.2 14930.4 14941.3 14944.8 18580.3 19623.0 19741.5 19784.4 19841.6 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#3] mootools.html Cycles:180 Average:9525.18 Median:2488.39 stddev:6836.92 (274.8%) stddev-sans-first:6828.98 18:52:12 INFO - PID 31321 | Values: 1420.6 1433.7 1474.2 1476.3 1492.6 14838.3 15423.0 15587.7 15592.1 15604.5 14943.0 15459.3 15850.0 15909.1 15982.0 2523.1 2588.1 2599.5 2607.6 2612.0 2671.2 2717.1 2717.3 2721.9 2730.2 2463.9 2470.7 2486.8 2495.5 2497.4 2490.0 2559.1 2564.6 2568.5 2569.2 2346.6 2379.2 2381.8 2386.8 2386.9 15173.5 15280.5 15334.3 15346.7 15381.3 7978.8 8263.4 8334.0 8346.9 8350.0 5009.1 5180.5 5314.5 5357.3 5367.0 1810.3 1815.4 1848.9 1906.9 1912.1 26760.6 26789.7 26802.9 26892.7 26911.0 6702.5 6749.2 6758.9 6980.2 7019.0 18117.3 18218.8 18298.1 18321.8 18337.1 7887.0 8124.9 8133.0 8146.4 8163.4 7460.6 7475.3 7488.4 7557.1 7677.7 5071.8 5175.1 5187.0 5213.2 5275.5 1513.8 1530.8 1533.7 1544.9 1564.2 929.2 935.2 944.2 951.9 964.3 7925.6 7986.8 7988.4 8114.0 8169.9 727.0 729.4 743.3 753.7 754.2 5384.6 5466.3 5659.8 5667.3 5783.2 20369.7 21340.9 22227.3 22363.0 22377.6 20717.9 21348.5 21560.5 21654.9 21720.7 11435.8 11965.2 12114.8 12186.8 12200.8 8566.4 8683.3 8920.5 8953.9 8978.8 17824.9 18401.2 18854.4 18901.1 19091.0 19436.7 19748.0 20133.5 20137.0 20255.5 12310.7 12374.6 12573.0 12816.5 13019.5 14221.2 14411.6 14481.8 14486.8 14489.4 11034.7 11435.9 11491.1 11637.6 11954.5 11440.8 11449.7 11528.0 11706.2 11817.2 9865.0 9979.0 10007.3 10014.3 10043.2 6936.3 7337.7 7360.4 7486.6 7556.9 7364.0 7475.6 7484.8 7507.1 7669.1 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#4] prototype.html Cycles:180 Average:5526.32 Median:6124.59 stddev:1581.16 (25.8%) stddev-sans-first:1539.86 18:52:12 INFO - PID 31321 | Values: 496.1 501.5 529.8 533.1 537.9 6075.7 6088.0 6089.3 6147.2 6149.3 5819.4 6000.3 6033.4 6050.6 6054.0 4695.6 4748.6 4758.6 4798.4 4829.5 4709.2 4792.8 4794.5 4797.2 4841.0 4580.2 4684.0 4747.8 4768.2 4779.0 4731.8 4737.5 4765.1 4786.8 4813.1 4320.3 4334.4 4348.6 4350.0 4357.8 5911.7 5937.0 5984.6 5992.1 6002.1 5642.2 5688.3 5722.6 5733.3 5743.7 6523.5 6524.7 6536.2 6554.0 6563.0 4921.5 4938.5 4952.6 4964.4 4976.7 6809.9 6841.4 6842.7 6864.3 6893.2 5055.3 5066.0 5070.8 5103.4 5105.4 5079.2 5082.3 5097.8 5099.4 5160.4 5645.5 5710.1 5718.3 5745.5 5751.7 6555.4 6564.4 6582.5 6616.0 6616.1 1770.1 1780.0 1791.4 1793.6 1808.3 1149.7 1152.7 1237.5 1239.0 1258.5 6033.8 6128.6 6131.7 6165.9 6289.8 6546.4 6659.0 6671.2 6711.4 6712.9 6163.8 6192.8 6254.8 6264.9 6291.2 3499.5 3511.6 3517.5 3517.8 3568.6 6875.0 6879.7 6997.6 7098.1 7121.3 6829.0 6853.1 6864.1 6867.5 6912.5 6987.7 6988.4 7070.5 7086.6 7111.5 6638.4 6640.9 6661.2 6677.9 6701.8 6571.6 6575.9 6588.1 6621.5 6645.4 6887.5 6993.5 6996.7 7004.4 7021.0 5004.3 5041.0 5046.6 5051.9 5091.5 6645.7 6676.0 6708.4 6727.2 6776.4 6473.6 6518.7 6542.0 6546.9 6550.0 6398.5 6413.8 6441.9 6481.7 6560.3 6446.8 6452.0 6460.5 6492.5 6516.9 5869.9 6271.5 6291.7 6443.9 6498.3 6120.6 6227.6 6283.9 6294.6 6323.2 18:52:12 INFO - PID 31321 | 18:52:12 INFO - PID 31321 | [#5] yui.html Cycles:180 Average:26563.31 Median:19851.70 stddev:37588.08 (189.3%) stddev-sans-first:37644.14 18:52:12 INFO - PID 31321 | Values: 902.8 945.2 947.0 949.7 953.5 17298.2 21413.7 22119.0 23144.4 23469.5 19220.9 19706.1 19768.6 19847.7 19855.7 1034.5 1053.2 1058.9 1059.4 1059.8 1065.0 1065.8 1065.9 1065.9 1068.1 999.1 1121.1 1125.3 1131.0 1132.1 1014.3 1091.2 1093.5 1093.9 1094.5 795.1 805.2 807.5 809.1 813.8 18917.9 19279.0 20181.3 20274.8 20586.6 20889.5 21019.5 21548.9 21685.1 21703.6 15189.3 15326.9 15341.0 15347.7 16897.2 3665.3 3677.7 3682.2 3709.2 3724.5 104909.0 143807.0 144452.3 148354.0 150223.2 12981.2 13310.3 15499.1 16171.9 17221.6 30717.4 31059.0 31713.7 32009.2 32203.2 9486.7 9491.5 9503.8 9545.7 9562.6 4372.1 4523.6 4524.9 4533.7 4539.3 4810.3 4816.0 4982.7 5009.4 5033.6 1075.5 1086.7 1095.6 1115.2 1115.7 690.5 693.7 709.9 712.3 743.7 12723.9 13325.9 13698.5 13913.2 14094.9 690.9 720.1 721.6 724.5 728.9 5778.4 5802.7 5834.9 5849.6 5870.8 125776.0 128788.0 129118.0 130796.0 132829.3 112661.0 114564.0 114761.4 115337.4 117234.0 98900.0 102695.0 103769.0 105924.5 106585.5 13595.5 13608.7 14119.4 14148.1 14427.0 44283.8 45041.3 46091.8 47024.1 49693.3 85201.0 85266.1 86917.6 87442.0 88861.6 18170.0 18614.2 18658.3 18756.6 18996.4 22258.8 22354.8 22531.0 23214.4 23613.9 19347.6 20037.8 20040.7 20170.6 20215.1 20532.9 21394.0 21747.2 21797.0 21878.3 18835.6 18900.0 18908.4 19004.6 19059.1 12259.9 12612.1 12631.4 12643.6 12713.4 13099.7 13158.0 13317.3 13374.6 13489.5 18:52:12 INFO - PID 31321 | -------- Summary: end -------- 18:52:12 INFO - PID 31321 | 18:52:13 INFO - TEST-INFO | 31321: exit 0 18:52:13 INFO - TEST-OK | dromaeo_css | took 1108925ms 18:52:13 INFO - TEST-START | kraken 18:52:13 INFO - Initialising browser for kraken test... 18:52:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58247/getInfo.html -profile /tmp/tmpq4jyU_/profile 18:52:13 INFO - TEST-INFO | started process 31734 (/builds/slave/test/build/application/firefox/firefox http://localhost:58247/getInfo.html) 18:52:19 INFO - TEST-INFO | 31734: exit 0 18:52:19 INFO - Browser initialized. 18:52:19 INFO - Running cycle 1/1 for kraken test... 18:52:19 INFO - TEST-INFO | started process 31944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq4jyU_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:30 INFO - PID 31944 | RSS: Main: 160808960 18:52:30 INFO - PID 31944 | 18:52:32 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58247/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:33 INFO - PID 31944 | RSS: Main: 165818368 18:52:33 INFO - PID 31944 | 18:52:36 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58247/tests/kraken/driver.html?testName=audio-dft) 18:52:36 INFO - PID 31944 | RSS: Main: 166162432 18:52:36 INFO - PID 31944 | 18:52:39 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58247/tests/kraken/driver.html?testName=audio-fft) 18:52:40 INFO - PID 31944 | RSS: Main: 160137216 18:52:40 INFO - PID 31944 | 18:52:42 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58247/tests/kraken/driver.html?testName=audio-oscillator) 18:52:43 INFO - PID 31944 | RSS: Main: 161984512 18:52:43 INFO - PID 31944 | 18:52:45 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:45 INFO - PID 31944 | RSS: Main: 161230848 18:52:45 INFO - PID 31944 | 18:52:48 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58247/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:49 INFO - PID 31944 | RSS: Main: 161972224 18:52:49 INFO - PID 31944 | 18:52:52 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58247/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:53 INFO - PID 31944 | RSS: Main: 165175296 18:52:53 INFO - PID 31944 | 18:52:56 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58247/tests/kraken/driver.html?testName=json-parse-financial) 18:52:56 INFO - PID 31944 | RSS: Main: 166486016 18:52:56 INFO - PID 31944 | 18:52:58 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:58 INFO - PID 31944 | RSS: Main: 165449728 18:52:58 INFO - PID 31944 | 18:53:00 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:01 INFO - PID 31944 | RSS: Main: 165355520 18:53:01 INFO - PID 31944 | 18:53:03 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:03 INFO - PID 31944 | RSS: Main: 165531648 18:53:03 INFO - PID 31944 | 18:53:06 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:06 INFO - PID 31944 | RSS: Main: 165396480 18:53:06 INFO - PID 31944 | 18:53:09 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:10 INFO - PID 31944 | RSS: Main: 165756928 18:53:10 INFO - PID 31944 | 18:53:11 INFO - PID 31944 | Cycle 1(1): loaded http://localhost:58247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58247/tests/kraken/driver.html?testName=ai-astar) 18:53:12 INFO - PID 31944 | RSS: Main: 167665664 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | __start_tp_report 18:53:12 INFO - PID 31944 | _x_x_mozilla_page_load 18:53:12 INFO - PID 31944 | _x_x_mozilla_page_load_details 18:53:12 INFO - PID 31944 | |i|pagename|runs| 18:53:12 INFO - PID 31944 | |0;ai-astar;101;106;93;106;108;106;112;107;107;108 18:53:12 INFO - PID 31944 | |1;audio-beat-detection;146;116;148;171;120;139;147;121;170;116 18:53:12 INFO - PID 31944 | |2;audio-dft;163;162;163;163;162;161;161;162;170;162 18:53:12 INFO - PID 31944 | |3;audio-fft;73;75;73;142;75;74;76;75;98;75 18:53:12 INFO - PID 31944 | |4;audio-oscillator;81;82;140;81;80;81;121;82;81;139 18:53:12 INFO - PID 31944 | |5;imaging-gaussian-blur;114;114;114;115;114;113;115;114;113;113 18:53:12 INFO - PID 31944 | |6;imaging-darkroom;150;149;149;151;150;150;150;152;150;148 18:53:12 INFO - PID 31944 | |7;imaging-desaturate;96;94;95;95;94;94;94;94;94;95 18:53:12 INFO - PID 31944 | |8;json-parse-financial;48;49;50;46;47;46;47;50;46;46 18:53:12 INFO - PID 31944 | |9;json-stringify-tinderbox;54;54;53;53;53;52;53;53;53;53 18:53:12 INFO - PID 31944 | |10;stanford-crypto-aes;86;76;77;77;90;75;74;74;73;75 18:53:12 INFO - PID 31944 | |11;stanford-crypto-ccm;135;124;118;140;120;119;117;123;122;144 18:53:12 INFO - PID 31944 | |12;stanford-crypto-pbkdf2;171;174;168;175;168;167;170;170;167;176 18:53:12 INFO - PID 31944 | |13;stanford-crypto-sha256-iterative;64;68;66;62;67;64;60;60;62;60 18:53:12 INFO - PID 31944 | __end_tp_report 18:53:12 INFO - PID 31944 | __start_cc_report 18:53:12 INFO - PID 31944 | _x_x_mozilla_cycle_collect,852 18:53:12 INFO - PID 31944 | __end_cc_report 18:53:12 INFO - PID 31944 | __startTimestamp1500342792247__endTimestamp 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | ------- Summary: start ------- 18:53:12 INFO - PID 31944 | Number of tests: 14 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#0] ai-astar Cycles:10 Average:105.40 Median:107.50 stddev:5.13 (4.8%) stddev-sans-first:5.18 18:53:12 INFO - PID 31944 | Values: 101.0 106.0 93.0 106.0 108.0 106.0 112.0 107.0 107.0 108.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:146.50 stddev:20.87 (14.2%) stddev-sans-first:22.00 18:53:12 INFO - PID 31944 | Values: 146.0 116.0 148.0 171.0 120.0 139.0 147.0 121.0 170.0 116.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.60 (1.6%) stddev-sans-first:2.76 18:53:12 INFO - PID 31944 | Values: 163.0 162.0 163.0 163.0 162.0 161.0 161.0 162.0 170.0 162.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:21.83 (29.1%) stddev-sans-first:22.81 18:53:12 INFO - PID 31944 | Values: 73.0 75.0 73.0 142.0 75.0 74.0 76.0 75.0 98.0 75.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:81.00 stddev:25.72 (31.7%) stddev-sans-first:26.63 18:53:12 INFO - PID 31944 | Values: 81.0 82.0 140.0 81.0 80.0 81.0 121.0 82.0 81.0 139.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 18:53:12 INFO - PID 31944 | Values: 114.0 114.0 114.0 115.0 114.0 113.0 115.0 114.0 113.0 113.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 18:53:12 INFO - PID 31944 | Values: 150.0 149.0 149.0 151.0 150.0 150.0 150.0 152.0 150.0 148.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 18:53:12 INFO - PID 31944 | Values: 96.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:1.65 (3.5%) stddev-sans-first:1.74 18:53:12 INFO - PID 31944 | Values: 48.0 49.0 50.0 46.0 47.0 46.0 47.0 50.0 46.0 46.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 18:53:12 INFO - PID 31944 | Values: 54.0 54.0 53.0 53.0 53.0 52.0 53.0 53.0 53.0 53.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:76.50 stddev:5.66 (7.4%) stddev-sans-first:5.14 18:53:12 INFO - PID 31944 | Values: 86.0 76.0 77.0 77.0 90.0 75.0 74.0 74.0 73.0 75.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.50 stddev:9.77 (7.9%) stddev-sans-first:9.83 18:53:12 INFO - PID 31944 | Values: 135.0 124.0 118.0 140.0 120.0 119.0 117.0 123.0 122.0 144.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.50 stddev:3.34 (2.0%) stddev-sans-first:3.54 18:53:12 INFO - PID 31944 | Values: 171.0 174.0 168.0 175.0 168.0 167.0 170.0 170.0 167.0 176.0 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:2.98 (4.7%) stddev-sans-first:3.15 18:53:12 INFO - PID 31944 | Values: 64.0 68.0 66.0 62.0 67.0 64.0 60.0 60.0 62.0 60.0 18:53:12 INFO - PID 31944 | -------- Summary: end -------- 18:53:12 INFO - PID 31944 | 18:53:12 INFO - PID 31944 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:53:13 INFO - TEST-INFO | 31944: exit 0 18:53:13 INFO - TEST-OK | kraken | took 59878ms 18:53:13 INFO - SUITE-END | took 1168s 18:53:13 INFO - Completed test suite (00:19:29) 18:53:13 INFO - javascript benchmark 18:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8866.17965109374, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.609964854041, 3437.6218615952243, 3443.913902152446, 3450.9137271568225, 3468.2023134679025, 6244.063390491428, 6292.056191571267, 6295.024271237954, 6301.212348456443, 6355.8093257202245, 6286.937130628692, 6295.307516173229, 6319.589226700261, 6320.462760665349, 6363.777267795628, 5503.036968530511, 5506.752196151183, 5528.917066244009, 5551.666899985994, 5595.300587426572, 5580.330360356763, 5580.525655319303, 5580.86047848803, 5581.079121944895, 5592.384837667853, 5568.693721845297, 5575.024370735126, 5583.720813959306, 5590.385057643656, 5594.440555944414, 5548.44515548446, 5582.748776305076, 5586.994341018615, 5594.720263986805, 5607.943920560783, 5471.863203419906, 5496.955578440124, 5516.613837031409, 5516.668999860021, 5612.186232996233, 6224.502039836802, 6225.159603453521, 6246.6876656167005, 6284.18305620271, 6297.622142671455, 6698.631575263358, 6733.09103271057, 6772.390484856386, 6815.863682726367, 6833.487488438387, 6797.388235058819, 6814.454843612499, 6823.420009299166, 6825.624590647512, 6853.4174595159475, 6285.057241413779, 6312.116303717483, 6312.621242725405, 6312.652804095773, 6344.49244060474, 5905.40945905406, 6916.723331066802, 6987.475939304572, 7006.684699188549, 7032.578045317297, 6519.380658837403, 6686.398224159849, 6730.899036514456, 6751.594904305757, 6756.560823546453, 6699.497537684693, 6839.965800170968, 6842.4868134890085, 6861.451083913275, 6913.1358580177475, 6663.06717059612, 6673.566218195801, 6674.299198584079, 6675.7997260082275, 6691.364320389555, 6189.473894718909, 6698.5980841149685, 6719.596824190564, 6780.762673306411, 6796.932030679729, 4999.0501804657, 5052.141136006888, 5114.411842638145, 5114.897702045938, 5118.360204974379, 4482.9775851121185, 4490.550944905483, 4491.775411229425, 4508.639308855284, 4538.410006699174, 6392.328805475451, 6393.264774550986, 6405.48756099511, 6414.871702566016, 6439.291677915426, 6778.457723382117, 6780.1524809398825, 6811.523193376416, 6814.727410903607, 6818.147731533559, 6324.71538780756, 6344.555881088372, 6404.519661025442, 6416.679166041679, 6439.291677915426, 5707.743151558107, 5719.828405147852, 5735.827925162252, 5770.134479827975, 5845.678487683218, 7220.566765994057, 7233.168185658611, 7297.05138332024, 7312.963435182896, 7331.926680733124, 6834.179898412222, 6842.7605033823575, 6867.381935625817, 6919.481038922202, 6936.0636314098965, 7077.893831592633, 7126.35862772353, 7161.892571611325, 7230.855382892418, 7261.164966028763, 5746.885062298814, 6711.597304161766, 6736.225334086446, 6746.190457144978, 6760.492963027891, 6817.250102488623, 6883.655817209019, 6949.0, 6977.441804655717, 6983.1620205575655, 6560.3111673275525, 6613.570117942319, 6669.7665581704405, 6688.398044176048, 6692.063111164538, 6451.548391612542, 6528.771492997722, 6613.27254002069, 6625.900611490735, 6709.597424154371, 6564.4748420125325, 6589.275179730322, 6592.670366481752, 6597.175353080865, 6597.9113446282745, 5711.828645140652, 6589.571677840925, 6611.537192396486, 6724.4284235840505, 6806.523543352116, 6492.448141907991, 6494.0, 6556.967215163893, 6571.047198156336, 6573.737050518117], "value": 6188.697464725489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.1532836283079, 899.0039275420758, 920.8388532006899, 940.6801687426274, 940.8118376324737, 41880.37179442307, 42813.78593107038, 43016.3547546787, 43019.139617207635, 43083.78458107713, 44532.0, 45408.3188752169, 45470.77264613672, 45471.545284547145, 45537.544624553746, 7365.0, 7511.924880751205, 7515.774526764206, 7517.849643007136, 7524.247575242459, 7292.0, 7420.369268612175, 7420.4805663603565, 7420.888686669704, 7443.516171448839, 7453.478256522046, 7460.179380268193, 7479.513831600956, 7495.0, 7497.437692173082, 7401.296876796696, 7436.516626419292, 7442.553446793209, 7442.665080071382, 7484.550926944401, 7194.748183813594, 7231.3130252625915, 7238.2761723827725, 7238.733221686237, 7244.637768111626, 38704.0, 38768.22463550742, 38809.61190388088, 38852.41721374181, 39896.80051599752, 3552.2007548301426, 3554.662307080823, 3567.357875582394, 3580.874669386585, 3582.7133829293593, 32004.199895002577, 32231.0, 32380.0, 32436.0, 32499.51250731241, 4892.706437613754, 4991.226359914219, 5009.2486127080865, 5009.599232061463, 5096.566791822699, 205255.0, 210229.0, 210512.0, 211823.0, 212182.0, 42343.36484952728, 51151.0, 52180.21729674058, 52418.73790631023, 52603.73698131485, 54710.72644636752, 54747.45252547503, 55034.44965550293, 55205.51575179127, 55286.0, 16710.08094554787, 16766.497005089623, 16866.662666746597, 16889.662206755795, 16920.238589263514, 13726.107802992774, 13754.587362379145, 13776.793348099787, 13863.4454621814, 13890.791638125234, 13746.037777355688, 13930.58208253754, 13948.0, 14006.649833754238, 14153.0, 5202.947970520322, 5213.191955246943, 5214.556762675215, 5311.176767601028, 5324.440933701983, 1049.2340591368343, 1051.1538211739623, 1062.8193207154802, 1078.396098185019, 1095.1567293184203, 23931.880340598185, 24261.514769704507, 24262.514749704907, 24296.635550466755, 24787.00851965901, 1169.3743847041962, 1178.1080678033607, 1191.112621097288, 1196.5572738086964, 1201.177193622354, 12806.231626102277, 13076.542321018718, 13079.084464087422, 13112.147710398793, 13140.671483212805, 293662.0, 294706.0, 295227.0, 295630.0, 296651.0, 56017.439825602036, 56090.0, 56203.0, 56277.71861140668, 56501.43498564962, 1446.8914831387688, 1496.0425327790224, 1497.2513743128436, 1508.2081906998912, 1515.113658509762, 24065.639015414432, 29775.404491910474, 30075.849620751756, 30238.54642180413, 30493.54259686062, 53862.0, 54145.45854541562, 54201.728991354794, 54224.728876355366, 54346.0, 238600.0, 238836.0, 239658.0, 239926.0, 240530.0, 32456.67543324631, 32612.184695381857, 32870.02779833218, 32934.83532582322, 34423.655763442046, 41334.0, 45242.0, 46072.76963615161, 46341.304880427495, 46574.0, 32766.0, 32966.0, 33477.83261083679, 33566.664333356355, 33628.831855840566, 33127.503087453224, 33340.816234903126, 33488.16279593029, 33505.32989340151, 33900.49149262813, 37710.24579508339, 38480.615193847705, 38994.6100538991, 39000.41499377568, 39104.41343379795, 30642.0, 32132.678673213904, 32296.677033229367, 32364.0, 32764.344713106082, 24540.361713717808, 24560.0, 25014.624780627943, 25266.36834079163, 25604.871975640002], "value": 18042.352128255392, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.4342042826535, 558.4666643355594, 565.375260337327, 570.1675553691608, 591.3760982163818, 21832.89083554582, 22784.088636454562, 22939.311820645406, 23019.884900575475, 23027.654585181215, 25398.74601253987, 26258.6061209082, 27523.862380688068, 27727.306817329576, 27792.861035694845, 5994.400559944003, 6042.274927008743, 6043.0, 6051.062085376773, 6086.330503644595, 6024.5180385569265, 6056.242969628796, 6056.727447264861, 6068.180795592582, 6105.511559075286, 6025.819225423223, 6075.149479072933, 6154.476869466078, 6622.8675426491445, 6697.698603562827, 6510.707018184193, 6610.570312929644, 6619.404253617174, 6645.4683625310345, 6668.533202675814, 6529.249136349333, 6570.375814297634, 6570.375814297634, 6571.0, 6579.835504112388, 31034.689653103407, 32256.193595160075, 32739.345213095843, 33283.500747488804, 33373.833130834435, 2216.612092883739, 2236.731592208945, 2242.495438526335, 2244.9663255051187, 2251.5159240763314, 20786.168553257852, 20799.480012999644, 21085.8945705272, 21234.5753084939, 21271.8936405317, 2100.3698890332994, 2111.915523379063, 2167.295628920607, 2183.54145629418, 2195.3523710505438, 154389.0, 159143.0, 159253.0, 159459.2027039869, 159559.0, 22411.775882241294, 22574.774252257597, 23703.881480592485, 24876.0, 25500.872495637403, 49358.25962610564, 49534.75232623814, 49547.50452495429, 49550.0, 49800.750996245515, 12206.816897746541, 12685.556005539762, 12837.935810320889, 12863.549775757803, 12913.225206487454, 10472.476376181161, 10526.789464210826, 10546.209034322457, 10581.36511809294, 10649.0, 12130.393480325949, 12364.505419783109, 12626.621201363974, 12634.936825316, 12645.292885460345, 2731.7951153663553, 2758.517259479583, 2859.099383694171, 4562.498125206224, 4796.736179510091, 1006.4112494190834, 1011.2415688233824, 1041.3959903256093, 1057.1595581512715, 1057.5716834681966, 21114.366569002956, 21438.0, 21558.353249402542, 21762.476626635984, 22364.776352236593, 1064.6805958212506, 1090.86909570852, 1094.7755710079573, 1101.427257825942, 1116.062507493693, 11743.88256117445, 11772.88227117735, 11795.115366347558, 11881.524739010516, 12045.859516548577, 556900.0, 562949.0, 568241.0, 568398.0, 572774.0, 121577.0, 135238.0, 135920.32039839934, 137752.0, 138865.0, 1226.4726167747954, 1255.7551277500982, 1278.4822147030281, 1282.24347634894, 1283.3775618824861, 17944.0, 19003.14485848168, 19013.61972760565, 19066.809331906505, 19132.23471061142, 58266.7086664564, 61378.38621613727, 61801.69099154655, 62076.379236208864, 62506.0, 75582.62208688921, 78082.0, 78197.0, 78508.21491785008, 78965.0, 14776.704465910836, 14850.851491485379, 14994.100353978796, 15054.849451505344, 15112.244387780787, 23546.175883843982, 23843.523129537658, 23901.163459278843, 24137.758622414254, 24339.26982190537, 19319.0, 19358.516037099183, 19575.119119639934, 19733.0, 19925.701114483003, 17250.0, 17351.351891249877, 17360.479185624452, 18035.18841652155, 18259.360922367654, 19361.0, 19878.10548525291, 20072.0, 20248.89875550613, 20596.897015514827, 14685.0, 14831.184284864004, 14930.402783888523, 14941.327640256432, 14944.7758283628, 18580.2567897288, 19623.0, 19741.506462338555, 19784.406467805988, 19841.611087223755], "value": 13218.305855213639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.602231375215, 1433.7132573485299, 1474.1966025072243, 1476.2987580899073, 1492.5522343297002, 14838.258087095643, 15423.0, 15587.688246235082, 15592.14243216624, 15604.453844115458, 14943.0, 15459.30433130509, 15850.0, 15909.124998125099, 15982.0, 2523.1295203154973, 2588.094167041539, 2599.54507961107, 2607.5958226474927, 2612.0, 2671.1585850457045, 2717.076194094008, 2717.334253107991, 2721.8502982335963, 2730.194592595189, 2463.876806159694, 2470.7405722399158, 2486.8010559155314, 2495.4759500504915, 2497.438076432797, 2489.987550062247, 2559.1298958354155, 2564.5640241158862, 2568.524822907768, 2569.177863083814, 2346.636271377939, 2379.167291447997, 2381.7856392924546, 2386.809055275574, 2386.880655967195, 15173.468928587557, 15280.465183718628, 15334.309956051893, 15346.693066138727, 15381.307841147063, 7978.800529986739, 8263.380246481478, 8333.95833020831, 8346.874796878052, 8350.0, 5009.148444764399, 5180.507851754077, 5314.521693047605, 5357.330333708286, 5367.0, 1810.2651277921918, 1815.373696074852, 1848.92604295828, 1906.8951207683572, 1912.1108684461653, 26760.59859102115, 26789.732102678918, 26802.86598567014, 26892.731072689217, 26911.0, 6702.463802895757, 6749.2238392584495, 6758.864822703518, 6980.197277313073, 7019.0, 18117.275308987493, 18218.817811821977, 18298.085095745424, 18321.816781832276, 18337.083145842655, 7887.0, 8124.918750812416, 8132.959335203286, 8146.389020823462, 8163.428560000862, 7460.552366857897, 7475.25247475259, 7488.4009279257525, 7557.05536807899, 7677.731279405306, 5071.7971281149075, 5175.094358487249, 5186.988537235203, 5213.191955246943, 5275.498827611371, 1513.8259100203397, 1530.8086489188852, 1533.7162624914426, 1544.8995815272197, 1564.1866229560792, 929.1776777551916, 935.2004036548789, 944.1596978688972, 951.9190868776232, 964.3153361113548, 7925.643346049442, 7986.7603971880935, 7988.360931125496, 8114.0, 8169.918300817035, 727.0185249912576, 729.3836707981746, 743.2901578992049, 753.7135888362496, 754.1779460388094, 5384.623076384615, 5466.262054622575, 5659.830205093854, 5667.319921609434, 5783.161441590946, 20369.694454583194, 21340.893295533424, 22227.333180004625, 22363.0, 22377.552448951257, 20717.89641051815, 21348.466288342606, 21560.460988475414, 21654.89172554127, 21720.674189887166, 11435.771284574428, 11965.222260553037, 12114.757704845853, 12186.756264874653, 12200.755984880252, 8566.443181193203, 8683.348748843735, 8920.509371984344, 8953.910460895568, 8978.775530611787, 17824.91087544554, 18401.171947262672, 18854.434366969013, 18901.149448275137, 19091.0, 19436.708449373553, 19748.0, 20133.49666258355, 20137.0, 20255.4936126598, 12310.692232694255, 12374.62876113718, 12572.994160467324, 12816.487340506275, 13019.544315949275, 14221.217833019284, 14411.567652970427, 14481.782773258199, 14486.768624667022, 14489.406165321596, 11034.668959931216, 11435.942820285845, 11491.080713543064, 11637.592684256011, 11954.462049207632, 11440.771184576428, 11449.656510304705, 11528.02011829004, 11706.180567360543, 11817.231879927776, 9864.950675246579, 9979.0, 10007.349522281029, 10014.298999069995, 10043.196544276587, 6936.271691472524, 7337.669804858688, 7360.39468493621, 7486.5508069516, 7556.8866467001935, 7364.0, 7475.551466912003, 7484.775456736306, 7507.099148102263, 7669.118051424158], "value": 6707.877150585595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.14910428614917, 501.4759576242825, 529.7589596733486, 533.0671325180931, 537.8924215156969, 6075.696215189239, 6088.0259158534645, 6089.269287685478, 6147.1701320321745, 6149.3235744068115, 5819.352194751388, 6000.339962604121, 6033.396660333975, 6050.636961782297, 6053.969730151354, 4695.624350052005, 4748.646635708824, 4758.595519380848, 4798.352222449959, 4829.51704829516, 4709.199436095855, 4792.784324705397, 4794.544518270759, 4797.208460603996, 4840.951590484103, 4580.1984652685815, 4683.953160468386, 4747.810087596492, 4768.189407800664, 4779.044191161782, 4731.78706958186, 4737.50256223095, 4765.118453086156, 4786.8085276589245, 4813.08551375241, 4320.33034879591, 4334.436523251957, 4348.586884245991, 4350.0, 4357.782110894443, 5911.733971971272, 5936.97031514844, 5984.640921544721, 5992.101184822268, 6002.0996850472775, 5642.175939571689, 5688.345840228385, 5722.599418040739, 5733.312002559678, 5743.655380677173, 6523.478121750249, 6524.651125594782, 6536.215654121488, 6554.0, 6562.9671851640915, 4921.474342953696, 4938.530839570235, 4952.62855285855, 4964.35463389757, 4976.701397916137, 6809.863802723968, 6841.418479429254, 6842.726290948356, 6864.313568643146, 6893.241743408221, 5055.266986287042, 5066.0, 5070.822521211814, 5103.387593488731, 5105.361829771278, 5079.161938280143, 5082.33929589151, 5097.770600322994, 5099.36257967754, 5160.432352441228, 5645.5483561314995, 5710.114932185518, 5718.342390625131, 5745.454181852718, 5751.654900705971, 6555.3772391622715, 6564.409203171642, 6582.45312351597, 6616.0, 6616.14747870597, 1770.106096421299, 1779.9822001780076, 1791.3551121596477, 1793.5695433096223, 1808.2857271377732, 1149.7183190118474, 1152.6599653102187, 1237.4740735187509, 1239.021173273104, 1258.5028913579085, 6033.78881739137, 6128.601640893327, 6131.724072416752, 6165.938340616536, 6289.779857704958, 6546.378094081055, 6658.966705166443, 6671.232808227116, 6711.362420570038, 6712.899306510406, 6163.825629800656, 6192.845178870564, 6254.781082662085, 6264.906026409516, 6291.182146320949, 3499.4575840744214, 3511.631278715749, 3517.50754894315, 3517.8416971236356, 3568.6439153121646, 6874.9656251718425, 6879.690413931385, 6997.615131167733, 7098.1482222132645, 7121.287871212838, 6828.9658551706925, 6853.143357080365, 6864.141982252218, 6867.450603951672, 6912.481563882729, 6987.685554150075, 6988.371046605626, 7070.46971477131, 7086.610236437045, 7111.53775004623, 6638.402543771083, 6640.867182656417, 6661.2006559213205, 6677.866442671217, 6701.8166370973395, 6571.605703657796, 6575.934240657532, 6588.07766912623, 6621.470282377302, 6645.435138013323, 6887.483438742214, 6993.510454268152, 6996.685149168198, 7004.404625606677, 7021.0, 5004.274380214775, 5041.0, 5046.596272298134, 5051.8633307505515, 5091.523458197082, 6645.700943457653, 6675.9666201670625, 6708.429783468265, 6727.159105111861, 6776.390124888783, 6473.579217350857, 6518.706658200487, 6541.967290163519, 6546.901796472961, 6549.967250163719, 6398.5201109916015, 6413.761050669382, 6441.903371449338, 6481.740730370732, 6560.343965603402, 6446.774362897276, 6451.967740161457, 6460.547761656639, 6492.480601551959, 6516.934830651822, 5869.882602348014, 6271.498280137669, 6291.716872740646, 6443.903341449975, 6498.252700939263, 6120.571559990758, 6227.626342419469, 6283.937160628335, 6294.622322660655, 6323.20959880015], "value": 5063.118519277626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.8374892519348, 945.1729736480579, 946.9763255918601, 949.6581230756926, 953.5184731710485, 17298.221580028898, 21413.67879481807, 22119.004644791003, 23144.42138946527, 23469.530609387803, 19220.903895480504, 19706.11322490488, 19768.604627907433, 19847.702284465708, 19855.702164467508, 1034.5292891734243, 1053.210092430677, 1058.8994045565698, 1059.422614675004, 1059.7774467361862, 1065.0148612533415, 1065.8134826405387, 1065.8614380130573, 1065.9093977011923, 1068.1081297116878, 999.1207737191262, 1121.0695123047892, 1125.2629527659396, 1131.0, 1132.1282612388457, 1014.3254735600816, 1091.241587096968, 1093.5243169221415, 1093.907017903479, 1094.545763508147, 795.1412474527555, 805.1867613710136, 807.5477732469835, 809.0857331215689, 813.7762115418249, 18917.90541047286, 19279.036048197675, 20181.29365472216, 20274.797252027438, 20586.58826823455, 20889.477763055893, 21019.474513137142, 21548.89225553878, 21685.13259469619, 21703.56592868134, 15189.316480758282, 15326.923365383213, 15341.0, 15347.693046139015, 16897.15514224284, 3665.321915445651, 3677.7425580209397, 3682.171511409938, 3709.239605880788, 3724.4599533067826, 104909.0, 143807.0, 144452.27773861063, 148354.0, 150223.24888375596, 12981.156224845356, 13310.334483275798, 15499.070055796688, 16171.919140404458, 17221.56946076358, 30717.38565228683, 31059.0, 31713.682863171536, 32009.199770005936, 32203.194920127185, 9486.667966621135, 9491.477968711788, 9503.809923801624, 9545.713628591153, 9562.61749530025, 4372.060007098489, 4523.5928766410525, 4524.886877828015, 4533.705309154961, 4539.31910213464, 4810.302506136661, 4816.0, 4982.676126051868, 5009.423916249605, 5033.640916952402, 1075.499892549968, 1086.6794295682791, 1095.5836782022939, 1115.2360632966445, 1115.743379022813, 690.5097380859646, 693.7121094745725, 709.8935159726083, 712.2592503796097, 743.695085015152, 12723.936380318224, 13325.93337033328, 13698.45206191741, 13913.165210087427, 14094.929525352307, 690.9032735417046, 720.1106633307861, 721.6319676964681, 724.5073350121862, 728.8542291541713, 5778.422157784272, 5802.680852553066, 5834.883302334015, 5849.61977471463, 5870.7945221917025, 125776.0, 128788.0, 129118.0, 130796.0, 132829.33585332206, 112661.0, 114564.0, 114761.42619287017, 115337.4233128829, 117234.0, 98899.99999999856, 102695.0, 103769.0, 105924.47037764762, 106585.46707266413, 13595.52415665447, 13608.65978350549, 14119.39287706136, 14148.109269950433, 14427.0, 44283.77858110818, 45041.32438013367, 46091.769541152076, 47024.059518810114, 49693.25460118029, 85201.0, 85266.1473385283, 86917.56541217254, 87442.0, 88861.55569222113, 18170.0, 18614.16236269344, 18658.34695785641, 18756.6248675023, 18996.43010709681, 22258.77741222567, 22354.77645223527, 22531.0, 23214.419639508473, 23613.881930590236, 19347.613047739247, 20037.848714990978, 20040.699389508878, 20170.596588067863, 20215.090320935888, 20532.897335513226, 21394.0, 21747.23884664029, 21797.0, 21878.343649690534, 18835.623287534447, 18900.0, 18908.43274701761, 19004.619907602046, 19059.14233859452, 12259.938700306442, 12612.117151799654, 12631.368431578201, 12643.557475488315, 12713.427895744899, 13099.672508187372, 13158.0, 13317.334133293103, 13374.598762037154, 13489.460421583026], "value": 9689.898524011476, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 93.0, 106.0, 108.0, 106.0, 112.0, 107.0, 107.0, 108.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 148.0, 171.0, 120.0, 139.0, 147.0, 121.0, 170.0, 116.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0, 162.0, 170.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 142.0, 75.0, 74.0, 76.0, 75.0, 98.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 140.0, 81.0, 80.0, 81.0, 121.0, 82.0, 81.0, 139.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 115.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 151.0, 150.0, 150.0, 150.0, 152.0, 150.0, 148.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 50.0, 46.0, 47.0, 46.0, 47.0, 50.0, 46.0, 46.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 77.0, 77.0, 90.0, 75.0, 74.0, 74.0, 73.0, 75.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 118.0, 140.0, 120.0, 119.0, 117.0, 123.0, 122.0, 144.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 168.0, 175.0, 168.0, 167.0, 170.0, 170.0, 167.0, 176.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 66.0, 62.0, 67.0, 64.0, 60.0, 60.0, 62.0, 60.0], "value": 63.3, "unit": "score"}]}]} 18:53:13 INFO - Return code: 0 18:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:13 INFO - # TBPL SUCCESS # 18:53:13 INFO - Running post-action listener: _package_coverage_data 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - [mozharness: 2017-07-18 01:53:13.520410Z] Finished run-tests step (success) 18:53:13 INFO - Running post-run listener: _resource_record_post_run 18:53:13 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432607232; Read time: 16; Write time: 256676 18:53:13 INFO - TinderboxPrint: CPU usage
13.0% 18:53:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:53:13 INFO - TinderboxPrint: I/O write bytes / time
432,607,232 / 256,676 18:53:13 INFO - TinderboxPrint: CPU idle
8,233.4 (87.0%) 18:53:13 INFO - TinderboxPrint: CPU user
1,187.0 (12.5%) 18:53:13 INFO - TinderboxPrint: Swap in / out
0 / 0 18:53:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108273664; Read time: 0; Write time: 87880 18:53:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:53:13 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 324333568; Read time: 0; Write time: 168796 18:53:14 INFO - Running post-run listener: _upload_blobber_files 18:53:14 INFO - Blob upload gear active. 18:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:53:14 INFO - Traceback (most recent call last): 18:53:14 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:53:14 INFO - main() 18:53:14 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:53:14 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:53:14 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:53:14 INFO - return set(response.json().get('whitelist', [])) 18:53:14 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:53:14 INFO - return json.loads(self.text or self.content, **kwargs) 18:53:14 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 18:53:14 INFO - return _default_decoder.decode(s) 18:53:14 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 18:53:14 INFO - obj, end = self.raw_decode(s) 18:53:14 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 18:53:14 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 18:53:14 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 18:53:14 ERROR - Return code: 1 18:53:14 INFO - Setting buildbot property blobber_files to {} 18:53:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:14 INFO - Contents: 18:53:14 INFO - blobber_files:{} 18:53:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:14 INFO - Copying logs to upload dir... 18:53:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.814735 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-07-17 18:53:14.066073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 18:53:14.070031) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/MmFQO4FmRwC1WR2gsYoksA/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-17 18:53:14.127468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:53:14.127828) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500340946.130031-1776821896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:53:14.178841) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:53:14.179162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:53:14.179477) ========= ========= Total master_lag: 0.19 =========