builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1500396960.32 results: success (0) revision: dece50457378ac4934afe9fb3c2a8054e8894588 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.318362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.318771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.320051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.392872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.393154) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 09:56:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-18 09:56:00 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.507582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.507931) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023347 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:00.561755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-18 09:56:00.564151) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dece50457378ac4934afe9fb3c2a8054e8894588 --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 dece50457378ac4934afe9fb3c2a8054e8894588 --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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 09:56:00,796 truncating revision to first 12 chars 2017-07-18 09:56:00,796 Setting DEBUG logging. 2017-07-18 09:56:00,796 attempt 1/10 2017-07-18 09:56:00,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dece50457378?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 09:56:02,160 unpacking tar archive at: mozilla-central-dece50457378/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-18 09:56:02.254651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:02.258052) ========= script_repo_revision: dece50457378ac4934afe9fb3c2a8054e8894588 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:02.258519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:02.258788) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 09:56:02.272035) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-18 09:56:02.272404) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:02 INFO - MultiFileLogger online at 20170718 09:56:02 in /builds/slave/test 09:56:02 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 09:56:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:02 INFO - {'append_to_log': False, 09:56:02 INFO - 'base_work_dir': '/builds/slave/test', 09:56:02 INFO - 'blob_upload_branch': 'Firefox', 09:56:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:02 INFO - 'branch': 'Firefox', 09:56:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:02 INFO - 'code_coverage': False, 09:56:02 INFO - 'config_files': ('talos/linux_config.py',), 09:56:02 INFO - 'default_actions': ('clobber', 09:56:02 INFO - 'read-buildbot-config', 09:56:02 INFO - 'download-and-extract', 09:56:02 INFO - 'populate-webroot', 09:56:02 INFO - 'create-virtualenv', 09:56:02 INFO - 'install', 09:56:02 INFO - 'setup-mitmproxy', 09:56:02 INFO - 'run-tests'), 09:56:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:02 INFO - 'disable_ccov_upload': False, 09:56:02 INFO - 'download_minidump_stackwalk': True, 09:56:02 INFO - 'download_symbols': 'ondemand', 09:56:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:02 INFO - 'gecko_profile': False, 09:56:02 INFO - 'gecko_profile_interval': 0, 09:56:02 INFO - 'installer_path': 'installer.exe', 09:56:02 INFO - 'log_level': 'info', 09:56:02 INFO - 'log_name': 'talos', 09:56:02 INFO - 'log_to_console': True, 09:56:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:02 INFO - 'opt_config_files': (), 09:56:02 INFO - 'pip_index': False, 09:56:02 INFO - 'suite': 'dromaeojs-e10s', 09:56:02 INFO - 'system_bits': '32', 09:56:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:02 INFO - 'title': 'talos-linux64-ix-013', 09:56:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:02 INFO - 'use_talos_json': True, 09:56:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:02 INFO - 'work_dir': 'build'} 09:56:02 INFO - [mozharness: 2017-07-18 16:56:02.607444Z] Running clobber step. 09:56:02 INFO - Running pre-action listener: _resource_record_pre_action 09:56:02 INFO - Running main action method: clobber 09:56:02 INFO - rmtree: /builds/slave/test/build 09:56:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:03 INFO - Running post-action listener: _resource_record_post_action 09:56:03 INFO - [mozharness: 2017-07-18 16:56:03.657770Z] Finished clobber step (success) 09:56:03 INFO - [mozharness: 2017-07-18 16:56:03.657873Z] Running read-buildbot-config step. 09:56:03 INFO - Running pre-action listener: _resource_record_pre_action 09:56:03 INFO - Running main action method: read_buildbot_config 09:56:03 INFO - Using buildbot properties: 09:56:03 INFO - { 09:56:03 INFO - "project": "", 09:56:03 INFO - "product": "firefox", 09:56:03 INFO - "who": "ffxbld@noreply.mozilla.org", 09:56:03 INFO - "installer_path": "public/build/target.tar.bz2", 09:56:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:56:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:56:03 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:56:03 INFO - "stage_platform": "linux64-stylosequential", 09:56:03 INFO - "basedir": "/builds/slave/test", 09:56:03 INFO - "buildnumber": 108, 09:56:03 INFO - "platform": "ubuntu64_hw_styloseq", 09:56:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:56:03 INFO - "slavebuilddir": "test", 09:56:03 INFO - "taskId": "YibwnBuRTOuopSQhrI7F4A", 09:56:03 INFO - "branch": "mozilla-central", 09:56:03 INFO - "script_repo_revision": "production", 09:56:03 INFO - "revision": "dece50457378ac4934afe9fb3c2a8054e8894588", 09:56:03 INFO - "slavename": "talos-linux64-ix-013", 09:56:03 INFO - "repo_path": "mozilla-central" 09:56:03 INFO - } 09:56:03 INFO - Finding installer, test and symbols from parent task. 09:56:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YibwnBuRTOuopSQhrI7F4A'}, attempt #1 09:56:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YibwnBuRTOuopSQhrI7F4A'}, attempt #1 09:56:04 INFO - Task dependencies: GnlYt2-cQ-yMT4Kww2hNLw 09:56:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw'}, attempt #1 09:56:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 09:56:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/test_packages.json 09:56:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.crashreporter-symbols.zip 09:56:05 INFO - Running post-action listener: _resource_record_post_action 09:56:05 INFO - [mozharness: 2017-07-18 16:56:05.000530Z] Finished read-buildbot-config step (success) 09:56:05 INFO - [mozharness: 2017-07-18 16:56:05.000751Z] Running download-and-extract step. 09:56:05 INFO - Running pre-action listener: _resource_record_pre_action 09:56:05 INFO - Running main action method: download_and_extract 09:56:05 INFO - mkdir: /builds/slave/test/build/tests 09:56:05 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')]} 09:56:05 INFO - trying https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.test_packages.json 09:56:05 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:56:05 INFO - Downloaded 989 bytes. 09:56:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:56:05 INFO - Using the following test package requirements: 09:56:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:56:05 INFO - u'common': [u'target.common.tests.zip'], 09:56:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:56:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:56:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:56:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:56:05 INFO - u'mozbase': [u'target.common.tests.zip'], 09:56:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:56:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:56:05 INFO - u'web-platform': [u'target.common.tests.zip', 09:56:05 INFO - u'target.web-platform.tests.tar.gz'], 09:56:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:56:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:56:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip 09:56:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:56:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip into memory 09:56:06 INFO - Content-Length response header: 72754936 09:56:06 INFO - Bytes received: 72754936 09:56:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip 09:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.common.tests.zip into memory 09:56:19 INFO - Content-Length response header: 72754936 09:56:19 INFO - Bytes received: 72754936 09:56:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.talos.tests.zip 09:56:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:56:31 INFO - Fetch https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.talos.tests.zip into memory 09:56:32 INFO - Content-Length response header: 14495033 09:56:32 INFO - Bytes received: 14495033 09:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:32 INFO - trying https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 09:56:32 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:56:33 INFO - Downloaded 61863085 bytes. 09:56:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 09:56:33 INFO - mkdir: /builds/slave/test/properties 09:56:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:33 INFO - Contents: 09:56:33 INFO - build_url:https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 09:56:33 INFO - Running post-action listener: _resource_record_post_action 09:56:33 INFO - Running post-action listener: set_extra_try_arguments 09:56:33 INFO - [mozharness: 2017-07-18 16:56:33.511609Z] Finished download-and-extract step (success) 09:56:33 INFO - [mozharness: 2017-07-18 16:56:33.511707Z] Running populate-webroot step. 09:56:33 INFO - Running pre-action listener: _resource_record_pre_action 09:56:33 INFO - Running main action method: populate_webroot 09:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:33 INFO - '--tppagecycles', 09:56:33 INFO - '7'], 09:56:33 INFO - 'tests': ['tsvgm']}}, 09:56:33 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['damp', 'tps']}, 09:56:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'tests': ['damp', 'tps']}, 09:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['dromaeo_dom']}, 09:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:56:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:56:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_many_windows', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_many_windows', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_many_windows', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['a11yr', 09:56:33 INFO - 'ts_paint', 09:56:33 INFO - 'tpaint', 09:56:33 INFO - 'sessionrestore', 09:56:33 INFO - 'sessionrestore_no_auto_restore', 09:56:33 INFO - 'tabpaint']}, 09:56:33 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 09:56:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:56:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:56:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:56:33 INFO - 'talos_options': ['--mitmproxy', 09:56:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:56:33 INFO - '--firstNonBlankPaint'], 09:56:33 INFO - 'tests': ['quantum_pageload_google', 09:56:33 INFO - 'quantum_pageload_youtube', 09:56:33 INFO - 'quantum_pageload_amazon', 09:56:33 INFO - 'quantum_pageload_facebook']}, 09:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['tsvgx', 09:56:33 INFO - 'tsvgr_opacity', 09:56:33 INFO - 'tart', 09:56:33 INFO - 'tscrollx', 09:56:33 INFO - 'cart', 09:56:33 INFO - 'tsvg_static']}, 09:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:33 INFO - 'tsvgr_opacity', 09:56:33 INFO - 'tart', 09:56:33 INFO - 'tscrollx', 09:56:33 INFO - 'cart', 09:56:33 INFO - 'tsvg_static']}, 09:56:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'talos_options': ['--disable-e10s'], 09:56:33 INFO - 'tests': ['tp5o']}, 09:56:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:56:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'talos_options': ['--disable-e10s', 09:56:33 INFO - '--xperf_path', 09:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:33 INFO - 'tests': ['tp5n']}, 09:56:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:56:33 INFO - 'talos_options': ['--xperf_path', 09:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:33 INFO - 'tests': ['tp5n']}}, 09:56:33 INFO - 'talos.zip': {'path': '', 09:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:33 INFO - Running post-action listener: _resource_record_post_action 09:56:33 INFO - [mozharness: 2017-07-18 16:56:33.527004Z] Finished populate-webroot step (success) 09:56:33 INFO - [mozharness: 2017-07-18 16:56:33.527095Z] Running create-virtualenv step. 09:56:33 INFO - Running pre-action listener: _resource_record_pre_action 09:56:33 INFO - Running main action method: create_virtualenv 09:56:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:33 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 09:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:33 INFO - Using real prefix '/usr' 09:56:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:36 INFO - Installing pip.................done. 09:56:36 INFO - Return code: 0 09:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:56:36 INFO - Reading from file tmpfile_stdout 09:56:36 INFO - Output received: 09:56:36 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) 09:56:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56: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')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:36 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 09:56:36 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 09:56:36 INFO - Using env: {'DISPLAY': ':0', 09:56:36 INFO - 'HOME': '/home/cltbld', 09:56:36 INFO - 'LANG': 'en_US.UTF-8', 09:56:36 INFO - 'LANGUAGE': 'en_US:en', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MAIL': '/var/mail/cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SHLVL': '1', 09:56:36 INFO - 'TERM': 'linux', 09:56:36 INFO - 'TMOUT': '86400', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - '_': '/tools/buildbot/bin/python'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 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 09:56:36 INFO - Cleaning up... 09:56:36 INFO - Return code: 0 09:56:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56: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')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:36 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 09:56:36 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 09:56:36 INFO - Using env: {'DISPLAY': ':0', 09:56:36 INFO - 'HOME': '/home/cltbld', 09:56:36 INFO - 'LANG': 'en_US.UTF-8', 09:56:36 INFO - 'LANGUAGE': 'en_US:en', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MAIL': '/var/mail/cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SHLVL': '1', 09:56:36 INFO - 'TERM': 'linux', 09:56:36 INFO - 'TMOUT': '86400', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - '_': '/tools/buildbot/bin/python'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Downloading/unpacking psutil>=3.1.1 09:56:36 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 09:56:36 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 09:56:36 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 09:56:36 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 09:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:37 INFO - Installing collected packages: psutil 09:56:37 INFO - Running setup.py install for psutil 09:56:38 INFO - building 'psutil._psutil_linux' extension 09:56:38 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 09:56:38 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 09:56:38 INFO - building 'psutil._psutil_posix' extension 09:56:38 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 09:56:38 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 09:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:38 INFO - Successfully installed psutil 09:56:38 INFO - Cleaning up... 09:56:38 INFO - Return code: 0 09:56:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56:38 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')]} 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:38 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')]} 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:38 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:38 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 09:56:38 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 09:56:38 INFO - Using env: {'DISPLAY': ':0', 09:56:38 INFO - 'HOME': '/home/cltbld', 09:56:38 INFO - 'LANG': 'en_US.UTF-8', 09:56:38 INFO - 'LANGUAGE': 'en_US:en', 09:56:38 INFO - 'LOGNAME': 'cltbld', 09:56:38 INFO - 'MAIL': '/var/mail/cltbld', 09:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:38 INFO - 'MOZ_NO_REMOTE': '1', 09:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:38 INFO - 'NO_EM_RESTART': '1', 09:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:38 INFO - 'PWD': '/builds/slave/test', 09:56:38 INFO - 'SHELL': '/bin/bash', 09:56:38 INFO - 'SHLVL': '1', 09:56:38 INFO - 'TERM': 'linux', 09:56:38 INFO - 'TMOUT': '86400', 09:56:38 INFO - 'USER': 'cltbld', 09:56:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:38 INFO - '_': '/tools/buildbot/bin/python'} 09:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:39 INFO - Installing collected packages: mozsystemmonitor 09:56:39 INFO - Running setup.py install for mozsystemmonitor 09:56:39 INFO - Successfully installed mozsystemmonitor 09:56:39 INFO - Cleaning up... 09:56:39 INFO - Return code: 0 09:56:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:56:39 INFO - Using env: {'DISPLAY': ':0', 09:56:39 INFO - 'HOME': '/home/cltbld', 09:56:39 INFO - 'LANG': 'en_US.UTF-8', 09:56:39 INFO - 'LANGUAGE': 'en_US:en', 09:56:39 INFO - 'LOGNAME': 'cltbld', 09:56:39 INFO - 'MAIL': '/var/mail/cltbld', 09:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:39 INFO - 'MOZ_NO_REMOTE': '1', 09:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:39 INFO - 'NO_EM_RESTART': '1', 09:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:39 INFO - 'PWD': '/builds/slave/test', 09:56:39 INFO - 'SHELL': '/bin/bash', 09:56:39 INFO - 'SHLVL': '1', 09:56:39 INFO - 'TERM': 'linux', 09:56:39 INFO - 'TMOUT': '86400', 09:56:39 INFO - 'USER': 'cltbld', 09:56:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:39 INFO - '_': '/tools/buildbot/bin/python'} 09:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:41 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:41 INFO - warning: no files found matching '*.txt' 09:56:41 INFO - no previously-included directories found matching 'build' 09:56:41 INFO - no previously-included directories found matching 'dist' 09:56:41 INFO - no previously-included directories found matching '.git*' 09:56:41 INFO - Installing collected packages: jsonschema, functools32 09:56:41 INFO - Running setup.py install for functools32 09:56:41 INFO - warning: no files found matching '*.txt' 09:56:41 INFO - no previously-included directories found matching 'build' 09:56:41 INFO - no previously-included directories found matching 'dist' 09:56:41 INFO - no previously-included directories found matching '.git*' 09:56:41 INFO - Successfully installed jsonschema functools32 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:41 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 09:56:41 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 09:56:41 INFO - Using env: {'DISPLAY': ':0', 09:56:41 INFO - 'HOME': '/home/cltbld', 09:56:41 INFO - 'LANG': 'en_US.UTF-8', 09:56:41 INFO - 'LANGUAGE': 'en_US:en', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MAIL': '/var/mail/cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SHLVL': '1', 09:56:41 INFO - 'TERM': 'linux', 09:56:41 INFO - 'TMOUT': '86400', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - '_': '/tools/buildbot/bin/python'} 09:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:41 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 09:56:41 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 09:56:41 INFO - Using env: {'DISPLAY': ':0', 09:56:41 INFO - 'HOME': '/home/cltbld', 09:56:41 INFO - 'LANG': 'en_US.UTF-8', 09:56:41 INFO - 'LANGUAGE': 'en_US:en', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MAIL': '/var/mail/cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SHLVL': '1', 09:56:41 INFO - 'TERM': 'linux', 09:56:41 INFO - 'TMOUT': '86400', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - '_': '/tools/buildbot/bin/python'} 09:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:42 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 09:56:42 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 09:56:42 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 09:56:42 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 09:56:43 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:43 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 09:56:43 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 09:56:43 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 09:56:43 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 09:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:43 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 09:56:43 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 09:56:43 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 09:56:43 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 09:56:43 INFO - Downloading docopt-0.6.1.tar.gz 09:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:43 INFO - Running setup.py install for blobuploader 09:56:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:44 INFO - Running setup.py install for requests 09:56:44 INFO - Running setup.py install for docopt 09:56:44 INFO - Successfully installed blobuploader requests docopt 09:56:44 INFO - Cleaning up... 09:56:44 INFO - Return code: 0 09:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56: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')]} 09:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:44 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:44 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 09:56:44 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 09:56:44 INFO - Using env: {'DISPLAY': ':0', 09:56:44 INFO - 'HOME': '/home/cltbld', 09:56:44 INFO - 'LANG': 'en_US.UTF-8', 09:56:44 INFO - 'LANGUAGE': 'en_US:en', 09:56:44 INFO - 'LOGNAME': 'cltbld', 09:56:44 INFO - 'MAIL': '/var/mail/cltbld', 09:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:44 INFO - 'MOZ_NO_REMOTE': '1', 09:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:44 INFO - 'NO_EM_RESTART': '1', 09:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:44 INFO - 'PWD': '/builds/slave/test', 09:56:44 INFO - 'SHELL': '/bin/bash', 09:56:44 INFO - 'SHLVL': '1', 09:56:44 INFO - 'TERM': 'linux', 09:56:44 INFO - 'TMOUT': '86400', 09:56:44 INFO - 'USER': 'cltbld', 09:56:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:44 INFO - '_': '/tools/buildbot/bin/python'} 09:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:44 INFO - Running setup.py (path:/tmp/pip-DwNMQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:44 INFO - Running setup.py (path:/tmp/pip-VAAkR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:44 INFO - Running setup.py (path:/tmp/pip-l3BOFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:44 INFO - Running setup.py (path:/tmp/pip-J5ucjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:45 INFO - Running setup.py (path:/tmp/pip-UCiAvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:45 INFO - Running setup.py (path:/tmp/pip-5ernoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:45 INFO - Running setup.py (path:/tmp/pip-Jn6MGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:45 INFO - Running setup.py (path:/tmp/pip-TbOTvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:45 INFO - Running setup.py (path:/tmp/pip-kvSH7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:45 INFO - Running setup.py (path:/tmp/pip-mmJCE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:45 INFO - Running setup.py (path:/tmp/pip-L121j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:45 INFO - Running setup.py (path:/tmp/pip-2U_NgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:45 INFO - Running setup.py (path:/tmp/pip-7xIVAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:45 INFO - Running setup.py (path:/tmp/pip-mLOurp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:45 INFO - Running setup.py (path:/tmp/pip-edeqGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:45 INFO - Running setup.py (path:/tmp/pip-uSx66D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:45 INFO - Running setup.py (path:/tmp/pip-C3jsgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:45 INFO - Running setup.py install for manifestparser 09:56:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for mozcrash 09:56:46 INFO - Running setup.py install for mozdebug 09:56:46 INFO - Running setup.py install for mozdevice 09:56:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for mozfile 09:56:46 INFO - Running setup.py install for mozhttpd 09:56:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for mozinfo 09:56:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for mozInstall 09:56:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for mozleak 09:56:46 INFO - Running setup.py install for mozlog 09:56:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Running setup.py install for moznetwork 09:56:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Running setup.py install for mozprocess 09:56:47 INFO - Running setup.py install for mozprofile 09:56:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Running setup.py install for mozrunner 09:56:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Running setup.py install for mozscreenshot 09:56:47 INFO - Running setup.py install for moztest 09:56:47 INFO - Running setup.py install for mozversion 09:56:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:47 INFO - Cleaning up... 09:56:47 INFO - Return code: 0 09:56:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:47 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')]} 09:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:47 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')]} 09:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:47 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:47 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 09:56:47 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 09:56:47 INFO - Using env: {'DISPLAY': ':0', 09:56:47 INFO - 'HOME': '/home/cltbld', 09:56:47 INFO - 'LANG': 'en_US.UTF-8', 09:56:47 INFO - 'LANGUAGE': 'en_US:en', 09:56:47 INFO - 'LOGNAME': 'cltbld', 09:56:47 INFO - 'MAIL': '/var/mail/cltbld', 09:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:47 INFO - 'MOZ_NO_REMOTE': '1', 09:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:47 INFO - 'NO_EM_RESTART': '1', 09:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:47 INFO - 'PWD': '/builds/slave/test', 09:56:47 INFO - 'SHELL': '/bin/bash', 09:56:47 INFO - 'SHLVL': '1', 09:56:47 INFO - 'TERM': 'linux', 09:56:47 INFO - 'TMOUT': '86400', 09:56:47 INFO - 'USER': 'cltbld', 09:56:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:47 INFO - '_': '/tools/buildbot/bin/python'} 09:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:47 INFO - Running setup.py (path:/tmp/pip-XB_aGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:48 INFO - Running setup.py (path:/tmp/pip-dgyC4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:48 INFO - Running setup.py (path:/tmp/pip-oj2E7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:48 INFO - Running setup.py (path:/tmp/pip-sJ3dM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:48 INFO - Running setup.py (path:/tmp/pip-Lh0IWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:48 INFO - Running setup.py (path:/tmp/pip-72560S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:48 INFO - Running setup.py (path:/tmp/pip-d6PT3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:48 INFO - Running setup.py (path:/tmp/pip-aEzAnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:48 INFO - Running setup.py (path:/tmp/pip-V92zaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:48 INFO - Running setup.py (path:/tmp/pip-yjlBKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:48 INFO - Running setup.py (path:/tmp/pip-ZAcJ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:48 INFO - Running setup.py (path:/tmp/pip-Jb1aEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:48 INFO - Running setup.py (path:/tmp/pip-yy11Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:48 INFO - Running setup.py (path:/tmp/pip-gHoI3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:48 INFO - Running setup.py (path:/tmp/pip-1uFT8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:49 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)) 09:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:49 INFO - Running setup.py (path:/tmp/pip-FOGUJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:49 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)) 09:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:49 INFO - Running setup.py (path:/tmp/pip-Lrk0aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:49 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)) 09:56:49 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)) 09:56:49 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)) 09:56:49 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)) 09:56:49 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)) 09:56:49 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)) 09:56:49 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)) 09:56:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:50 INFO - Downloading blessings-1.6.tar.gz 09:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:50 INFO - Installing collected packages: blessings 09:56:50 INFO - Running setup.py install for blessings 09:56:50 INFO - Successfully installed blessings 09:56:50 INFO - Cleaning up... 09:56:50 INFO - Return code: 0 09:56:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:50 INFO - Reading from file tmpfile_stdout 09:56:50 INFO - Current package versions: 09:56:50 INFO - argparse == 1.2.1 09:56:50 INFO - blessings == 1.6 09:56:50 INFO - blobuploader == 1.2.4 09:56:50 INFO - docopt == 0.6.1 09:56:50 INFO - functools32 == 3.2.3-2 09:56:50 INFO - jsonschema == 2.5.1 09:56:50 INFO - manifestparser == 1.1 09:56:50 INFO - mozInstall == 1.13 09:56:50 INFO - mozcrash == 1.0 09:56:50 INFO - mozdebug == 0.1 09:56:50 INFO - mozdevice == 0.51 09:56:50 INFO - mozfile == 1.2 09:56:50 INFO - mozhttpd == 0.7 09:56:50 INFO - mozinfo == 0.10 09:56:50 INFO - mozleak == 0.1 09:56:50 INFO - mozlog == 3.5 09:56:50 INFO - moznetwork == 0.27 09:56:50 INFO - mozprocess == 0.25 09:56:50 INFO - mozprofile == 0.28 09:56:50 INFO - mozrunner == 6.13 09:56:50 INFO - mozscreenshot == 0.1 09:56:50 INFO - mozsystemmonitor == 0.3 09:56:50 INFO - moztest == 0.8 09:56:50 INFO - mozversion == 1.4 09:56:50 INFO - psutil == 3.1.1 09:56:50 INFO - requests == 1.2.3 09:56:50 INFO - wsgiref == 0.1.2 09:56:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:50 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 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:50 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 09:56:50 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 09:56:50 INFO - Using env: {'DISPLAY': ':0', 09:56:50 INFO - 'HOME': '/home/cltbld', 09:56:50 INFO - 'LANG': 'en_US.UTF-8', 09:56:50 INFO - 'LANGUAGE': 'en_US:en', 09:56:50 INFO - 'LOGNAME': 'cltbld', 09:56:50 INFO - 'MAIL': '/var/mail/cltbld', 09:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:50 INFO - 'MOZ_NO_REMOTE': '1', 09:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:50 INFO - 'NO_EM_RESTART': '1', 09:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:50 INFO - 'PWD': '/builds/slave/test', 09:56:50 INFO - 'SHELL': '/bin/bash', 09:56:50 INFO - 'SHLVL': '1', 09:56:50 INFO - 'TERM': 'linux', 09:56:50 INFO - 'TMOUT': '86400', 09:56:50 INFO - 'USER': 'cltbld', 09:56:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:50 INFO - '_': '/tools/buildbot/bin/python'} 09:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 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)) 09:56:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:52 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:56:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:56:52 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 09:56:52 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 09:56:52 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 09:56:52 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 09:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:56:52 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)) 09:56:52 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)) 09:56:52 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)) 09:56:52 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)) 09:56:52 INFO - Installing collected packages: marionette-driver, simplejson 09:56:52 INFO - Running setup.py install for marionette-driver 09:56:52 INFO - Running setup.py install for simplejson 09:56:52 INFO - building 'simplejson._speedups' extension 09:56:52 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 09:56:53 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 09:56:53 INFO - Successfully installed marionette-driver simplejson 09:56:53 INFO - Cleaning up... 09:56:53 INFO - Return code: 0 09:56:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', '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 09:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:53 INFO - Using env: {'DISPLAY': ':0', 09:56:53 INFO - 'HOME': '/home/cltbld', 09:56:53 INFO - 'LANG': 'en_US.UTF-8', 09:56:53 INFO - 'LANGUAGE': 'en_US:en', 09:56:53 INFO - 'LOGNAME': 'cltbld', 09:56:53 INFO - 'MAIL': '/var/mail/cltbld', 09:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:53 INFO - 'MOZ_NO_REMOTE': '1', 09:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:53 INFO - 'NO_EM_RESTART': '1', 09:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:53 INFO - 'PWD': '/builds/slave/test', 09:56:53 INFO - 'SHELL': '/bin/bash', 09:56:53 INFO - 'SHLVL': '1', 09:56:53 INFO - 'TERM': 'linux', 09:56:53 INFO - 'TMOUT': '86400', 09:56:53 INFO - 'USER': 'cltbld', 09:56:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:53 INFO - '_': '/tools/buildbot/bin/python'} 09:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:53 INFO - Cleaning up... 09:56:53 INFO - Return code: 0 09:56:53 INFO - Running post-action listener: _resource_record_post_action 09:56:53 INFO - Running post-action listener: _start_resource_monitoring 09:56:53 INFO - Starting resource monitoring. 09:56:53 INFO - [mozharness: 2017-07-18 16:56:53.803277Z] Finished create-virtualenv step (success) 09:56:53 INFO - [mozharness: 2017-07-18 16:56:53.803790Z] Running install step. 09:56:53 INFO - Running pre-action listener: _resource_record_pre_action 09:56:53 INFO - Running main action method: install 09:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:54 INFO - Reading from file tmpfile_stdout 09:56:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:54 INFO - Reading from file tmpfile_stdout 09:56:54 INFO - Output received: 09:56:54 INFO - Usage: mozinstall [options] installer 09:56:54 INFO - Options: 09:56:54 INFO - -h, --help show this help message and exit 09:56:54 INFO - -d DEST, --destination=DEST 09:56:54 INFO - Directory to install application into. [default: 09:56:54 INFO - "/builds/slave/test"] 09:56:54 INFO - --app=APP Application being installed. [default: firefox] 09:56:54 INFO - mkdir: /builds/slave/test/build/application 09:56:54 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'] 09:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:57:12 INFO - Reading from file tmpfile_stdout 09:57:12 INFO - Output received: 09:57:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:57:12 INFO - Running post-action listener: _resource_record_post_action 09:57:12 INFO - [mozharness: 2017-07-18 16:57:12.081421Z] Finished install step (success) 09:57:12 INFO - [mozharness: 2017-07-18 16:57:12.081685Z] Running setup-mitmproxy step. 09:57:12 INFO - Running pre-action listener: _resource_record_pre_action 09:57:12 INFO - Running main action method: setup_mitmproxy 09:57:12 INFO - Skipping: mitmproxy is not required 09:57:12 INFO - Running post-action listener: _resource_record_post_action 09:57:12 INFO - [mozharness: 2017-07-18 16:57:12.082836Z] Finished setup-mitmproxy step (success) 09:57:12 INFO - [mozharness: 2017-07-18 16:57:12.083058Z] Running run-tests step. 09:57:12 INFO - Running pre-action listener: _resource_record_pre_action 09:57:12 INFO - Running pre-action listener: _set_gcov_prefix 09:57:12 INFO - Running main action method: run_tests 09:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:12 INFO - Python 2.7.3 09:57:12 INFO - Return code: 0 09:57:12 INFO - grabbing minidump binary from tooltool 09:57: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')]} 09:57:12 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 0x119dd00>, '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 0x119ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:12 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 09:57:12 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 09:57:12 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 09:57:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:12 INFO - Return code: 0 09:57:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: RUST_BACKTRACE is now 1 09:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:12 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/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 09:57:12 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/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 09:57:12 INFO - Using env: {'DISPLAY': ':0', 09:57:12 INFO - 'HOME': '/home/cltbld', 09:57:12 INFO - 'LANG': 'en_US.UTF-8', 09:57:12 INFO - 'LANGUAGE': 'en_US:en', 09:57:12 INFO - 'LOGNAME': 'cltbld', 09:57:12 INFO - 'MAIL': '/var/mail/cltbld', 09:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:12 INFO - 'MOZ_NO_REMOTE': '1', 09:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:12 INFO - 'NO_EM_RESTART': '1', 09:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:12 INFO - 'PWD': '/builds/slave/test', 09:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:12 INFO - 'RUST_BACKTRACE': '1', 09:57:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:57:12 INFO - 'SHELL': '/bin/bash', 09:57:12 INFO - 'SHLVL': '1', 09:57:12 INFO - 'TERM': 'linux', 09:57:12 INFO - 'TMOUT': '86400', 09:57:12 INFO - 'USER': 'cltbld', 09:57:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045', 09:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:12 INFO - '_': '/tools/buildbot/bin/python'} 09:57:12 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/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 09:57:12 INFO - mozversion application_buildid: 20170718161641 09:57:12 INFO - mozversion application_changeset: dece50457378ac4934afe9fb3c2a8054e8894588 09:57:12 INFO - mozversion application_display_name: Nightly 09:57:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:12 INFO - mozversion application_name: Firefox 09:57:12 INFO - mozversion application_remotingname: firefox 09:57:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:57:12 INFO - mozversion application_vendor: Mozilla 09:57:12 INFO - mozversion application_version: 56.0a1 09:57:12 INFO - mozversion platform_buildid: 20170718161641 09:57:12 INFO - mozversion platform_changeset: dece50457378ac4934afe9fb3c2a8054e8894588 09:57:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:57:12 INFO - mozversion platform_version: 56.0a1 09:57:12 INFO - using testdate: 1500397032 09:57:12 INFO - actual date: 1500397032 09:57:12 INFO - starting webserver on 'localhost:42498' 09:57:12 INFO - SUITE-START | Running 2 tests 09:57:12 INFO - TEST-START | dromaeo_css 09:57:12 INFO - Initialising browser for dromaeo_css test... 09:57:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42498/getInfo.html -profile /tmp/tmpMw7NMA/profile 09:57:12 INFO - TEST-INFO | started process 10928 (/builds/slave/test/build/application/firefox/firefox http://localhost:42498/getInfo.html) 09:57:18 INFO - TEST-INFO | 10928: exit 0 09:57:18 INFO - Browser initialized. 09:57:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:18 INFO - TEST-INFO | started process 11194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMw7NMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:30 INFO - PID 11194 | RSS: Main: 178704384 09:57:30 INFO - PID 11194 | 10:00:28 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42498/tests/dromaeo/cssquery-ext.html) 10:00:30 INFO - PID 11194 | RSS: Main: 181198848 10:00:30 INFO - PID 11194 | 10:03:32 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-ext.html (next: http://localhost:42498/tests/dromaeo/cssquery-jquery.html) 10:03:32 INFO - PID 11194 | RSS: Main: 177876992 10:03:32 INFO - PID 11194 | 10:06:34 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42498/tests/dromaeo/cssquery-mootools.html) 10:06:35 INFO - PID 11194 | RSS: Main: 179593216 10:06:35 INFO - PID 11194 | 10:09:36 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42498/tests/dromaeo/cssquery-prototype.html) 10:09:37 INFO - PID 11194 | RSS: Main: 177844224 10:09:37 INFO - PID 11194 | 10:12:40 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42498/tests/dromaeo/cssquery-yui.html) 10:12:41 INFO - PID 11194 | RSS: Main: 180842496 10:12:41 INFO - PID 11194 | 10:15:42 INFO - PID 11194 | Cycle 1(1): loaded http://localhost:42498/tests/dromaeo/cssquery-yui.html (next: http://localhost:42498/tests/dromaeo/cssquery-dojo.html) 10:15:43 INFO - PID 11194 | RSS: Main: 182607872 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | __start_tp_report 10:15:43 INFO - PID 11194 | _x_x_mozilla_page_load 10:15:43 INFO - PID 11194 | _x_x_mozilla_page_load_details 10:15:43 INFO - PID 11194 | |i|pagename|runs| 10:15:43 INFO - PID 11194 | |0;dojo.html;3073.10879844845;3111.7977331473453;3141.4816555268376;3161.715445609896;3174.3016536361993;6101.237345331833;6143.815685529441;6159.3224745277985;6188.257409110907;6230.906536401958;6190.195274614305;6216;6218.098375735515;6237.656928868922;6243.594166379182;5654.293213348332;5662.490375866181;5682.772689092431;5712.1431785232135;5715.028445164332;5675.659460432387;5685.374608793029;5687.232223649796;5697.6011679182475;5708.828735137952;5706.657600543981;5708.20085188074;5717.256756621633;5718.771249150029;5725.856853578653;5699.544036477072;5706.686132262724;5717.313922329306;5728.16941543476;5730.19777231188;5632.070708333161;5649.067903795869;5672.829815105553;5716.657000579979;5752.568557358215;6209.006558950547;6221.502279817604;6243.500519958392;6294.181756371642;6310.810675679737;6621.86756264872;6637.535372523926;6702.765403210913;6703.798886033427;6729.865402691968;6526.314736952599;6542.4111829935055;6565.606063636149;6566.113574667406;6578.407943285079;6114.2357205349335;6168.414000669929;6192;6197.597156184834;6218;6749.291324410964;6851.931480685129;6859.07402500656;6943.097397338313;6947;6427.807165785034;6476.838079047967;6508.284088750233;6519.250286217051;6608.140941677647;6469.482441404676;6621.470282377399;6687.4984376171005;6690.899636505456;6698;6463.080455229941;6482.157319548429;6519.282878883319;6549.967250163719;6567.901481477782;6611;6650.3349665034075;6673.866522669519;6725.798226053226;6748.662566871637;5291;5342.305500284938;5391.865203369869;5392.892142157135;5408.756605952742;4485.484169320504;4581.839635612738;4586.610138138229;4600.3099535070005;4604.148232576984;5727.914081288784;5744.310682718101;5744.4829965303325;5751.511121554715;5758.539316854642;6605.405513503808;6606.8017959461295;6611.371919667624;6617.636030018395;6635.535512514174;5675.914861277084;5730.312362516524;5742.13867919807;5755;5768.134779783066;5774.133879917962;5777.508911742465;5782.479576838105;5790;5803.564732645069;6350.6189628621505;6401.455876250478;6453.419192272718;6507.7071531781185;6528.608283503005;6697.765578204934;6700.128983232344;6792.150981127359;6805.421539169028;6806.829829254309;6366.045093236052;6393.520485963479;6463.547551671338;6471.06169605414;6486.708098135501;6501.772437964649;6517.543771935919;6563.409293163638;6575.947848344242;6577.769778057745;6614.867702646016;6627.3372662733345;6639.3692599203;6649.2685804562425;6672.466202703869;6391.712372943136;6447.3552644735155;6470.611763294218;6505.251896032017;6549.279579246184;6404.487640988803;6421.64680942534;6499.610023398611;6535.738570457129;6556.803295901131;6182.381761823962;6333.6516491591565;6377.840553986188;6413.1021656969;6424.93575064262;6523.7716679915975;6533.738650453929;6538.607683539003;6571.769988050395;6594;5990.101484777319;6312.210973628296;6318.273398559225;6421.743130274924;6432.549721519449 10:15:43 INFO - PID 11194 | |1;ext.html;726.9273072692728;743.1045590063974;777.444127448874;784.6782819044197;804.919508049195;38476.99999999996;39615.80192099042;39820.80089599548;39893;40041.79979100104;37284;37637.435438468376;37670;37678.81160594193;37710.24579508408;6636.4690824734025;6719.596824190564;6741;6745.123133992599;6750.324967503259;6758.594484330932;6777.118974533304;6804.727810887559;6839.076724642159;6855.765962126815;6724.327567243261;6777;6790;6801.353871382235;6828.863422731542;6733.696983635724;6742.123523941857;6742.7640032598865;6760.560563563377;6774.085498457744;6119.755209791603;6147.293061297919;6174.351693072253;6205.100260462208;6220.409061139185;32706.836465817756;32974.50538241928;32995.83502082498;33013;33069.83465082683;3354.7483938704695;3410.9488357674654;3442.1566716154703;3512.4731290306404;3607.603163651996;29712.405751885057;29739.405211895857;29894.10317690451;29972.85013574918;29993.250168745737;4811.4707382187935;4840.975795121037;4845.224764037773;4848.29699693546;4948.975255123737;188582;192625;193274;196852;198018;41203;47228.29157562639;47232.291515627294;47595;47606.5239347609;49630.50369496331;49811.25283120756;49824.50175498271;49860.50139498631;50029.49970500321;15600.921995390177;15793.763093553605;15832.68334633301;15853.762193567105;15857.603559911095;12990.610281691565;13009.739805203842;13067.346632668328;13074.673133171747;13095;14288.785668214985;14345.713085738227;14416;14417.567472975827;14513.274336283144;5717.8570535736935;5749.741261643236;5871.442212989759;5943.435373639497;5946;964.5225613321451;981.4258658684606;998.3560603410759;1021.7598864266891;1021.8569400283966;21842.689438633734;21965;21983.23058692938;22036.88981555114;22506.774932250795;1083.3608171178885;1096.2326371539955;1112.093643680398;1120.1822669451346;1120.4789772755707;11362.829557556643;11413.48639311233;11823.408829558488;11892.76214475723;11974.88025119755;228558;230118;230394;231433;231610;49114;49373;49658.255126173135;49736.751316243186;49798;1453.636590852308;1490.2027415332745;1490.5230326295482;1495.2150121186464;1498.1685164733678;21543.67943238864;21760.782392175875;22275;22281.331560053226;22703.091876325423;35334.29331413306;35363.646363536034;35445.46831797474;35464.64535354613;35740.4638930411;189874.0506297515;190941;193117;194536;195051;29970.100896973127;30036.24909377283;30071.849640751658;31633.5254971171;32347.514787277738;40033;41986.160276793686;42053;42081.57918420777;42470;28569.62332928311;30617.387652246383;30960.225994350323;31271.84364078165;32944.01167964965;31751.72993080251;33070.66929330676;33105.50341744828;33214.66785332116;33316.50025249672;34849.65150348464;36673.81663091668;36753.816230918674;36769.816150919076;37043.814780925924;31071;31476.37047259088;31673.524897127023;31783.52324715085;31886.52170217402;22636.320910372717;23597.646035309826;23973.04107835667;24020.39949001289;24150.03399864056 10:15:43 INFO - PID 11194 | |2;jquery.html;558.9273394458722;563.3633993587247;568.7810193075665;573.1774903014177;590.3358721438381;21143.471413214676;21784.564308713838;21874.343769686915;21939.561208775816;22448.326550203477;26059.739402605966;26326.47347053058;26578.33554161147;26595.202143935665;26738.5989210162;6212.813615591528;6292.244930608334;6378.4578310843635;6379.649119298437;6386.712597933104;6164.07538869171;6333.113364129025;6399.232092148949;6399.648019358933;6428.164338635994;5986.970065149668;6226.377362263783;6255.749770009217;6267.091271765591;6280.780172693957;6269.968650156766;6271.529635277349;6277.591956522857;6286.057091436275;6291.748330066815;5841.153032810219;5870.765169393219;5871.148683440877;5884.941150588482;5903.734331955029;27487.45025099487;27638.86180569084;27952.440951180863;28409;28458.146255612366;1955.1885967323544;1967.3802752133176;1985.5731017831235;1985.7517810273716;1986.920523179071;17928.282868685237;18597;18600.34898778536;18652.25390984359;18701.62596748071;2252.4368907773055;2274.2494976657663;2319.1651005637955;2322.7328857181474;2326.2904814031713;131516;140072;140083;140379.99999999898;140408;13723.519676811464;14501.564953051426;14603.123812571068;14682.339294731762;14724.337404816595;22914.541709165722;22930.770692292863;23040.65439018416;23134.305970820904;23162.768372316397;9716.765144016774;9724.659636912675;9790.314677972474;9820.214382849355;9855.979524197523;8785.692500762443;8813.42712723671;8857.64569417216;8908.777280568038;8937.285017198608;8685.261752750961;8818.470891746516;9029.593668284942;9173.44959302444;9189.540522973824;2496.463260399023;2520.798336133105;2559.2066459397647;2589.52093862636;2620.4235068284947;926.2358554192817;932.4778124250441;952.4904176265665;954;975.5219942228257;19234.903825480782;19615.607687846164;19654.606907861762;20151.294704685264;20283;979.0943377375899;1009.399407352624;1013.6654903881702;1032.3135115148343;1034.9586016559404;10560.313579617301;10874;10973.177011723992;10977.945110274557;11045.171612129123;529539;548795;554057;556727;588606;112316;116190;117966;118141.40929295299;126703;1264.4183675509184;1266.993665031669;1279.635303938373;1321.8876395506297;1324.3312127375614;18709.625807484048;21293.89353053225;21409.357719268446;21492.46268843229;21735.78264217401;54557.72721136369;55771.72114139403;56478.71760641171;56564.717176413855;57364.71317643385;76596.61701691456;79735.60132199302;79933;80650.5967470159;81191.18808812073;20373.18507259693;21192.36422907315;21204;21372.465688357915;21531.354059378245;20450.386488405373;23463.76536234616;24132.51734965326;24306.27081187567;24367.878160609085;18287.634247314712;18472.722909156106;18734.906325468284;18799;19467.27458155831;12869.613911582668;13885.444582216598;14170.57488275312;16574.254158562653;16885.155742213086;19154.71267930954;19246.23015079381;19845.503862403555;19847.60304793925;19857.503562411057;20891;21196.68204976896;21234.469138271048;21261.36215913525;21272.680909786057;18188.90905545464;18463.61522885762;18591.16339764687;18720.7191892119;19013.714794278374 10:15:43 INFO - PID 11194 | |3;mootools.html;1344.6571124363288;1381.2817334985807;1385.8059871617975;1393.9233342166176;1401.5444980381376;13209.603711888634;13796.93101534491;13816.723665526684;13855.584332470016;13877.444902203912;13808.79286810696;14097.224652644101;14579.92710036451;14587.781183282259;14594;2518.3452302401324;2547.503236868811;2563.282280961334;2564.61530770385;2577.523158215736;2562.2569454858067;2626.3696712788887;2628.067036202149;2632.670916135483;2637.2483842105003;2252.695886055386;2558.5266725655815;2586.702529209146;2594.3514121469634;2607.1005503101496;2232.754397016327;2233.8883055847223;2240.574290884727;2540.809439292042;2624.160268714012;2508.209913877141;2512.359348366173;2520.1053625962886;2530.101813856073;2535.8351707138977;13387.397567109503;13677.726445471135;13683.589492315246;13684;13707.725845483035;7131.607761573111;7369.115706115247;7391.630418479054;7400.740974065936;7404.9629751851435;4773.4510531289;4856.441509226449;4964.627652926045;4968.87577810554;4997.275395067695;1812.7915289741716;1815.9921243709737;1839.0988415676222;1882.425860112665;1883.2467013194832;22423.77576224233;22516.887415562982;22660.433489162737;22681.659775103388;22750;6007.15899774032;6044.335123136451;6106.511479081662;6131.202943617391;6140.140380346755;14694.706105878036;14865.554033379016;14927.776083358758;14943.551693448997;14964.476243331432;7130.180029296697;7261.7095316187815;7294.70821167158;7298.817529561803;7303.050603421521;6715.664216789141;6754.93245067543;6782.898256526156;6831.28271531482;6925.065116209348;4680.602148817388;4742.57316841479;4766.809327626856;4853.9029219416125;4872.049950259665;1362.1894972491352;1383.197745307719;1385.231196685829;1391.8886489080849;1392.749305125067;875.9255463285692;886.1935638569;892.0633334998225;893.647009431284;899.0559912092408;8453.408261421642;8721.563921803885;8802.339824513187;8871.379003469825;8892.466452012899;979.3683074416961;991.7850632974548;1006.1447769395954;1012.9949350253202;1018.3940555369543;5056.494350564914;5178.948210517847;5231.058409486329;5248.317718696545;5374.247605335257;18946.242150313832;19647.50881227952;19770.60458790816;19853;19860.10629521675;19038.143283552272;19134.330298439487;19321;19531.609367812565;19566.21735130579;9915.454649994175;10646.787064258671;10664.626738064131;10723.249372544004;10854.945725271482;7556.858768463969;8236;8273.33813294947;8418.410711250153;8513.87229191575;15617.843821561639;15984.561389475002;16125.435609754071;16352.591185220464;16432.589185270463;16422.67154656924;16449.588760281087;17350.47948561545;17387.652246955244;17596.472105836845;10902.56389744433;11376.431178441211;11469.369184694922;11488.310701357945;11516.827247591125;12884.48462061507;13186.604401867959;13189.538366157138;13190.406431710788;13199.274039927896;10137.68210132678;10344.069033786995;10379.429131397543;10387.896121038693;10445.791084178121;9340.53297335144;9982;10377.481125943823;10377.636782712569;10411.11505522039;9124.49815260167;9253.58358873839;9338.95330523343;9340.486273255035;9359.298052646214;6890.414314783299;7072.929270707227;7262.164851042197;7303.415726741741;7330.633468326669;6929.203141638776;7019.508634395544;7280.854382912418;7293.890591641023;7300.05099337104 10:15:43 INFO - PID 11194 | |4;prototype.html;471.70989841247643;488.86067470770837;497.9402471703396;501.4559203264458;508.4686502604778;5966.492848107905;6022.608530445518;6038.991203752262;6078;6085.908711369328;5769.682667453289;5914.4085591440835;5931.902598019369;5952.166696662471;5956.927753004457;4820.566149046585;4830.657131291321;4841.298011788306;4865.732384718839;4883.6337274704365;4845.418549774032;4849.927251091236;4863.781129849148;4889.413270407538;4900.754962251891;4760.571548560629;4817.988757026858;4820.445648750404;4834.2265237562;4853.538913803183;4599.471060828014;4698.08387364464;4767.499412561666;4830.178869592178;4843.370361852972;4298.570142985708;4312.82748690052;4330.17726631939;4336.934945975813;4337.3084497046175;5762.415335782652;5924.407559244084;5938.792142275043;5939.316978547436;5978.163057172;5417.647852889589;5466.453354664542;5478.561715062785;5510.972445137789;5527.944720552783;6336.2396512418345;6424.3254458282145;6430.164078669743;6451;6472.967635161841;4701.341812146302;4712.2224832902875;4716.608600462838;4742.585338556234;4749.100359856051;6672.566283191577;6780.288069752703;6818.863622727567;6836.077129587541;6839.965800171017;4866.975665121652;4872.19608764557;4873.658843880894;4898.706077635282;4918.835712286583;4869.878253043702;4883.8290659826735;4916.287138364917;4930.728809915489;4932.21084626458;5411.781169720396;5422.972885135549;5471.124620060771;5502.80740174092;5510.586705997066;6387.968060159669;6399.9040014399825;6406.263279722798;6440.9438590707005;6503.674816259168;1688.9155542223086;1713.8029126650595;1718.7937447506379;1723.5174151237673;1728.395061728385;1091.3560999010463;1179.5930404010603;1180.3036208636945;1194.295365734221;1205.108219917255;5463.262459567987;5557.77768889248;5671.2060311556415;5699.202111704365;5703.40114288002;6449.548531602836;6470.255920569195;6486.6756662167645;6562.737490500422;6595.571287866273;5667.773289068391;5670.291213598301;5672.858178545487;5685.971570142206;5751.712414379264;3398.7790793598833;3479.199784049632;3480.686738193575;3490.511328414024;3534.5228394166456;6416.550841441148;6421.839454013593;6422.518311126591;6427.967860160763;6482.546221764525;6671.166104236971;6740.258571557125;6804.625745583941;6813.965930170417;6815;6362.236531616236;6405.35946405365;6407.487401007908;6413.807585772341;6418.267067891737;6480.351964803482;6563.868722625616;6584.407403333723;6584.7036883341325;6620.3710647488415;6466;6475.546711730133;6507.251666058464;6514.413702766584;6584.242812076673;6316.936830631818;6335.746570137143;6360.427561519486;6385.265694445198;6430.974243113405;4785.736784476887;4820.8794780130775;4826.686265392738;4829.140780799487;4842.806287748451;6495.610263384212;6568.27748947625;6582.605043697394;6584.275729669828;6629.237637671729;6328.683565821599;6341.968290158519;6369.20384951881;6385.10608514799;6458.934275844433;6324.988001919671;6370.458511026429;6391.584547004616;6420.165378500765;6427.196600424947;6221.9377806223165;6285.937140628535;6320.715567799368;6331.841703957438;6392.264889537762;5821;6412.903806443001;6417.93582064192;6426.775062872777;6454.903176452451;6138.693065346804;6190.721417536131;6205.689715514116;6210.596311239755;6237.906431403623 10:15:43 INFO - PID 11194 | |5;yui.html;906.1120102299747;906.9183773460387;923.6536298887917;925.9629614815408;933.5798890499273;18714.53213669659;19078.618427631438;19188.616227675455;19205.615887682237;19252.614947701037;19619.11713972871;20472.078756455958;20862.478438039056;21008.684869726967;21079.367618971417;1015.1219195395985;1039.3504059962524;1043.7964596903607;1044.6552637629602;1047.261680515235;1058.5977328615115;1059.311447559085;1060.2472244706269;1060.42736922062;1060.6340812419703;1058.3226734889677;1079.3416016230094;1097.2209731090934;1130.0451118804638;1131.4003578103618;1069.470612047034;1071.3304184884448;1078.7195329214383;1079.104343394988;1080.1304949515636;793.5992323876405;793.6388943030908;793.6745934166964;793.8174219929449;795.6220795122271;18293.634127317513;18530.351437699617;18957;19144.521386965298;19262.61474770511;19972.600547989103;20411.183552658025;20643.793562064486;20672.689909651366;20746;15292;15452.845471545366;15594.454194103151;15628.14045227512;15690.68618627621;3544.220271540257;3546.85812567497;3547.343741407822;3575.213453040327;3577.5349204603235;125338;125601;131616.3419182898;131734.34132829274;135620.32189838987;15679.843201568066;15846.207689615703;15897.52307430779;15990.360385584447;16332.83667163337;28880.422391552052;29291.707082929322;29466.11601651954;29483;29635.40729185404;7747.767566973;7761.922380776233;7762.107357653942;7772.961135194401;7824.256695613907;3924.2543916655745;4007.539132999684;4011.6991225658194;4014.6186112319283;4017.397390391465;4776.47458779534;4834.927476087862;4939.925901111486;4959.90080198394;5010.348654674869;862.288611895189;889.8709687095464;894.2086253665553;894.4096896048577;911.9270458363314;663.731188868509;696.1055044268091;713.6289129652655;721.7473884140509;732.7179036071151;11228.494717737722;11230;11679.306500557372;12037.578684745991;12106;560.3248086056292;584.360125662399;592.7717828636006;622.8816524860262;676.6244734172483;5322.175062865262;5368.248445217672;5370.91943620846;5408.269883565668;5485.890282194334;97105.5144724286;99646.50176749215;101658.49170754099;102433.48783256185;102659.486702566;93725;93855.2499077738;94436;94835.52582237183;97745;76644.61677691687;80382;81738.18261817425;82569.58715206505;84555;11810.704732381759;11969.581064662694;12060.371849800516;12307.507699691912;12351.19717218378;35653.48969169665;35803.46294805632;36126.277474450886;36373.636263637025;36579.634203657624;42922;63319.366806331345;65095;65950;66296;17854.5536361592;18026.008569528276;18704;18975.525611859815;19147.61704765869;19025.714614281074;19175.80824191796;19993.200271988957;20633.793662063188;20980.638471814727;16222.594435139215;16226.350945962502;16797.66404671924;17677.823221768132;18157.636847263246;17849.37527186542;18081.819181808012;18417.02893119483;18997;19446.124924378153;17355.826441735422;17570.20934057996;18728.157232924277;18972.525686857938;18974.525636859187;12331.136820422484;12421.689457763629;12884.291363974697;13943.233122178377;14484.565463036126;13282;13317.267550284827;13520.256385898476;13621.318934053455;13869.861301386856 10:15:43 INFO - PID 11194 | __end_tp_report 10:15:43 INFO - PID 11194 | __start_cc_report 10:15:43 INFO - PID 11194 | _x_x_mozilla_cycle_collect,369 10:15:43 INFO - PID 11194 | __end_cc_report 10:15:43 INFO - PID 11194 | __startTimestamp1500398143132__endTimestamp 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | ------- Summary: start ------- 10:15:43 INFO - PID 11194 | Number of tests: 6 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#0] dojo.html Cycles:165 Average:6111.83 Median:6377.84 stddev:721.98 (11.3%) stddev-sans-first:683.71 10:15:43 INFO - PID 11194 | Values: 3073.1 3111.8 3141.5 3161.7 3174.3 6101.2 6143.8 6159.3 6188.3 6230.9 6190.2 6216.0 6218.1 6237.7 6243.6 5654.3 5662.5 5682.8 5712.1 5715.0 5675.7 5685.4 5687.2 5697.6 5708.8 5706.7 5708.2 5717.3 5718.8 5725.9 5699.5 5706.7 5717.3 5728.2 5730.2 5632.1 5649.1 5672.8 5716.7 5752.6 6209.0 6221.5 6243.5 6294.2 6310.8 6621.9 6637.5 6702.8 6703.8 6729.9 6526.3 6542.4 6565.6 6566.1 6578.4 6114.2 6168.4 6192.0 6197.6 6218.0 6749.3 6851.9 6859.1 6943.1 6947.0 6427.8 6476.8 6508.3 6519.3 6608.1 6469.5 6621.5 6687.5 6690.9 6698.0 6463.1 6482.2 6519.3 6550.0 6567.9 6611.0 6650.3 6673.9 6725.8 6748.7 5291.0 5342.3 5391.9 5392.9 5408.8 4485.5 4581.8 4586.6 4600.3 4604.1 5727.9 5744.3 5744.5 5751.5 5758.5 6605.4 6606.8 6611.4 6617.6 6635.5 5675.9 5730.3 5742.1 5755.0 5768.1 5774.1 5777.5 5782.5 5790.0 5803.6 6350.6 6401.5 6453.4 6507.7 6528.6 6697.8 6700.1 6792.2 6805.4 6806.8 6366.0 6393.5 6463.5 6471.1 6486.7 6501.8 6517.5 6563.4 6575.9 6577.8 6614.9 6627.3 6639.4 6649.3 6672.5 6391.7 6447.4 6470.6 6505.3 6549.3 6404.5 6421.6 6499.6 6535.7 6556.8 6182.4 6333.7 6377.8 6413.1 6424.9 6523.8 6533.7 6538.6 6571.8 6594.0 5990.1 6312.2 6318.3 6421.7 6432.5 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#1] ext.html Cycles:180 Average:36578.49 Median:33265.58 stddev:53535.48 (160.9%) stddev-sans-first:53617.98 10:15:43 INFO - PID 11194 | Values: 726.9 743.1 777.4 784.7 804.9 38477.0 39615.8 39820.8 39893.0 40041.8 37284.0 37637.4 37670.0 37678.8 37710.2 6636.5 6719.6 6741.0 6745.1 6750.3 6758.6 6777.1 6804.7 6839.1 6855.8 6724.3 6777.0 6790.0 6801.4 6828.9 6733.7 6742.1 6742.8 6760.6 6774.1 6119.8 6147.3 6174.4 6205.1 6220.4 32706.8 32974.5 32995.8 33013.0 33069.8 3354.7 3410.9 3442.2 3512.5 3607.6 29712.4 29739.4 29894.1 29972.9 29993.3 4811.5 4841.0 4845.2 4848.3 4949.0 188582.0 192625.0 193274.0 196852.0 198018.0 41203.0 47228.3 47232.3 47595.0 47606.5 49630.5 49811.3 49824.5 49860.5 50029.5 15600.9 15793.8 15832.7 15853.8 15857.6 12990.6 13009.7 13067.3 13074.7 13095.0 14288.8 14345.7 14416.0 14417.6 14513.3 5717.9 5749.7 5871.4 5943.4 5946.0 964.5 981.4 998.4 1021.8 1021.9 21842.7 21965.0 21983.2 22036.9 22506.8 1083.4 1096.2 1112.1 1120.2 1120.5 11362.8 11413.5 11823.4 11892.8 11974.9 228558.0 230118.0 230394.0 231433.0 231610.0 49114.0 49373.0 49658.3 49736.8 49798.0 1453.6 1490.2 1490.5 1495.2 1498.2 21543.7 21760.8 22275.0 22281.3 22703.1 35334.3 35363.6 35445.5 35464.6 35740.5 189874.1 190941.0 193117.0 194536.0 195051.0 29970.1 30036.2 30071.8 31633.5 32347.5 40033.0 41986.2 42053.0 42081.6 42470.0 28569.6 30617.4 30960.2 31271.8 32944.0 31751.7 33070.7 33105.5 33214.7 33316.5 34849.7 36673.8 36753.8 36769.8 37043.8 31071.0 31476.4 31673.5 31783.5 31886.5 22636.3 23597.6 23973.0 24020.4 24150.0 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#2] jquery.html Cycles:180 Average:37186.47 Median:23148.54 stddev:92921.96 (401.4%) stddev-sans-first:93141.93 10:15:43 INFO - PID 11194 | Values: 558.9 563.4 568.8 573.2 590.3 21143.5 21784.6 21874.3 21939.6 22448.3 26059.7 26326.5 26578.3 26595.2 26738.6 6212.8 6292.2 6378.5 6379.6 6386.7 6164.1 6333.1 6399.2 6399.6 6428.2 5987.0 6226.4 6255.7 6267.1 6280.8 6270.0 6271.5 6277.6 6286.1 6291.7 5841.2 5870.8 5871.1 5884.9 5903.7 27487.5 27638.9 27952.4 28409.0 28458.1 1955.2 1967.4 1985.6 1985.8 1986.9 17928.3 18597.0 18600.3 18652.3 18701.6 2252.4 2274.2 2319.2 2322.7 2326.3 131516.0 140072.0 140083.0 140380.0 140408.0 13723.5 14501.6 14603.1 14682.3 14724.3 22914.5 22930.8 23040.7 23134.3 23162.8 9716.8 9724.7 9790.3 9820.2 9856.0 8785.7 8813.4 8857.6 8908.8 8937.3 8685.3 8818.5 9029.6 9173.4 9189.5 2496.5 2520.8 2559.2 2589.5 2620.4 926.2 932.5 952.5 954.0 975.5 19234.9 19615.6 19654.6 20151.3 20283.0 979.1 1009.4 1013.7 1032.3 1035.0 10560.3 10874.0 10973.2 10977.9 11045.2 529539.0 548795.0 554057.0 556727.0 588606.0 112316.0 116190.0 117966.0 118141.4 126703.0 1264.4 1267.0 1279.6 1321.9 1324.3 18709.6 21293.9 21409.4 21492.5 21735.8 54557.7 55771.7 56478.7 56564.7 57364.7 76596.6 79735.6 79933.0 80650.6 81191.2 20373.2 21192.4 21204.0 21372.5 21531.4 20450.4 23463.8 24132.5 24306.3 24367.9 18287.6 18472.7 18734.9 18799.0 19467.3 12869.6 13885.4 14170.6 16574.3 16885.2 19154.7 19246.2 19845.5 19847.6 19857.5 20891.0 21196.7 21234.5 21261.4 21272.7 18188.9 18463.6 18591.2 18720.7 19013.7 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#3] mootools.html Cycles:180 Average:8576.96 Median:2515.35 stddev:5865.11 (233.2%) stddev-sans-first:5856.39 10:15:43 INFO - PID 11194 | Values: 1344.7 1381.3 1385.8 1393.9 1401.5 13209.6 13796.9 13816.7 13855.6 13877.4 13808.8 14097.2 14579.9 14587.8 14594.0 2518.3 2547.5 2563.3 2564.6 2577.5 2562.3 2626.4 2628.1 2632.7 2637.2 2252.7 2558.5 2586.7 2594.4 2607.1 2232.8 2233.9 2240.6 2540.8 2624.2 2508.2 2512.4 2520.1 2530.1 2535.8 13387.4 13677.7 13683.6 13684.0 13707.7 7131.6 7369.1 7391.6 7400.7 7405.0 4773.5 4856.4 4964.6 4968.9 4997.3 1812.8 1816.0 1839.1 1882.4 1883.2 22423.8 22516.9 22660.4 22681.7 22750.0 6007.2 6044.3 6106.5 6131.2 6140.1 14694.7 14865.6 14927.8 14943.6 14964.5 7130.2 7261.7 7294.7 7298.8 7303.1 6715.7 6754.9 6782.9 6831.3 6925.1 4680.6 4742.6 4766.8 4853.9 4872.0 1362.2 1383.2 1385.2 1391.9 1392.7 875.9 886.2 892.1 893.6 899.1 8453.4 8721.6 8802.3 8871.4 8892.5 979.4 991.8 1006.1 1013.0 1018.4 5056.5 5178.9 5231.1 5248.3 5374.2 18946.2 19647.5 19770.6 19853.0 19860.1 19038.1 19134.3 19321.0 19531.6 19566.2 9915.5 10646.8 10664.6 10723.2 10854.9 7556.9 8236.0 8273.3 8418.4 8513.9 15617.8 15984.6 16125.4 16352.6 16432.6 16422.7 16449.6 17350.5 17387.7 17596.5 10902.6 11376.4 11469.4 11488.3 11516.8 12884.5 13186.6 13189.5 13190.4 13199.3 10137.7 10344.1 10379.4 10387.9 10445.8 9340.5 9982.0 10377.5 10377.6 10411.1 9124.5 9253.6 9339.0 9340.5 9359.3 6890.4 7072.9 7262.2 7303.4 7330.6 6929.2 7019.5 7280.9 7293.9 7300.1 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#4] prototype.html Cycles:180 Average:5368.18 Median:5935.35 stddev:1518.44 (25.6%) stddev-sans-first:1477.56 10:15:43 INFO - PID 11194 | Values: 471.7 488.9 497.9 501.5 508.5 5966.5 6022.6 6039.0 6078.0 6085.9 5769.7 5914.4 5931.9 5952.2 5956.9 4820.6 4830.7 4841.3 4865.7 4883.6 4845.4 4849.9 4863.8 4889.4 4900.8 4760.6 4818.0 4820.4 4834.2 4853.5 4599.5 4698.1 4767.5 4830.2 4843.4 4298.6 4312.8 4330.2 4336.9 4337.3 5762.4 5924.4 5938.8 5939.3 5978.2 5417.6 5466.5 5478.6 5511.0 5527.9 6336.2 6424.3 6430.2 6451.0 6473.0 4701.3 4712.2 4716.6 4742.6 4749.1 6672.6 6780.3 6818.9 6836.1 6840.0 4867.0 4872.2 4873.7 4898.7 4918.8 4869.9 4883.8 4916.3 4930.7 4932.2 5411.8 5423.0 5471.1 5502.8 5510.6 6388.0 6399.9 6406.3 6440.9 6503.7 1688.9 1713.8 1718.8 1723.5 1728.4 1091.4 1179.6 1180.3 1194.3 1205.1 5463.3 5557.8 5671.2 5699.2 5703.4 6449.5 6470.3 6486.7 6562.7 6595.6 5667.8 5670.3 5672.9 5686.0 5751.7 3398.8 3479.2 3480.7 3490.5 3534.5 6416.6 6421.8 6422.5 6428.0 6482.5 6671.2 6740.3 6804.6 6814.0 6815.0 6362.2 6405.4 6407.5 6413.8 6418.3 6480.4 6563.9 6584.4 6584.7 6620.4 6466.0 6475.5 6507.3 6514.4 6584.2 6316.9 6335.7 6360.4 6385.3 6431.0 4785.7 4820.9 4826.7 4829.1 4842.8 6495.6 6568.3 6582.6 6584.3 6629.2 6328.7 6342.0 6369.2 6385.1 6458.9 6325.0 6370.5 6391.6 6420.2 6427.2 6221.9 6285.9 6320.7 6331.8 6392.3 5821.0 6412.9 6417.9 6426.8 6454.9 6138.7 6190.7 6205.7 6210.6 6237.9 10:15:43 INFO - PID 11194 | 10:15:43 INFO - PID 11194 | [#5] yui.html Cycles:180 Average:22782.25 Median:19795.86 stddev:31032.66 (156.8%) stddev-sans-first:31076.24 10:15:43 INFO - PID 11194 | Values: 906.1 906.9 923.7 926.0 933.6 18714.5 19078.6 19188.6 19205.6 19252.6 19619.1 20472.1 20862.5 21008.7 21079.4 1015.1 1039.4 1043.8 1044.7 1047.3 1058.6 1059.3 1060.2 1060.4 1060.6 1058.3 1079.3 1097.2 1130.0 1131.4 1069.5 1071.3 1078.7 1079.1 1080.1 793.6 793.6 793.7 793.8 795.6 18293.6 18530.4 18957.0 19144.5 19262.6 19972.6 20411.2 20643.8 20672.7 20746.0 15292.0 15452.8 15594.5 15628.1 15690.7 3544.2 3546.9 3547.3 3575.2 3577.5 125338.0 125601.0 131616.3 131734.3 135620.3 15679.8 15846.2 15897.5 15990.4 16332.8 28880.4 29291.7 29466.1 29483.0 29635.4 7747.8 7761.9 7762.1 7773.0 7824.3 3924.3 4007.5 4011.7 4014.6 4017.4 4776.5 4834.9 4939.9 4959.9 5010.3 862.3 889.9 894.2 894.4 911.9 663.7 696.1 713.6 721.7 732.7 11228.5 11230.0 11679.3 12037.6 12106.0 560.3 584.4 592.8 622.9 676.6 5322.2 5368.2 5370.9 5408.3 5485.9 97105.5 99646.5 101658.5 102433.5 102659.5 93725.0 93855.2 94436.0 94835.5 97745.0 76644.6 80382.0 81738.2 82569.6 84555.0 11810.7 11969.6 12060.4 12307.5 12351.2 35653.5 35803.5 36126.3 36373.6 36579.6 42922.0 63319.4 65095.0 65950.0 66296.0 17854.6 18026.0 18704.0 18975.5 19147.6 19025.7 19175.8 19993.2 20633.8 20980.6 16222.6 16226.4 16797.7 17677.8 18157.6 17849.4 18081.8 18417.0 18997.0 19446.1 17355.8 17570.2 18728.2 18972.5 18974.5 12331.1 12421.7 12884.3 13943.2 14484.6 13282.0 13317.3 13520.3 13621.3 13869.9 10:15:43 INFO - PID 11194 | -------- Summary: end -------- 10:15:43 INFO - PID 11194 | 10:15:43 INFO - TEST-INFO | 11194: exit 0 10:15:43 INFO - TEST-OK | dromaeo_css | took 1111507ms 10:15:43 INFO - TEST-START | kraken 10:15:43 INFO - Initialising browser for kraken test... 10:15:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42498/getInfo.html -profile /tmp/tmptQ1TKD/profile 10:15:43 INFO - TEST-INFO | started process 11593 (/builds/slave/test/build/application/firefox/firefox http://localhost:42498/getInfo.html) 10:15:50 INFO - TEST-INFO | 11593: exit 0 10:15:50 INFO - Browser initialized. 10:15:50 INFO - Running cycle 1/1 for kraken test... 10:15:50 INFO - TEST-INFO | started process 11864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptQ1TKD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:01 INFO - PID 11864 | RSS: Main: 175575040 10:16:01 INFO - PID 11864 | 10:16:04 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42498/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:05 INFO - PID 11864 | RSS: Main: 179904512 10:16:05 INFO - PID 11864 | 10:16:07 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42498/tests/kraken/driver.html?testName=audio-dft) 10:16:08 INFO - PID 11864 | RSS: Main: 179867648 10:16:08 INFO - PID 11864 | 10:16:11 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42498/tests/kraken/driver.html?testName=audio-fft) 10:16:12 INFO - PID 11864 | RSS: Main: 174190592 10:16:12 INFO - PID 11864 | 10:16:14 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42498/tests/kraken/driver.html?testName=audio-oscillator) 10:16:14 INFO - PID 11864 | RSS: Main: 174891008 10:16:14 INFO - PID 11864 | 10:16:16 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:17 INFO - PID 11864 | RSS: Main: 175222784 10:16:17 INFO - PID 11864 | 10:16:20 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42498/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:21 INFO - PID 11864 | RSS: Main: 178884608 10:16:21 INFO - PID 11864 | 10:16:24 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42498/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:25 INFO - PID 11864 | RSS: Main: 180056064 10:16:25 INFO - PID 11864 | 10:16:27 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42498/tests/kraken/driver.html?testName=json-parse-financial) 10:16:28 INFO - PID 11864 | RSS: Main: 178495488 10:16:28 INFO - PID 11864 | 10:16:30 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:30 INFO - PID 11864 | RSS: Main: 178237440 10:16:30 INFO - PID 11864 | 10:16:32 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:33 INFO - PID 11864 | RSS: Main: 178278400 10:16:33 INFO - PID 11864 | 10:16:35 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:35 INFO - PID 11864 | RSS: Main: 178094080 10:16:35 INFO - PID 11864 | 10:16:38 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:39 INFO - PID 11864 | RSS: Main: 178356224 10:16:39 INFO - PID 11864 | 10:16:42 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:42 INFO - PID 11864 | RSS: Main: 178810880 10:16:42 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | Cycle 1(1): loaded http://localhost:42498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42498/tests/kraken/driver.html?testName=ai-astar) 10:16:44 INFO - PID 11864 | RSS: Main: 180580352 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | __start_tp_report 10:16:44 INFO - PID 11864 | _x_x_mozilla_page_load 10:16:44 INFO - PID 11864 | _x_x_mozilla_page_load_details 10:16:44 INFO - PID 11864 | |i|pagename|runs| 10:16:44 INFO - PID 11864 | |0;ai-astar;99;108;101;110;107;110;111;100;110;110 10:16:44 INFO - PID 11864 | |1;audio-beat-detection;145;120;147;187;117;143;154;119;170;119 10:16:44 INFO - PID 11864 | |2;audio-dft;163;161;162;163;163;171;170;169;173;162 10:16:44 INFO - PID 11864 | |3;audio-fft;75;74;78;168;74;75;78;76;94;74 10:16:44 INFO - PID 11864 | |4;audio-oscillator;81;80;138;81;80;81;144;80;80;130 10:16:44 INFO - PID 11864 | |5;imaging-gaussian-blur;114;113;114;114;113;114;113;113;113;114 10:16:44 INFO - PID 11864 | |6;imaging-darkroom;150;151;150;149;151;150;152;152;151;150 10:16:44 INFO - PID 11864 | |7;imaging-desaturate;94;94;94;94;94;94;95;94;94;93 10:16:44 INFO - PID 11864 | |8;json-parse-financial;55;56;61;56;56;59;63;57;56;62 10:16:44 INFO - PID 11864 | |9;json-stringify-tinderbox;54;55;55;55;54;54;54;54;54;55 10:16:44 INFO - PID 11864 | |10;stanford-crypto-aes;78;78;77;77;87;77;77;77;76;86 10:16:44 INFO - PID 11864 | |11;stanford-crypto-ccm;141;139;133;130;127;143;126;133;128;149 10:16:44 INFO - PID 11864 | |12;stanford-crypto-pbkdf2;192;187;179;177;176;174;183;178;179;177 10:16:44 INFO - PID 11864 | |13;stanford-crypto-sha256-iterative;69;68;73;68;69;77;70;66;68;72 10:16:44 INFO - PID 11864 | __end_tp_report 10:16:44 INFO - PID 11864 | __start_cc_report 10:16:44 INFO - PID 11864 | _x_x_mozilla_cycle_collect,981 10:16:44 INFO - PID 11864 | __end_cc_report 10:16:44 INFO - PID 11864 | __startTimestamp1500398204971__endTimestamp 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | ------- Summary: start ------- 10:16:44 INFO - PID 11864 | Number of tests: 14 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#0] ai-astar Cycles:10 Average:106.60 Median:110.00 stddev:4.72 (4.3%) stddev-sans-first:4.13 10:16:44 INFO - PID 11864 | Values: 99.0 108.0 101.0 110.0 107.0 110.0 111.0 100.0 110.0 110.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:146.00 stddev:23.93 (16.4%) stddev-sans-first:25.36 10:16:44 INFO - PID 11864 | Values: 145.0 120.0 147.0 187.0 117.0 143.0 154.0 119.0 170.0 119.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:4.50 (2.7%) stddev-sans-first:4.66 10:16:44 INFO - PID 11864 | Values: 163.0 161.0 162.0 163.0 163.0 171.0 170.0 169.0 173.0 162.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#3] audio-fft Cycles:10 Average:86.60 Median:75.50 stddev:29.22 (38.7%) stddev-sans-first:30.69 10:16:44 INFO - PID 11864 | Values: 75.0 74.0 78.0 168.0 74.0 75.0 78.0 76.0 94.0 74.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:80.00 stddev:27.69 (34.6%) stddev-sans-first:28.72 10:16:44 INFO - PID 11864 | Values: 81.0 80.0 138.0 81.0 80.0 81.0 144.0 80.0 80.0 130.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:16:44 INFO - PID 11864 | Values: 114.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 113.0 114.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 10:16:44 INFO - PID 11864 | Values: 150.0 151.0 150.0 149.0 151.0 150.0 152.0 152.0 151.0 150.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:16:44 INFO - PID 11864 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 93.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.92 (5.0%) stddev-sans-first:2.88 10:16:44 INFO - PID 11864 | Values: 55.0 56.0 61.0 56.0 56.0 59.0 63.0 57.0 56.0 62.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:16:44 INFO - PID 11864 | Values: 54.0 55.0 55.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:77.50 stddev:4.00 (5.2%) stddev-sans-first:4.23 10:16:44 INFO - PID 11864 | Values: 78.0 78.0 77.0 77.0 87.0 77.0 77.0 77.0 76.0 86.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:136.00 stddev:7.74 (5.7%) stddev-sans-first:7.89 10:16:44 INFO - PID 11864 | Values: 141.0 139.0 133.0 130.0 127.0 143.0 126.0 133.0 128.0 149.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:179.00 stddev:5.55 (3.1%) stddev-sans-first:3.92 10:16:44 INFO - PID 11864 | Values: 192.0 187.0 179.0 177.0 176.0 174.0 183.0 178.0 179.0 177.0 10:16:44 INFO - PID 11864 | 10:16:44 INFO - PID 11864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:3.20 (4.6%) stddev-sans-first:3.37 10:16:44 INFO - PID 11864 | Values: 69.0 68.0 73.0 68.0 69.0 77.0 70.0 66.0 68.0 72.0 10:16:44 INFO - PID 11864 | -------- Summary: end -------- 10:16:44 INFO - PID 11864 | 10:16:45 INFO - PID 11864 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:16:45 INFO - TEST-INFO | 11864: exit 0 10:16:45 INFO - TEST-OK | kraken | took 61725ms 10:16:45 INFO - SUITE-END | took 1173s 10:16:46 INFO - Completed test suite (00:19:33) 10:16:46 INFO - javascript benchmark 10:16:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8309.558160818466, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.10879844845, 3111.7977331473453, 3141.4816555268376, 3161.715445609896, 3174.3016536361993, 6101.237345331833, 6143.815685529441, 6159.3224745277985, 6188.257409110907, 6230.906536401958, 6190.195274614305, 6216.0, 6218.098375735515, 6237.656928868922, 6243.594166379182, 5654.293213348332, 5662.490375866181, 5682.772689092431, 5712.1431785232135, 5715.028445164332, 5675.659460432387, 5685.374608793029, 5687.232223649796, 5697.6011679182475, 5708.828735137952, 5706.657600543981, 5708.20085188074, 5717.256756621633, 5718.771249150029, 5725.856853578653, 5699.544036477072, 5706.686132262724, 5717.313922329306, 5728.16941543476, 5730.19777231188, 5632.070708333161, 5649.067903795869, 5672.829815105553, 5716.657000579979, 5752.568557358215, 6209.006558950547, 6221.502279817604, 6243.500519958392, 6294.181756371642, 6310.810675679737, 6621.86756264872, 6637.535372523926, 6702.765403210913, 6703.798886033427, 6729.865402691968, 6526.314736952599, 6542.4111829935055, 6565.606063636149, 6566.113574667406, 6578.407943285079, 6114.2357205349335, 6168.414000669929, 6192.0, 6197.597156184834, 6218.0, 6749.291324410964, 6851.931480685129, 6859.07402500656, 6943.097397338313, 6947.0, 6427.807165785034, 6476.838079047967, 6508.284088750233, 6519.250286217051, 6608.140941677647, 6469.482441404676, 6621.470282377399, 6687.4984376171005, 6690.899636505456, 6698.0, 6463.080455229941, 6482.157319548429, 6519.282878883319, 6549.967250163719, 6567.901481477782, 6611.0, 6650.3349665034075, 6673.866522669519, 6725.798226053226, 6748.662566871637, 5291.0, 5342.305500284938, 5391.865203369869, 5392.892142157135, 5408.756605952742, 4485.484169320504, 4581.839635612738, 4586.610138138229, 4600.3099535070005, 4604.148232576984, 5727.914081288784, 5744.310682718101, 5744.4829965303325, 5751.511121554715, 5758.539316854642, 6605.405513503808, 6606.8017959461295, 6611.371919667624, 6617.636030018395, 6635.535512514174, 5675.914861277084, 5730.312362516524, 5742.13867919807, 5755.0, 5768.134779783066, 5774.133879917962, 5777.508911742465, 5782.479576838105, 5790.0, 5803.564732645069, 6350.6189628621505, 6401.455876250478, 6453.419192272718, 6507.7071531781185, 6528.608283503005, 6697.765578204934, 6700.128983232344, 6792.150981127359, 6805.421539169028, 6806.829829254309, 6366.045093236052, 6393.520485963479, 6463.547551671338, 6471.06169605414, 6486.708098135501, 6501.772437964649, 6517.543771935919, 6563.409293163638, 6575.947848344242, 6577.769778057745, 6614.867702646016, 6627.3372662733345, 6639.3692599203, 6649.2685804562425, 6672.466202703869, 6391.712372943136, 6447.3552644735155, 6470.611763294218, 6505.251896032017, 6549.279579246184, 6404.487640988803, 6421.64680942534, 6499.610023398611, 6535.738570457129, 6556.803295901131, 6182.381761823962, 6333.6516491591565, 6377.840553986188, 6413.1021656969, 6424.93575064262, 6523.7716679915975, 6533.738650453929, 6538.607683539003, 6571.769988050395, 6594.0, 5990.101484777319, 6312.210973628296, 6318.273398559225, 6421.743130274924, 6432.549721519449], "value": 6057.458083564337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9273072692728, 743.1045590063974, 777.444127448874, 784.6782819044197, 804.919508049195, 38476.99999999996, 39615.80192099042, 39820.80089599548, 39893.0, 40041.79979100104, 37284.0, 37637.435438468376, 37670.0, 37678.81160594193, 37710.24579508408, 6636.4690824734025, 6719.596824190564, 6741.0, 6745.123133992599, 6750.324967503259, 6758.594484330932, 6777.118974533304, 6804.727810887559, 6839.076724642159, 6855.765962126815, 6724.327567243261, 6777.0, 6790.0, 6801.353871382235, 6828.863422731542, 6733.696983635724, 6742.123523941857, 6742.7640032598865, 6760.560563563377, 6774.085498457744, 6119.755209791603, 6147.293061297919, 6174.351693072253, 6205.100260462208, 6220.409061139185, 32706.836465817756, 32974.50538241928, 32995.83502082498, 33013.0, 33069.83465082683, 3354.7483938704695, 3410.9488357674654, 3442.1566716154703, 3512.4731290306404, 3607.603163651996, 29712.405751885057, 29739.405211895857, 29894.10317690451, 29972.85013574918, 29993.250168745737, 4811.4707382187935, 4840.975795121037, 4845.224764037773, 4848.29699693546, 4948.975255123737, 188582.0, 192625.0, 193274.0, 196852.0, 198018.0, 41203.0, 47228.29157562639, 47232.291515627294, 47595.0, 47606.5239347609, 49630.50369496331, 49811.25283120756, 49824.50175498271, 49860.50139498631, 50029.49970500321, 15600.921995390177, 15793.763093553605, 15832.68334633301, 15853.762193567105, 15857.603559911095, 12990.610281691565, 13009.739805203842, 13067.346632668328, 13074.673133171747, 13095.0, 14288.785668214985, 14345.713085738227, 14416.0, 14417.567472975827, 14513.274336283144, 5717.8570535736935, 5749.741261643236, 5871.442212989759, 5943.435373639497, 5946.0, 964.5225613321451, 981.4258658684606, 998.3560603410759, 1021.7598864266891, 1021.8569400283966, 21842.689438633734, 21965.0, 21983.23058692938, 22036.88981555114, 22506.774932250795, 1083.3608171178885, 1096.2326371539955, 1112.093643680398, 1120.1822669451346, 1120.4789772755707, 11362.829557556643, 11413.48639311233, 11823.408829558488, 11892.76214475723, 11974.88025119755, 228558.0, 230118.0, 230394.0, 231433.0, 231610.0, 49114.0, 49373.0, 49658.255126173135, 49736.751316243186, 49798.0, 1453.636590852308, 1490.2027415332745, 1490.5230326295482, 1495.2150121186464, 1498.1685164733678, 21543.67943238864, 21760.782392175875, 22275.0, 22281.331560053226, 22703.091876325423, 35334.29331413306, 35363.646363536034, 35445.46831797474, 35464.64535354613, 35740.4638930411, 189874.0506297515, 190941.0, 193117.0, 194536.0, 195051.0, 29970.100896973127, 30036.24909377283, 30071.849640751658, 31633.5254971171, 32347.514787277738, 40033.0, 41986.160276793686, 42053.0, 42081.57918420777, 42470.0, 28569.62332928311, 30617.387652246383, 30960.225994350323, 31271.84364078165, 32944.01167964965, 31751.72993080251, 33070.66929330676, 33105.50341744828, 33214.66785332116, 33316.50025249672, 34849.65150348464, 36673.81663091668, 36753.816230918674, 36769.816150919076, 37043.814780925924, 31071.0, 31476.37047259088, 31673.524897127023, 31783.52324715085, 31886.52170217402, 22636.320910372717, 23597.646035309826, 23973.04107835667, 24020.39949001289, 24150.03399864056], "value": 16356.218515092733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9273394458722, 563.3633993587247, 568.7810193075665, 573.1774903014177, 590.3358721438381, 21143.471413214676, 21784.564308713838, 21874.343769686915, 21939.561208775816, 22448.326550203477, 26059.739402605966, 26326.47347053058, 26578.33554161147, 26595.202143935665, 26738.5989210162, 6212.813615591528, 6292.244930608334, 6378.4578310843635, 6379.649119298437, 6386.712597933104, 6164.07538869171, 6333.113364129025, 6399.232092148949, 6399.648019358933, 6428.164338635994, 5986.970065149668, 6226.377362263783, 6255.749770009217, 6267.091271765591, 6280.780172693957, 6269.968650156766, 6271.529635277349, 6277.591956522857, 6286.057091436275, 6291.748330066815, 5841.153032810219, 5870.765169393219, 5871.148683440877, 5884.941150588482, 5903.734331955029, 27487.45025099487, 27638.86180569084, 27952.440951180863, 28409.0, 28458.146255612366, 1955.1885967323544, 1967.3802752133176, 1985.5731017831235, 1985.7517810273716, 1986.920523179071, 17928.282868685237, 18597.0, 18600.34898778536, 18652.25390984359, 18701.62596748071, 2252.4368907773055, 2274.2494976657663, 2319.1651005637955, 2322.7328857181474, 2326.2904814031713, 131516.0, 140072.0, 140083.0, 140379.99999999898, 140408.0, 13723.519676811464, 14501.564953051426, 14603.123812571068, 14682.339294731762, 14724.337404816595, 22914.541709165722, 22930.770692292863, 23040.65439018416, 23134.305970820904, 23162.768372316397, 9716.765144016774, 9724.659636912675, 9790.314677972474, 9820.214382849355, 9855.979524197523, 8785.692500762443, 8813.42712723671, 8857.64569417216, 8908.777280568038, 8937.285017198608, 8685.261752750961, 8818.470891746516, 9029.593668284942, 9173.44959302444, 9189.540522973824, 2496.463260399023, 2520.798336133105, 2559.2066459397647, 2589.52093862636, 2620.4235068284947, 926.2358554192817, 932.4778124250441, 952.4904176265665, 954.0, 975.5219942228257, 19234.903825480782, 19615.607687846164, 19654.606907861762, 20151.294704685264, 20283.0, 979.0943377375899, 1009.399407352624, 1013.6654903881702, 1032.3135115148343, 1034.9586016559404, 10560.313579617301, 10874.0, 10973.177011723992, 10977.945110274557, 11045.171612129123, 529539.0, 548795.0, 554057.0, 556727.0, 588606.0, 112316.0, 116190.0, 117966.0, 118141.40929295299, 126703.0, 1264.4183675509184, 1266.993665031669, 1279.635303938373, 1321.8876395506297, 1324.3312127375614, 18709.625807484048, 21293.89353053225, 21409.357719268446, 21492.46268843229, 21735.78264217401, 54557.72721136369, 55771.72114139403, 56478.71760641171, 56564.717176413855, 57364.71317643385, 76596.61701691456, 79735.60132199302, 79933.0, 80650.5967470159, 81191.18808812073, 20373.18507259693, 21192.36422907315, 21204.0, 21372.465688357915, 21531.354059378245, 20450.386488405373, 23463.76536234616, 24132.51734965326, 24306.27081187567, 24367.878160609085, 18287.634247314712, 18472.722909156106, 18734.906325468284, 18799.0, 19467.27458155831, 12869.613911582668, 13885.444582216598, 14170.57488275312, 16574.254158562653, 16885.155742213086, 19154.71267930954, 19246.23015079381, 19845.503862403555, 19847.60304793925, 19857.503562411057, 20891.0, 21196.68204976896, 21234.469138271048, 21261.36215913525, 21272.680909786057, 18188.90905545464, 18463.61522885762, 18591.16339764687, 18720.7191892119, 19013.714794278374], "value": 12161.552207453586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.6571124363288, 1381.2817334985807, 1385.8059871617975, 1393.9233342166176, 1401.5444980381376, 13209.603711888634, 13796.93101534491, 13816.723665526684, 13855.584332470016, 13877.444902203912, 13808.79286810696, 14097.224652644101, 14579.92710036451, 14587.781183282259, 14594.0, 2518.3452302401324, 2547.503236868811, 2563.282280961334, 2564.61530770385, 2577.523158215736, 2562.2569454858067, 2626.3696712788887, 2628.067036202149, 2632.670916135483, 2637.2483842105003, 2252.695886055386, 2558.5266725655815, 2586.702529209146, 2594.3514121469634, 2607.1005503101496, 2232.754397016327, 2233.8883055847223, 2240.574290884727, 2540.809439292042, 2624.160268714012, 2508.209913877141, 2512.359348366173, 2520.1053625962886, 2530.101813856073, 2535.8351707138977, 13387.397567109503, 13677.726445471135, 13683.589492315246, 13684.0, 13707.725845483035, 7131.607761573111, 7369.115706115247, 7391.630418479054, 7400.740974065936, 7404.9629751851435, 4773.4510531289, 4856.441509226449, 4964.627652926045, 4968.87577810554, 4997.275395067695, 1812.7915289741716, 1815.9921243709737, 1839.0988415676222, 1882.425860112665, 1883.2467013194832, 22423.77576224233, 22516.887415562982, 22660.433489162737, 22681.659775103388, 22750.0, 6007.15899774032, 6044.335123136451, 6106.511479081662, 6131.202943617391, 6140.140380346755, 14694.706105878036, 14865.554033379016, 14927.776083358758, 14943.551693448997, 14964.476243331432, 7130.180029296697, 7261.7095316187815, 7294.70821167158, 7298.817529561803, 7303.050603421521, 6715.664216789141, 6754.93245067543, 6782.898256526156, 6831.28271531482, 6925.065116209348, 4680.602148817388, 4742.57316841479, 4766.809327626856, 4853.9029219416125, 4872.049950259665, 1362.1894972491352, 1383.197745307719, 1385.231196685829, 1391.8886489080849, 1392.749305125067, 875.9255463285692, 886.1935638569, 892.0633334998225, 893.647009431284, 899.0559912092408, 8453.408261421642, 8721.563921803885, 8802.339824513187, 8871.379003469825, 8892.466452012899, 979.3683074416961, 991.7850632974548, 1006.1447769395954, 1012.9949350253202, 1018.3940555369543, 5056.494350564914, 5178.948210517847, 5231.058409486329, 5248.317718696545, 5374.247605335257, 18946.242150313832, 19647.50881227952, 19770.60458790816, 19853.0, 19860.10629521675, 19038.143283552272, 19134.330298439487, 19321.0, 19531.609367812565, 19566.21735130579, 9915.454649994175, 10646.787064258671, 10664.626738064131, 10723.249372544004, 10854.945725271482, 7556.858768463969, 8236.0, 8273.33813294947, 8418.410711250153, 8513.87229191575, 15617.843821561639, 15984.561389475002, 16125.435609754071, 16352.591185220464, 16432.589185270463, 16422.67154656924, 16449.588760281087, 17350.47948561545, 17387.652246955244, 17596.472105836845, 10902.56389744433, 11376.431178441211, 11469.369184694922, 11488.310701357945, 11516.827247591125, 12884.48462061507, 13186.604401867959, 13189.538366157138, 13190.406431710788, 13199.274039927896, 10137.68210132678, 10344.069033786995, 10379.429131397543, 10387.896121038693, 10445.791084178121, 9340.53297335144, 9982.0, 10377.481125943823, 10377.636782712569, 10411.11505522039, 9124.49815260167, 9253.58358873839, 9338.95330523343, 9340.486273255035, 9359.298052646214, 6890.414314783299, 7072.929270707227, 7262.164851042197, 7303.415726741741, 7330.633468326669, 6929.203141638776, 7019.508634395544, 7280.854382912418, 7293.890591641023, 7300.05099337104], "value": 6251.7178420402315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.70989841247643, 488.86067470770837, 497.9402471703396, 501.4559203264458, 508.4686502604778, 5966.492848107905, 6022.608530445518, 6038.991203752262, 6078.0, 6085.908711369328, 5769.682667453289, 5914.4085591440835, 5931.902598019369, 5952.166696662471, 5956.927753004457, 4820.566149046585, 4830.657131291321, 4841.298011788306, 4865.732384718839, 4883.6337274704365, 4845.418549774032, 4849.927251091236, 4863.781129849148, 4889.413270407538, 4900.754962251891, 4760.571548560629, 4817.988757026858, 4820.445648750404, 4834.2265237562, 4853.538913803183, 4599.471060828014, 4698.08387364464, 4767.499412561666, 4830.178869592178, 4843.370361852972, 4298.570142985708, 4312.82748690052, 4330.17726631939, 4336.934945975813, 4337.3084497046175, 5762.415335782652, 5924.407559244084, 5938.792142275043, 5939.316978547436, 5978.163057172, 5417.647852889589, 5466.453354664542, 5478.561715062785, 5510.972445137789, 5527.944720552783, 6336.2396512418345, 6424.3254458282145, 6430.164078669743, 6451.0, 6472.967635161841, 4701.341812146302, 4712.2224832902875, 4716.608600462838, 4742.585338556234, 4749.100359856051, 6672.566283191577, 6780.288069752703, 6818.863622727567, 6836.077129587541, 6839.965800171017, 4866.975665121652, 4872.19608764557, 4873.658843880894, 4898.706077635282, 4918.835712286583, 4869.878253043702, 4883.8290659826735, 4916.287138364917, 4930.728809915489, 4932.21084626458, 5411.781169720396, 5422.972885135549, 5471.124620060771, 5502.80740174092, 5510.586705997066, 6387.968060159669, 6399.9040014399825, 6406.263279722798, 6440.9438590707005, 6503.674816259168, 1688.9155542223086, 1713.8029126650595, 1718.7937447506379, 1723.5174151237673, 1728.395061728385, 1091.3560999010463, 1179.5930404010603, 1180.3036208636945, 1194.295365734221, 1205.108219917255, 5463.262459567987, 5557.77768889248, 5671.2060311556415, 5699.202111704365, 5703.40114288002, 6449.548531602836, 6470.255920569195, 6486.6756662167645, 6562.737490500422, 6595.571287866273, 5667.773289068391, 5670.291213598301, 5672.858178545487, 5685.971570142206, 5751.712414379264, 3398.7790793598833, 3479.199784049632, 3480.686738193575, 3490.511328414024, 3534.5228394166456, 6416.550841441148, 6421.839454013593, 6422.518311126591, 6427.967860160763, 6482.546221764525, 6671.166104236971, 6740.258571557125, 6804.625745583941, 6813.965930170417, 6815.0, 6362.236531616236, 6405.35946405365, 6407.487401007908, 6413.807585772341, 6418.267067891737, 6480.351964803482, 6563.868722625616, 6584.407403333723, 6584.7036883341325, 6620.3710647488415, 6466.0, 6475.546711730133, 6507.251666058464, 6514.413702766584, 6584.242812076673, 6316.936830631818, 6335.746570137143, 6360.427561519486, 6385.265694445198, 6430.974243113405, 4785.736784476887, 4820.8794780130775, 4826.686265392738, 4829.140780799487, 4842.806287748451, 6495.610263384212, 6568.27748947625, 6582.605043697394, 6584.275729669828, 6629.237637671729, 6328.683565821599, 6341.968290158519, 6369.20384951881, 6385.10608514799, 6458.934275844433, 6324.988001919671, 6370.458511026429, 6391.584547004616, 6420.165378500765, 6427.196600424947, 6221.9377806223165, 6285.937140628535, 6320.715567799368, 6331.841703957438, 6392.264889537762, 5821.0, 6412.903806443001, 6417.93582064192, 6426.775062872777, 6454.903176452451, 6138.693065346804, 6190.721417536131, 6205.689715514116, 6210.596311239755, 6237.906431403623], "value": 4919.490109855774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.1120102299747, 906.9183773460387, 923.6536298887917, 925.9629614815408, 933.5798890499273, 18714.53213669659, 19078.618427631438, 19188.616227675455, 19205.615887682237, 19252.614947701037, 19619.11713972871, 20472.078756455958, 20862.478438039056, 21008.684869726967, 21079.367618971417, 1015.1219195395985, 1039.3504059962524, 1043.7964596903607, 1044.6552637629602, 1047.261680515235, 1058.5977328615115, 1059.311447559085, 1060.2472244706269, 1060.42736922062, 1060.6340812419703, 1058.3226734889677, 1079.3416016230094, 1097.2209731090934, 1130.0451118804638, 1131.4003578103618, 1069.470612047034, 1071.3304184884448, 1078.7195329214383, 1079.104343394988, 1080.1304949515636, 793.5992323876405, 793.6388943030908, 793.6745934166964, 793.8174219929449, 795.6220795122271, 18293.634127317513, 18530.351437699617, 18957.0, 19144.521386965298, 19262.61474770511, 19972.600547989103, 20411.183552658025, 20643.793562064486, 20672.689909651366, 20746.0, 15292.0, 15452.845471545366, 15594.454194103151, 15628.14045227512, 15690.68618627621, 3544.220271540257, 3546.85812567497, 3547.343741407822, 3575.213453040327, 3577.5349204603235, 125338.0, 125601.0, 131616.3419182898, 131734.34132829274, 135620.32189838987, 15679.843201568066, 15846.207689615703, 15897.52307430779, 15990.360385584447, 16332.83667163337, 28880.422391552052, 29291.707082929322, 29466.11601651954, 29483.0, 29635.40729185404, 7747.767566973, 7761.922380776233, 7762.107357653942, 7772.961135194401, 7824.256695613907, 3924.2543916655745, 4007.539132999684, 4011.6991225658194, 4014.6186112319283, 4017.397390391465, 4776.47458779534, 4834.927476087862, 4939.925901111486, 4959.90080198394, 5010.348654674869, 862.288611895189, 889.8709687095464, 894.2086253665553, 894.4096896048577, 911.9270458363314, 663.731188868509, 696.1055044268091, 713.6289129652655, 721.7473884140509, 732.7179036071151, 11228.494717737722, 11230.0, 11679.306500557372, 12037.578684745991, 12106.0, 560.3248086056292, 584.360125662399, 592.7717828636006, 622.8816524860262, 676.6244734172483, 5322.175062865262, 5368.248445217672, 5370.91943620846, 5408.269883565668, 5485.890282194334, 97105.5144724286, 99646.50176749215, 101658.49170754099, 102433.48783256185, 102659.486702566, 93725.0, 93855.2499077738, 94436.0, 94835.52582237183, 97745.0, 76644.61677691687, 80382.0, 81738.18261817425, 82569.58715206505, 84555.0, 11810.704732381759, 11969.581064662694, 12060.371849800516, 12307.507699691912, 12351.19717218378, 35653.48969169665, 35803.46294805632, 36126.277474450886, 36373.636263637025, 36579.634203657624, 42922.0, 63319.366806331345, 65095.0, 65950.0, 66296.0, 17854.5536361592, 18026.008569528276, 18704.0, 18975.525611859815, 19147.61704765869, 19025.714614281074, 19175.80824191796, 19993.200271988957, 20633.793662063188, 20980.638471814727, 16222.594435139215, 16226.350945962502, 16797.66404671924, 17677.823221768132, 18157.636847263246, 17849.37527186542, 18081.819181808012, 18417.02893119483, 18997.0, 19446.124924378153, 17355.826441735422, 17570.20934057996, 18728.157232924277, 18972.525686857938, 18974.525636859187, 12331.136820422484, 12421.689457763629, 12884.291363974697, 13943.233122178377, 14484.565463036126, 13282.0, 13317.267550284827, 13520.256385898476, 13621.318934053455, 13869.861301386856], "value": 8882.982295699308, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 101.0, 110.0, 107.0, 110.0, 111.0, 100.0, 110.0, 110.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 147.0, 187.0, 117.0, 143.0, 154.0, 119.0, 170.0, 119.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 163.0, 171.0, 170.0, 169.0, 173.0, 162.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 168.0, 74.0, 75.0, 78.0, 76.0, 94.0, 74.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 138.0, 81.0, 80.0, 81.0, 144.0, 80.0, 80.0, 130.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 149.0, 151.0, 150.0, 152.0, 152.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 61.0, 56.0, 56.0, 59.0, 63.0, 57.0, 56.0, 62.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 77.0, 87.0, 77.0, 77.0, 77.0, 76.0, 86.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 133.0, 130.0, 127.0, 143.0, 126.0, 133.0, 128.0, 149.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 187.0, 179.0, 177.0, 176.0, 174.0, 183.0, 178.0, 179.0, 177.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 68.0, 69.0, 77.0, 70.0, 66.0, 68.0, 72.0], "value": 70.0, "unit": "score"}]}]} 10:16:46 INFO - Return code: 0 10:16:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:46 INFO - # TBPL SUCCESS # 10:16:46 INFO - Running post-action listener: _package_coverage_data 10:16:46 INFO - Running post-action listener: _resource_record_post_action 10:16:46 INFO - [mozharness: 2017-07-18 17:16:46.256359Z] Finished run-tests step (success) 10:16:46 INFO - Running post-run listener: _resource_record_post_run 10:16:46 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436129792; Read time: 8; Write time: 379448 10:16:46 INFO - TinderboxPrint: CPU usage
13.1% 10:16:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:16:46 INFO - TinderboxPrint: I/O write bytes / time
436,129,792 / 379,448 10:16:46 INFO - TinderboxPrint: CPU idle
8,257.0 (86.8%) 10:16:46 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 10:16:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:16:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107421696; Read time: 0; Write time: 86636 10:16:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:16:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 328708096; Read time: 0; Write time: 292812 10:16:46 INFO - Running post-run listener: _upload_blobber_files 10:16:46 INFO - Blob upload gear active. 10:16:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:46 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 10:16:46 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'] 10:16:46 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 10:16:47 INFO - Traceback (most recent call last): 10:16:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 10:16:47 INFO - main() 10:16:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 10:16:47 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 10:16:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 10:16:47 INFO - return set(response.json().get('whitelist', [])) 10:16:47 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 10:16:47 INFO - return json.loads(self.text or self.content, **kwargs) 10:16:47 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 10:16:47 INFO - return _default_decoder.decode(s) 10:16:47 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 10:16:47 INFO - obj, end = self.raw_decode(s) 10:16:47 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 10:16:47 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 10:16:47 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 10:16:47 ERROR - Return code: 1 10:16:47 INFO - Setting buildbot property blobber_files to {} 10:16:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:47 INFO - Contents: 10:16:47 INFO - blobber_files:{} 10:16:47 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:47 INFO - Copying logs to upload dir... 10:16:47 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.948421 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-18 10:16:47.252926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 10:16:47.260243) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/GnlYt2-cQ-yMT4Kww2hNLw/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 10:16:47.312164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 10:16:47.312494) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500392493.954658-1718285045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 10:16:47.361751) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 10:16:47.365131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 10:16:47.365491) ========= ========= Total master_lag: 0.18 =========