builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1500197850.64 results: success (0) revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.640104) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.644103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.644465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.660975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.661283) ========= 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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 02:37:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 44.5M=0s 2017-07-16 02:37:33 (44.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.762762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.763544) ========= 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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020258 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:30.816194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 02:37:30.816552) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4e656e5a996dd385e9af43a4d9e207553377c51 --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 b4e656e5a996dd385e9af43a4d9e207553377c51 --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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 02:37:33,181 truncating revision to first 12 chars 2017-07-16 02:37:33,181 Setting DEBUG logging. 2017-07-16 02:37:33,181 attempt 1/10 2017-07-16 02:37:33,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4e656e5a996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 02:37:34,348 unpacking tar archive at: mozilla-central-b4e656e5a996/testing/mozharness/ program finished with exit code 0 elapsedTime=1.469872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 02:37:32.304351) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:32.305132) ========= script_repo_revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:32.306124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:32.306883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:32.316952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-16 02:37:32.317452) ========= /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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:34 INFO - MultiFileLogger online at 20170716 02:37:34 in /builds/slave/test 02:37:34 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 02:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:34 INFO - {'append_to_log': False, 02:37:34 INFO - 'base_work_dir': '/builds/slave/test', 02:37:34 INFO - 'blob_upload_branch': 'Firefox', 02:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:34 INFO - 'branch': 'Firefox', 02:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:34 INFO - 'code_coverage': False, 02:37:34 INFO - 'config_files': ('talos/linux_config.py',), 02:37:34 INFO - 'default_actions': ('clobber', 02:37:34 INFO - 'read-buildbot-config', 02:37:34 INFO - 'download-and-extract', 02:37:34 INFO - 'populate-webroot', 02:37:34 INFO - 'create-virtualenv', 02:37:34 INFO - 'install', 02:37:34 INFO - 'setup-mitmproxy', 02:37:34 INFO - 'run-tests'), 02:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:34 INFO - 'disable_ccov_upload': False, 02:37:34 INFO - 'download_minidump_stackwalk': True, 02:37:34 INFO - 'download_symbols': 'ondemand', 02:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:34 INFO - 'gecko_profile': False, 02:37:34 INFO - 'gecko_profile_interval': 0, 02:37:34 INFO - 'installer_path': 'installer.exe', 02:37:34 INFO - 'log_level': 'info', 02:37:34 INFO - 'log_name': 'talos', 02:37:34 INFO - 'log_to_console': True, 02:37:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:34 INFO - 'opt_config_files': (), 02:37:34 INFO - 'pip_index': False, 02:37:34 INFO - 'suite': 'dromaeojs-e10s', 02:37:34 INFO - 'system_bits': '32', 02:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:34 INFO - 'title': 'talos-linux64-ix-035', 02:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:34 INFO - 'use_talos_json': True, 02:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:34 INFO - 'work_dir': 'build'} 02:37:34 INFO - [mozharness: 2017-07-16 09:37:34.790609Z] Running clobber step. 02:37:34 INFO - Running pre-action listener: _resource_record_pre_action 02:37:34 INFO - Running main action method: clobber 02:37:34 INFO - rmtree: /builds/slave/test/build 02:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:35 INFO - Running post-action listener: _resource_record_post_action 02:37:35 INFO - [mozharness: 2017-07-16 09:37:35.833743Z] Finished clobber step (success) 02:37:35 INFO - [mozharness: 2017-07-16 09:37:35.833846Z] Running read-buildbot-config step. 02:37:35 INFO - Running pre-action listener: _resource_record_pre_action 02:37:35 INFO - Running main action method: read_buildbot_config 02:37:35 INFO - Using buildbot properties: 02:37:35 INFO - { 02:37:35 INFO - "project": "", 02:37:35 INFO - "product": "firefox", 02:37:35 INFO - "who": "archaeopteryx@coole-files.de", 02:37:35 INFO - "installer_path": "public/build/target.tar.bz2", 02:37:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:37:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:37:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:37:35 INFO - "stage_platform": "linux64-stylosequential", 02:37:35 INFO - "basedir": "/builds/slave/test", 02:37:35 INFO - "buildnumber": 123, 02:37:35 INFO - "platform": "ubuntu64_hw_styloseq", 02:37:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:37:35 INFO - "slavebuilddir": "test", 02:37:35 INFO - "taskId": "SQgHWxiYTSC-0bOjaTIEXQ", 02:37:35 INFO - "branch": "mozilla-central", 02:37:35 INFO - "script_repo_revision": "production", 02:37:35 INFO - "revision": "b4e656e5a996dd385e9af43a4d9e207553377c51", 02:37:35 INFO - "slavename": "talos-linux64-ix-035", 02:37:35 INFO - "repo_path": "mozilla-central" 02:37:35 INFO - } 02:37:35 INFO - Finding installer, test and symbols from parent task. 02:37:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQgHWxiYTSC-0bOjaTIEXQ'}, attempt #1 02:37:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQgHWxiYTSC-0bOjaTIEXQ'}, attempt #1 02:37:36 INFO - Task dependencies: WJ_icmeDTNmefs5D-71J0w 02:37:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w'}, attempt #1 02:37:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:37:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/test_packages.json 02:37:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip 02:37:37 INFO - Running post-action listener: _resource_record_post_action 02:37:37 INFO - [mozharness: 2017-07-16 09:37:37.193537Z] Finished read-buildbot-config step (success) 02:37:37 INFO - [mozharness: 2017-07-16 09:37:37.193760Z] Running download-and-extract step. 02:37:37 INFO - Running pre-action listener: _resource_record_pre_action 02:37:37 INFO - Running main action method: download_and_extract 02:37:37 INFO - mkdir: /builds/slave/test/build/tests 02:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:37 INFO - trying https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json 02:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:37:37 INFO - Downloaded 989 bytes. 02:37:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:37:37 INFO - Using the following test package requirements: 02:37:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:37:37 INFO - u'common': [u'target.common.tests.zip'], 02:37:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:37:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:37:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:37:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:37:37 INFO - u'mozbase': [u'target.common.tests.zip'], 02:37:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:37:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:37:37 INFO - u'web-platform': [u'target.common.tests.zip', 02:37:37 INFO - u'target.web-platform.tests.tar.gz'], 02:37:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:37:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip 02:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip into memory 02:37:38 INFO - Content-Length response header: 72753054 02:37:38 INFO - Bytes received: 72753054 02:37:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:37:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip 02:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip into memory 02:37:51 INFO - Content-Length response header: 72753054 02:37:51 INFO - Bytes received: 72753054 02:38:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip 02:38:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:38:03 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip into memory 02:38:04 INFO - Content-Length response header: 14495033 02:38:04 INFO - Bytes received: 14495033 02:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:04 INFO - trying https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:38:04 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:38:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:38:05 INFO - Downloaded 61896492 bytes. 02:38:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:38:05 INFO - mkdir: /builds/slave/test/properties 02:38:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:05 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:05 INFO - Contents: 02:38:05 INFO - build_url:https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:38:05 INFO - Running post-action listener: _resource_record_post_action 02:38:05 INFO - Running post-action listener: set_extra_try_arguments 02:38:05 INFO - [mozharness: 2017-07-16 09:38:05.579003Z] Finished download-and-extract step (success) 02:38:05 INFO - [mozharness: 2017-07-16 09:38:05.579100Z] Running populate-webroot step. 02:38:05 INFO - Running pre-action listener: _resource_record_pre_action 02:38:05 INFO - Running main action method: populate_webroot 02:38:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:05 INFO - '--tppagecycles', 02:38:05 INFO - '7'], 02:38:05 INFO - 'tests': ['tsvgm']}}, 02:38:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['damp', 'tps']}, 02:38:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'tests': ['damp', 'tps']}, 02:38:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['dromaeo_dom']}, 02:38:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:38:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:38:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:38:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_many_windows', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_many_windows', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_many_windows', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['a11yr', 02:38:05 INFO - 'ts_paint', 02:38:05 INFO - 'tpaint', 02:38:05 INFO - 'sessionrestore', 02:38:05 INFO - 'sessionrestore_no_auto_restore', 02:38:05 INFO - 'tabpaint']}, 02:38:05 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 02:38:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:38:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:38:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:38:05 INFO - 'talos_options': ['--mitmproxy', 02:38:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:38:05 INFO - '--firstNonBlankPaint'], 02:38:05 INFO - 'tests': ['quantum_pageload_google', 02:38:05 INFO - 'quantum_pageload_youtube', 02:38:05 INFO - 'quantum_pageload_amazon', 02:38:05 INFO - 'quantum_pageload_facebook']}, 02:38:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['tsvgx', 02:38:05 INFO - 'tsvgr_opacity', 02:38:05 INFO - 'tart', 02:38:05 INFO - 'tscrollx', 02:38:05 INFO - 'cart', 02:38:05 INFO - 'tsvg_static']}, 02:38:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:05 INFO - 'tsvgr_opacity', 02:38:05 INFO - 'tart', 02:38:05 INFO - 'tscrollx', 02:38:05 INFO - 'cart', 02:38:05 INFO - 'tsvg_static']}, 02:38:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'talos_options': ['--disable-e10s'], 02:38:05 INFO - 'tests': ['tp5o']}, 02:38:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:38:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'talos_options': ['--disable-e10s', 02:38:05 INFO - '--xperf_path', 02:38:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:05 INFO - 'tests': ['tp5n']}, 02:38:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:38:05 INFO - 'talos_options': ['--xperf_path', 02:38:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:05 INFO - 'tests': ['tp5n']}}, 02:38:05 INFO - 'talos.zip': {'path': '', 02:38:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:05 INFO - Running post-action listener: _resource_record_post_action 02:38:05 INFO - [mozharness: 2017-07-16 09:38:05.594570Z] Finished populate-webroot step (success) 02:38:05 INFO - [mozharness: 2017-07-16 09:38:05.594661Z] Running create-virtualenv step. 02:38:05 INFO - Running pre-action listener: _resource_record_pre_action 02:38:05 INFO - Running main action method: create_virtualenv 02:38:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:38:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:38:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:05 INFO - Using real prefix '/usr' 02:38:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:06 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:08 INFO - Installing pip.................done. 02:38:08 INFO - Return code: 0 02:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:38:08 INFO - Reading from file tmpfile_stdout 02:38:08 INFO - Output received: 02:38:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:38:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:38:08 INFO - Using env: {'DISPLAY': ':0', 02:38:08 INFO - 'HOME': '/home/cltbld', 02:38:08 INFO - 'LANG': 'en_US.UTF-8', 02:38:08 INFO - 'LANGUAGE': 'en_US:en', 02:38:08 INFO - 'LOGNAME': 'cltbld', 02:38:08 INFO - 'MAIL': '/var/mail/cltbld', 02:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:08 INFO - 'MOZ_NO_REMOTE': '1', 02:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:08 INFO - 'NO_EM_RESTART': '1', 02:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:08 INFO - 'PWD': '/builds/slave/test', 02:38:08 INFO - 'SHELL': '/bin/bash', 02:38:08 INFO - 'SHLVL': '1', 02:38:08 INFO - 'TERM': 'linux', 02:38:08 INFO - 'TMOUT': '86400', 02:38:08 INFO - 'USER': 'cltbld', 02:38:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:08 INFO - '_': '/tools/buildbot/bin/python'} 02:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:38:08 INFO - Cleaning up... 02:38:08 INFO - Return code: 0 02:38:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:38:08 INFO - Using env: {'DISPLAY': ':0', 02:38:08 INFO - 'HOME': '/home/cltbld', 02:38:08 INFO - 'LANG': 'en_US.UTF-8', 02:38:08 INFO - 'LANGUAGE': 'en_US:en', 02:38:08 INFO - 'LOGNAME': 'cltbld', 02:38:08 INFO - 'MAIL': '/var/mail/cltbld', 02:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:08 INFO - 'MOZ_NO_REMOTE': '1', 02:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:08 INFO - 'NO_EM_RESTART': '1', 02:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:08 INFO - 'PWD': '/builds/slave/test', 02:38:08 INFO - 'SHELL': '/bin/bash', 02:38:08 INFO - 'SHLVL': '1', 02:38:08 INFO - 'TERM': 'linux', 02:38:08 INFO - 'TMOUT': '86400', 02:38:08 INFO - 'USER': 'cltbld', 02:38:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:08 INFO - '_': '/tools/buildbot/bin/python'} 02:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:08 INFO - Downloading/unpacking psutil>=3.1.1 02:38:08 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 02:38:08 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 02:38:08 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 02:38:08 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 02:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:10 INFO - Installing collected packages: psutil 02:38:10 INFO - Running setup.py install for psutil 02:38:10 INFO - building 'psutil._psutil_linux' extension 02:38:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:38:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:38:10 INFO - building 'psutil._psutil_posix' extension 02:38:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:38:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:38:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:10 INFO - Successfully installed psutil 02:38:10 INFO - Cleaning up... 02:38:10 INFO - Return code: 0 02:38:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:38:10 INFO - Using env: {'DISPLAY': ':0', 02:38:10 INFO - 'HOME': '/home/cltbld', 02:38:10 INFO - 'LANG': 'en_US.UTF-8', 02:38:10 INFO - 'LANGUAGE': 'en_US:en', 02:38:10 INFO - 'LOGNAME': 'cltbld', 02:38:10 INFO - 'MAIL': '/var/mail/cltbld', 02:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:10 INFO - 'MOZ_NO_REMOTE': '1', 02:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:10 INFO - 'NO_EM_RESTART': '1', 02:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:10 INFO - 'PWD': '/builds/slave/test', 02:38:10 INFO - 'SHELL': '/bin/bash', 02:38:10 INFO - 'SHLVL': '1', 02:38:10 INFO - 'TERM': 'linux', 02:38:10 INFO - 'TMOUT': '86400', 02:38:10 INFO - 'USER': 'cltbld', 02:38:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:10 INFO - '_': '/tools/buildbot/bin/python'} 02:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:38:10 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 02:38:10 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 02:38:10 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 02:38:10 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 02:38:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:38:11 INFO - Installing collected packages: mozsystemmonitor 02:38:11 INFO - Running setup.py install for mozsystemmonitor 02:38:11 INFO - Successfully installed mozsystemmonitor 02:38:11 INFO - Cleaning up... 02:38:12 INFO - Return code: 0 02:38:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38: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')]} 02:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:38:12 INFO - Using env: {'DISPLAY': ':0', 02:38:12 INFO - 'HOME': '/home/cltbld', 02:38:12 INFO - 'LANG': 'en_US.UTF-8', 02:38:12 INFO - 'LANGUAGE': 'en_US:en', 02:38:12 INFO - 'LOGNAME': 'cltbld', 02:38:12 INFO - 'MAIL': '/var/mail/cltbld', 02:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:12 INFO - 'MOZ_NO_REMOTE': '1', 02:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:12 INFO - 'NO_EM_RESTART': '1', 02:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:12 INFO - 'PWD': '/builds/slave/test', 02:38:12 INFO - 'SHELL': '/bin/bash', 02:38:12 INFO - 'SHLVL': '1', 02:38:12 INFO - 'TERM': 'linux', 02:38:12 INFO - 'TMOUT': '86400', 02:38:12 INFO - 'USER': 'cltbld', 02:38:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:12 INFO - '_': '/tools/buildbot/bin/python'} 02:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:12 INFO - Downloading/unpacking jsonschema==2.5.1 02:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:13 INFO - warning: no files found matching '*.txt' 02:38:13 INFO - no previously-included directories found matching 'build' 02:38:13 INFO - no previously-included directories found matching 'dist' 02:38:13 INFO - no previously-included directories found matching '.git*' 02:38:13 INFO - Installing collected packages: jsonschema, functools32 02:38:13 INFO - Running setup.py install for functools32 02:38:13 INFO - warning: no files found matching '*.txt' 02:38:13 INFO - no previously-included directories found matching 'build' 02:38:13 INFO - no previously-included directories found matching 'dist' 02:38:13 INFO - no previously-included directories found matching '.git*' 02:38:13 INFO - Successfully installed jsonschema functools32 02:38:13 INFO - Cleaning up... 02:38:13 INFO - Return code: 0 02:38:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:38:13 INFO - Using env: {'DISPLAY': ':0', 02:38:13 INFO - 'HOME': '/home/cltbld', 02:38:13 INFO - 'LANG': 'en_US.UTF-8', 02:38:13 INFO - 'LANGUAGE': 'en_US:en', 02:38:13 INFO - 'LOGNAME': 'cltbld', 02:38:13 INFO - 'MAIL': '/var/mail/cltbld', 02:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:13 INFO - 'MOZ_NO_REMOTE': '1', 02:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:13 INFO - 'NO_EM_RESTART': '1', 02:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:13 INFO - 'PWD': '/builds/slave/test', 02:38:13 INFO - 'SHELL': '/bin/bash', 02:38:13 INFO - 'SHLVL': '1', 02:38:13 INFO - 'TERM': 'linux', 02:38:13 INFO - 'TMOUT': '86400', 02:38:13 INFO - 'USER': 'cltbld', 02:38:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:13 INFO - '_': '/tools/buildbot/bin/python'} 02:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:38:13 INFO - Cleaning up... 02:38:13 INFO - Return code: 0 02:38:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:38:13 INFO - Using env: {'DISPLAY': ':0', 02:38:13 INFO - 'HOME': '/home/cltbld', 02:38:13 INFO - 'LANG': 'en_US.UTF-8', 02:38:13 INFO - 'LANGUAGE': 'en_US:en', 02:38:13 INFO - 'LOGNAME': 'cltbld', 02:38:13 INFO - 'MAIL': '/var/mail/cltbld', 02:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:13 INFO - 'MOZ_NO_REMOTE': '1', 02:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:13 INFO - 'NO_EM_RESTART': '1', 02:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:13 INFO - 'PWD': '/builds/slave/test', 02:38:13 INFO - 'SHELL': '/bin/bash', 02:38:13 INFO - 'SHLVL': '1', 02:38:13 INFO - 'TERM': 'linux', 02:38:13 INFO - 'TMOUT': '86400', 02:38:13 INFO - 'USER': 'cltbld', 02:38:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:13 INFO - '_': '/tools/buildbot/bin/python'} 02:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:14 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:15 INFO - Downloading docopt-0.6.1.tar.gz 02:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:15 INFO - Running setup.py install for blobuploader 02:38:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:15 INFO - Running setup.py install for requests 02:38:16 INFO - Running setup.py install for docopt 02:38:16 INFO - Successfully installed blobuploader requests docopt 02:38:16 INFO - Cleaning up... 02:38:16 INFO - Return code: 0 02:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:16 INFO - Using env: {'DISPLAY': ':0', 02:38:16 INFO - 'HOME': '/home/cltbld', 02:38:16 INFO - 'LANG': 'en_US.UTF-8', 02:38:16 INFO - 'LANGUAGE': 'en_US:en', 02:38:16 INFO - 'LOGNAME': 'cltbld', 02:38:16 INFO - 'MAIL': '/var/mail/cltbld', 02:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:16 INFO - 'MOZ_NO_REMOTE': '1', 02:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:16 INFO - 'NO_EM_RESTART': '1', 02:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:16 INFO - 'PWD': '/builds/slave/test', 02:38:16 INFO - 'SHELL': '/bin/bash', 02:38:16 INFO - 'SHLVL': '1', 02:38:16 INFO - 'TERM': 'linux', 02:38:16 INFO - 'TMOUT': '86400', 02:38:16 INFO - 'USER': 'cltbld', 02:38:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:16 INFO - '_': '/tools/buildbot/bin/python'} 02:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:16 INFO - Running setup.py (path:/tmp/pip-9lA5ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:16 INFO - Running setup.py (path:/tmp/pip-tCdC21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:16 INFO - Running setup.py (path:/tmp/pip-ec4ylA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:16 INFO - Running setup.py (path:/tmp/pip-oyAAly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:16 INFO - Running setup.py (path:/tmp/pip-JhPPuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:17 INFO - Running setup.py (path:/tmp/pip-FHQAp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:17 INFO - Running setup.py (path:/tmp/pip-nEml3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:17 INFO - Running setup.py (path:/tmp/pip-U0z8qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:17 INFO - Running setup.py (path:/tmp/pip-HONvan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:17 INFO - Running setup.py (path:/tmp/pip-K1A5f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:17 INFO - Running setup.py (path:/tmp/pip-EbYT4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:17 INFO - Running setup.py (path:/tmp/pip-yIaTBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:17 INFO - Running setup.py (path:/tmp/pip-7lIcYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:17 INFO - Running setup.py (path:/tmp/pip-9qK13P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:17 INFO - Running setup.py (path:/tmp/pip-f7iLI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:17 INFO - Running setup.py (path:/tmp/pip-eNAq6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:17 INFO - Running setup.py (path:/tmp/pip-2H6MId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:17 INFO - Running setup.py install for manifestparser 02:38:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:17 INFO - Running setup.py install for mozcrash 02:38:18 INFO - Running setup.py install for mozdebug 02:38:18 INFO - Running setup.py install for mozdevice 02:38:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for mozfile 02:38:18 INFO - Running setup.py install for mozhttpd 02:38:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for mozinfo 02:38:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for mozInstall 02:38:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for mozleak 02:38:18 INFO - Running setup.py install for mozlog 02:38:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for moznetwork 02:38:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:18 INFO - Running setup.py install for mozprocess 02:38:19 INFO - Running setup.py install for mozprofile 02:38:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:19 INFO - Running setup.py install for mozrunner 02:38:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:19 INFO - Running setup.py install for mozscreenshot 02:38:19 INFO - Running setup.py install for moztest 02:38:19 INFO - Running setup.py install for mozversion 02:38:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:19 INFO - Cleaning up... 02:38:19 INFO - Return code: 0 02:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:19 INFO - Using env: {'DISPLAY': ':0', 02:38:19 INFO - 'HOME': '/home/cltbld', 02:38:19 INFO - 'LANG': 'en_US.UTF-8', 02:38:19 INFO - 'LANGUAGE': 'en_US:en', 02:38:19 INFO - 'LOGNAME': 'cltbld', 02:38:19 INFO - 'MAIL': '/var/mail/cltbld', 02:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:19 INFO - 'MOZ_NO_REMOTE': '1', 02:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:19 INFO - 'NO_EM_RESTART': '1', 02:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:19 INFO - 'PWD': '/builds/slave/test', 02:38:19 INFO - 'SHELL': '/bin/bash', 02:38:19 INFO - 'SHLVL': '1', 02:38:19 INFO - 'TERM': 'linux', 02:38:19 INFO - 'TMOUT': '86400', 02:38:19 INFO - 'USER': 'cltbld', 02:38:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:19 INFO - '_': '/tools/buildbot/bin/python'} 02:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:19 INFO - Running setup.py (path:/tmp/pip-GduvMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:19 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)) 02:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:19 INFO - Running setup.py (path:/tmp/pip-CXzjvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:20 INFO - Running setup.py (path:/tmp/pip-ZQV35n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:20 INFO - Running setup.py (path:/tmp/pip-Bxi_XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:20 INFO - Running setup.py (path:/tmp/pip-bGv6BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:20 INFO - Running setup.py (path:/tmp/pip-7JHFC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:20 INFO - Running setup.py (path:/tmp/pip-blrb6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:20 INFO - Running setup.py (path:/tmp/pip-pRVsdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:20 INFO - Running setup.py (path:/tmp/pip-oSlJWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:20 INFO - Running setup.py (path:/tmp/pip-y1gpVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:20 INFO - Running setup.py (path:/tmp/pip-OvdP3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:20 INFO - Running setup.py (path:/tmp/pip-kDalIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:20 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)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:20 INFO - Running setup.py (path:/tmp/pip-ptshkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:20 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)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:20 INFO - Running setup.py (path:/tmp/pip-EMk9Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:20 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)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:20 INFO - Running setup.py (path:/tmp/pip-Sf9Vp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:20 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)) 02:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:20 INFO - Running setup.py (path:/tmp/pip-XQy5Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:21 INFO - Running setup.py (path:/tmp/pip-KczI5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:38:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:22 INFO - Downloading blessings-1.6.tar.gz 02:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:22 INFO - Installing collected packages: blessings 02:38:22 INFO - Running setup.py install for blessings 02:38:22 INFO - Successfully installed blessings 02:38:22 INFO - Cleaning up... 02:38:22 INFO - Return code: 0 02:38:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:22 INFO - Reading from file tmpfile_stdout 02:38:22 INFO - Current package versions: 02:38:22 INFO - argparse == 1.2.1 02:38:22 INFO - blessings == 1.6 02:38:22 INFO - blobuploader == 1.2.4 02:38:22 INFO - docopt == 0.6.1 02:38:22 INFO - functools32 == 3.2.3-2 02:38:22 INFO - jsonschema == 2.5.1 02:38:22 INFO - manifestparser == 1.1 02:38:22 INFO - mozInstall == 1.13 02:38:22 INFO - mozcrash == 1.0 02:38:22 INFO - mozdebug == 0.1 02:38:22 INFO - mozdevice == 0.51 02:38:22 INFO - mozfile == 1.2 02:38:22 INFO - mozhttpd == 0.7 02:38:22 INFO - mozinfo == 0.10 02:38:22 INFO - mozleak == 0.1 02:38:22 INFO - mozlog == 3.5 02:38:22 INFO - moznetwork == 0.27 02:38:22 INFO - mozprocess == 0.25 02:38:22 INFO - mozprofile == 0.28 02:38:22 INFO - mozrunner == 6.13 02:38:22 INFO - mozscreenshot == 0.1 02:38:22 INFO - mozsystemmonitor == 0.3 02:38:22 INFO - moztest == 0.8 02:38:22 INFO - mozversion == 1.4 02:38:22 INFO - psutil == 3.1.1 02:38:22 INFO - requests == 1.2.3 02:38:22 INFO - wsgiref == 0.1.2 02:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:22 INFO - Using env: {'DISPLAY': ':0', 02:38:22 INFO - 'HOME': '/home/cltbld', 02:38:22 INFO - 'LANG': 'en_US.UTF-8', 02:38:22 INFO - 'LANGUAGE': 'en_US:en', 02:38:22 INFO - 'LOGNAME': 'cltbld', 02:38:22 INFO - 'MAIL': '/var/mail/cltbld', 02:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:22 INFO - 'MOZ_NO_REMOTE': '1', 02:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:22 INFO - 'NO_EM_RESTART': '1', 02:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:22 INFO - 'PWD': '/builds/slave/test', 02:38:22 INFO - 'SHELL': '/bin/bash', 02:38:22 INFO - 'SHLVL': '1', 02:38:22 INFO - 'TERM': 'linux', 02:38:22 INFO - 'TMOUT': '86400', 02:38:22 INFO - 'USER': 'cltbld', 02:38:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:22 INFO - '_': '/tools/buildbot/bin/python'} 02:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 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)) 02:38:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:38:22 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 02:38:22 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 02:38:22 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 02:38:22 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 02:38:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:38:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:38:24 INFO - Installing collected packages: marionette-driver, simplejson 02:38:24 INFO - Running setup.py install for marionette-driver 02:38:24 INFO - Running setup.py install for simplejson 02:38:24 INFO - building 'simplejson._speedups' extension 02:38:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:38:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:38:25 INFO - Successfully installed marionette-driver simplejson 02:38:25 INFO - Cleaning up... 02:38:25 INFO - Return code: 0 02:38:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', '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 02:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:38:25 INFO - Using env: {'DISPLAY': ':0', 02:38:25 INFO - 'HOME': '/home/cltbld', 02:38:25 INFO - 'LANG': 'en_US.UTF-8', 02:38:25 INFO - 'LANGUAGE': 'en_US:en', 02:38:25 INFO - 'LOGNAME': 'cltbld', 02:38:25 INFO - 'MAIL': '/var/mail/cltbld', 02:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:25 INFO - 'MOZ_NO_REMOTE': '1', 02:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:25 INFO - 'NO_EM_RESTART': '1', 02:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:25 INFO - 'PWD': '/builds/slave/test', 02:38:25 INFO - 'SHELL': '/bin/bash', 02:38:25 INFO - 'SHLVL': '1', 02:38:25 INFO - 'TERM': 'linux', 02:38:25 INFO - 'TMOUT': '86400', 02:38:25 INFO - 'USER': 'cltbld', 02:38:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:25 INFO - '_': '/tools/buildbot/bin/python'} 02:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:25 INFO - Cleaning up... 02:38:25 INFO - Return code: 0 02:38:25 INFO - Running post-action listener: _resource_record_post_action 02:38:25 INFO - Running post-action listener: _start_resource_monitoring 02:38:25 INFO - Starting resource monitoring. 02:38:25 INFO - [mozharness: 2017-07-16 09:38:25.683501Z] Finished create-virtualenv step (success) 02:38:25 INFO - [mozharness: 2017-07-16 09:38:25.684016Z] Running install step. 02:38:25 INFO - Running pre-action listener: _resource_record_pre_action 02:38:25 INFO - Running main action method: install 02:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:25 INFO - Reading from file tmpfile_stdout 02:38:25 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:26 INFO - Reading from file tmpfile_stdout 02:38:26 INFO - Output received: 02:38:26 INFO - Usage: mozinstall [options] installer 02:38:26 INFO - Options: 02:38:26 INFO - -h, --help show this help message and exit 02:38:26 INFO - -d DEST, --destination=DEST 02:38:26 INFO - Directory to install application into. [default: 02:38:26 INFO - "/builds/slave/test"] 02:38:26 INFO - --app=APP Application being installed. [default: firefox] 02:38:26 INFO - mkdir: /builds/slave/test/build/application 02:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:38:43 INFO - Reading from file tmpfile_stdout 02:38:43 INFO - Output received: 02:38:43 INFO - /builds/slave/test/build/application/firefox/firefox 02:38:43 INFO - Running post-action listener: _resource_record_post_action 02:38:43 INFO - [mozharness: 2017-07-16 09:38:43.945421Z] Finished install step (success) 02:38:43 INFO - [mozharness: 2017-07-16 09:38:43.945685Z] Running setup-mitmproxy step. 02:38:43 INFO - Running pre-action listener: _resource_record_pre_action 02:38:43 INFO - Running main action method: setup_mitmproxy 02:38:43 INFO - Skipping: mitmproxy is not required 02:38:43 INFO - Running post-action listener: _resource_record_post_action 02:38:43 INFO - [mozharness: 2017-07-16 09:38:43.946839Z] Finished setup-mitmproxy step (success) 02:38:43 INFO - [mozharness: 2017-07-16 09:38:43.947062Z] Running run-tests step. 02:38:43 INFO - Running pre-action listener: _resource_record_pre_action 02:38:43 INFO - Running pre-action listener: _set_gcov_prefix 02:38:43 INFO - Running main action method: run_tests 02:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:43 INFO - Python 2.7.3 02:38:43 INFO - Return code: 0 02:38:43 INFO - grabbing minidump binary from tooltool 02:38:43 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')]} 02:38:43 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 0x2cafd00>, '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 0x2cb0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:43 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 02:38:43 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 02:38:43 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 02:38:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:44 INFO - Return code: 0 02:38:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:38:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:44 INFO - ENV: RUST_BACKTRACE is now 1 02:38:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:38:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 02:38:44 INFO - Using env: {'DISPLAY': ':0', 02:38:44 INFO - 'HOME': '/home/cltbld', 02:38:44 INFO - 'LANG': 'en_US.UTF-8', 02:38:44 INFO - 'LANGUAGE': 'en_US:en', 02:38:44 INFO - 'LOGNAME': 'cltbld', 02:38:44 INFO - 'MAIL': '/var/mail/cltbld', 02:38:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:44 INFO - 'MOZ_NO_REMOTE': '1', 02:38:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:44 INFO - 'NO_EM_RESTART': '1', 02:38:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:44 INFO - 'PWD': '/builds/slave/test', 02:38:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:44 INFO - 'RUST_BACKTRACE': '1', 02:38:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:44 INFO - 'SHELL': '/bin/bash', 02:38:44 INFO - 'SHLVL': '1', 02:38:44 INFO - 'TERM': 'linux', 02:38:44 INFO - 'TMOUT': '86400', 02:38:44 INFO - 'USER': 'cltbld', 02:38:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535', 02:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:44 INFO - '_': '/tools/buildbot/bin/python'} 02:38:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:38:44 INFO - mozversion application_buildid: 20170716085807 02:38:44 INFO - mozversion application_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:44 INFO - mozversion application_display_name: Nightly 02:38:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:44 INFO - mozversion application_name: Firefox 02:38:44 INFO - mozversion application_remotingname: firefox 02:38:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:38:44 INFO - mozversion application_vendor: Mozilla 02:38:44 INFO - mozversion application_version: 56.0a1 02:38:44 INFO - mozversion platform_buildid: 20170716085807 02:38:44 INFO - mozversion platform_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:38:44 INFO - mozversion platform_version: 56.0a1 02:38:44 INFO - using testdate: 1500197924 02:38:44 INFO - actual date: 1500197924 02:38:44 INFO - starting webserver on 'localhost:56482' 02:38:44 INFO - SUITE-START | Running 2 tests 02:38:44 INFO - TEST-START | dromaeo_css 02:38:44 INFO - Initialising browser for dromaeo_css test... 02:38:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56482/getInfo.html -profile /tmp/tmp2ub690/profile 02:38:44 INFO - TEST-INFO | started process 29292 (/builds/slave/test/build/application/firefox/firefox http://localhost:56482/getInfo.html) 02:38:50 INFO - TEST-INFO | 29292: exit 0 02:38:50 INFO - Browser initialized. 02:38:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:50 INFO - TEST-INFO | started process 29517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ub690/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:02 INFO - PID 29517 | RSS: Main: 170012672 02:39:02 INFO - PID 29517 | 02:42:00 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56482/tests/dromaeo/cssquery-ext.html) 02:42:02 INFO - PID 29517 | RSS: Main: 177684480 02:42:02 INFO - PID 29517 | 02:45:04 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-ext.html (next: http://localhost:56482/tests/dromaeo/cssquery-jquery.html) 02:45:04 INFO - PID 29517 | RSS: Main: 175788032 02:45:04 INFO - PID 29517 | 02:48:06 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56482/tests/dromaeo/cssquery-mootools.html) 02:48:07 INFO - PID 29517 | RSS: Main: 177291264 02:48:07 INFO - PID 29517 | 02:51:08 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56482/tests/dromaeo/cssquery-prototype.html) 02:51:09 INFO - PID 29517 | RSS: Main: 177049600 02:51:09 INFO - PID 29517 | 02:54:12 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56482/tests/dromaeo/cssquery-yui.html) 02:54:13 INFO - PID 29517 | RSS: Main: 176361472 02:54:13 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | Cycle 1(1): loaded http://localhost:56482/tests/dromaeo/cssquery-yui.html (next: http://localhost:56482/tests/dromaeo/cssquery-dojo.html) 02:57:15 INFO - PID 29517 | RSS: Main: 178704384 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | __start_tp_report 02:57:15 INFO - PID 29517 | _x_x_mozilla_page_load 02:57:15 INFO - PID 29517 | _x_x_mozilla_page_load_details 02:57:15 INFO - PID 29517 | |i|pagename|runs| 02:57:15 INFO - PID 29517 | |0;dojo.html;3035.5901953236307;3063.958254193574;3124.5781819454382;3129.9687003129975;3137.3097918457947;6098.17674613927;6145.293291271505;6152.3540028297;6174.197354343929;6197.194364732579;6094.664793436359;6179.814605561829;6225.221847269091;6252;6290.402411770886;5672.092465205568;5675.2054712340205;5689;5717.714114294289;5764.25064741583;5644.858878528049;5650.434956504358;5653.689047102408;5696.971515142419;5711.086226203808;5484.506394424481;5555.833325000216;5567.777288908459;5571.359293681217;5660.943390566083;5539.806106786243;5557.221988921554;5564.443555644443;5579.358373787026;5584.5253153482;5462.8361149165585;5528.9723551382385;5550.333959924835;5553.750081246354;5555.722213889289;5968.343482216953;6001.129836173774;6006.549508786815;6011.0382338825575;6015.428534289235;6462.095306657072;6507.381798729113;6516.77191298307;6522.5760325578685;6556.93443065568;6593.406593406568;6598.175228096488;6611.702473388709;6613.173353330833;6615.4046135848;6083.482903953125;6099.085137229406;6148.354422785633;6154.415330543591;6157.261128664589;6765.830854228585;6791.830204244933;6857.7256909723055;6867.622280774605;6898.379145876896;6258.468030217391;6414.358564143642;6477.384648458389;6517.934820651828;6536.411722944863;6527;6569.507286953498;6580.703868325937;6581.769638062645;6589.209294884548;6504.544681872224;6516.674166291761;6524.249711283263;6524.988626762859;6538.934610653928;5521.834344969658;6367.140436041168;6581;6668.033135195369;6680.0981867448245;5336.810255593592;5350.91973620396;5410.3507579090765;5432.239486471897;5438.755256013489;4503.459584849774;4584;4609.631229501631;4612.308153776893;4647.395838540968;5599.860003499945;5675.716214189274;5677.290338707661;5681.517071049007;5684.8294551163535;6520.836979075466;6554.934450655433;6568.901466478007;6571.671416429255;6581;5681.744321505542;5695.487406133385;5733.913991290134;5765.4811067004175;5776.42235776419;5858.2677165354335;5867.656153370439;5927.347991720907;5942.7920022799;5945.791897283574;6242.875142497124;6351.904721429275;6361.522885783585;6435;6518.185226846645;6570.8028759137305;6575.24384695747;6582.736690532517;6586.967065164644;6587.308332625005;6304.810855674337;6377.808665740035;6378.6810659467765;6380.298167201511;6399.7440102395385;6328.493720502441;6383.39357761012;6425.06836508713;6445.935540644534;6453.580517266362;6552.246491653521;6559.639219842955;6585.440237579859;6625.138731964814;6647;6337.683115844282;6344.68276586178;6435.935640643721;6450.9354906450335;6453.709583068679;6298.11826344303;6300.432961033529;6309.2744334400295;6402.135711678864;6411.839704007437;6289.433950944437;6324.588901721373;6334.398232167937;6338.176037115146;6342;5542.528885044816;6360.713767880364;6377.266614339411;6382.329855365306;6451.096846441408;6005.729742161526;6123.785667501616;6127.785527506516;6139.079138129317;6148.723307451086 02:57:15 INFO - PID 29517 | |1;ext.html;749.5877267502872;808.4785313472814;846.8137009857832;867.6876324523166;868.1665601023019;42458;43479.56520434795;43504.56495435045;43570;43661.56338436615;39426.8028659857;39489;39545;39571.60428395715;39596.40605390922;6907.378335949764;7015.158181018285;7039.225685174627;7040.29597040297;7056.929430705679;6928.480363972697;6987.68555415005;7008.474364422663;7014.859702805941;7017.929820701805;6996.930030699704;7012.298770122998;7013.929860701379;7017.438604911595;7018.298170182967;6938.722451101949;6942.340477654615;6951.096357473496;6954.37410633043;6981.197162326347;6342.143810585604;6343.682815859234;6359.300476947532;6359.395857393541;6384.968075159594;35040.82479587611;35155.64844351549;35203.64796352029;35242.29515409703;35322.823385883166;3359.6808303211155;3400.0309911675054;3410.658934106594;3565.3760591896316;3631.6731494165388;32821.343573128644;33356.6664333356;33555.32889342224;33563.83218083894;33565.328693425996;4915.21356582945;4950.381202349707;4980.800767969277;4988.102141614508;5071.974640126813;197625;201785;202285;207544;208488;44947.10105797866;50249;51292.23061654078;51362.74318628383;51690.70773230699;53867.19199211936;54343.72828135834;54460.72769636127;54505.727471363185;54552.181717274274;16751.497455076365;16762.329506819835;16836;16889.831101689073;16897.57756056084;13950.441982320797;14046;14058.297085145701;14065.789013164811;14067.71864562703;14222.431102755774;14242.643933901736;14254.360748513845;14322.283885805668;14386.85613143876;5652.0718100920285;5685;5687.459691329317;5805.303363596396;5819.970900145472;981.5141504955093;998.3061772068343;1021.1014307409432;1048.4652827058255;1053.7839742852698;23243.883780581327;23575.292741217792;23617.88191059068;23662.29013129609;23780.048798048232;1108.451316598289;1114.1810769084716;1131.9434028298551;1138.6584024792694;1146.2148428326623;12089.214201076902;12404.25574465535;12434.440450179764;12456.626301210978;12487.625371238877;230394;230730;230773;230832;231225;55396.446035539935;55744.72127639336;56045;56056.43943560512;56289.15566266509;1469.2139705257637;1513.1072667126227;1515.0758037597057;1515.9166245856363;1516.1282262698992;22860.657090143995;23358.532829343658;23626.409339766644;27793.44413111686;28862;53902.460975389746;54177;54586.727066364416;54618.453815462926;54712;213741;217952;218181;218669;219038;36932.63067369292;37555;37904.052398690255;38375.42436863393;38454;43608.56391436172;46136.53863461457;46240.768796155804;46307.53692463032;46803.765981169876;33042.33915321728;33342.49986250257;33733.662663373056;33963.830180848934;34102.658973410944;33124.503132453516;33318.50022249619;33422;33478.83260583682;33514.329713406085;35369.64630353663;36855.63144368522;36882.262354752216;36987.63012369842;37313.81343093267;29628.40743185081;31420.842895785376;31845.840770795996;32379.35241295114;32651.18372040718;23397.88301058484;23788.88105559461;23830.285091447284;23982.52034959256;24328.635070474313 02:57:15 INFO - PID 29517 | |2;jquery.html;570.4979617936218;576.3372122059634;578.2511647416595;583.3466517500399;603.2971588099863;22354.88822555887;22407.103715851346;23345.649815252742;23417.297481075573;23468.64797028046;26442.867785661092;27241.86379068107;27242.863785681046;27253.72746272537;27311.317217069583;6417.101605775195;6571.244306904719;6577.7368905243975;6593.142891424132;6605.570637908545;3955.189186216833;6568.93431065688;6645.767398141066;6646.368594983469;6654.134962454898;5528.944710552883;6587.242467116271;6591.5056370772145;6593.769218077368;6665.300143484913;6582.605043697369;6588.176477940257;6597.2083349998065;6610.570312929644;6618.238902526223;6093.238345206849;6127.846803829895;6147.231596050494;6157.2919114301985;6166.506679465632;28105.156845294674;30111.09666710002;30182.54726179109;30269.24326891823;30618.387632247453;1884.123882394693;1932.9806701932941;1935.680612698903;1936.883786972786;1940.1075505267595;18930.52673683155;19245.615087698166;19344.41966741;19381.321653742194;19500;2181.214762685432;2189.0805861538192;2238.1271304191378;2241.69737085493;2263.909443622253;137427;141020.29489852587;141219.29390353087;141307;141479;14501.709965800625;14643.194624295766;14856.851431485762;14985.625359366102;15228.695426091415;24086.63870041951;24177.153799616928;24201.273961781175;24226.51546969051;24285.635715464283;10398.58405663765;10410.115140213014;10450.320729152581;10485.652317318223;10754.032137107697;9841.163501102343;9879.604815807432;9883.209343252667;9893.65372211969;10048.14590759779;8758.525921299188;9224.354295199271;9234.953825230965;9278.257739380833;9551.331406801597;2793.3296008957705;2803.159052284347;2861.728135827093;2866.4123854609757;2904.622399088147;950.458238803889;966.0050148347214;972.027972027972;974.2644303550774;975.878015248094;19468.61062778765;19928;20064.89967550153;20108.497287567927;20232.89883550602;1021.1728499915092;1046.1369370269558;1048.4233671480656;1054.330500132406;1060;10884.673459796219;10973.28673636227;11192.608258710907;11203.271787333797;11322.547098116147;513711;530586;537662;546001;547816;116440;123799.38100309442;123867;124054.37972810259;128094.35952820176;1278.7186818900013;1280.4366078925243;1325.754735373959;1329.7872340425486;1333.5532596580254;19590.314338998065;20566.897165514078;20864.165433382495;20891.582168356243;21185.788142119;54918;56421;57292;57397.426025740875;57911.420885792286;71191.28808712054;71537;72399.63800180965;72520;72774;14348.641283967567;14390.85609143895;14544.27278636085;14618.342174601956;14942.103473791607;23211.76788232096;23662.763372366746;23704.525909482058;23834.40413989595;24049;18518.16668249905;18642.906785465984;18662.81337186611;18745;18982.810171898105;16025.599360015627;16826.747598786274;16879.156042198087;17139.228734706718;17565.648687026445;19032.953187574818;19294.517637059187;19350.32273870408;19382.321618743277;19526.414207573795;14200.43198272099;14556.49052283165;14686.63283417923;14966.102033878002;15102.39590416371;18590.628187435905;18850.71723924115;18863.811361886754;18924.905375473034;18945.526361841064 02:57:15 INFO - PID 29517 | |3;mootools.html;1346.3133801761103;1379.5930200590824;1399.8180236569244;1401.8738313551783;1403.9298035098243;13419.597412077641;14069.71860562788;14192.574222773308;14211.289435528233;14227.075240109385;13637.386317615707;14470.927645361784;14539.418423263083;14554;14608.926955365208;2616.869156542175;2678.7723043541323;2680.9463810723773;2685.5434576122107;2688.9731102689016;2587.8964841406323;2630.0794721847296;2646.073874144053;2651.920442386722;2653.230563136688;2519.86140762258;2559.436923876744;2617.8952841886303;2627.6978147512996;2639.5644718621406;2676.5985102234627;2688.1801050679537;2691.663542057233;2693.0305090167526;2694.0705456617434;2563.115725074846;2594.2736033910537;2604.348912771807;2604.791616670662;2609.4781043791127;13528.526501572496;13859.23774192419;13864.861351386458;13880;13885.305734713224;7266.128064632225;7422.665980030912;7503.324700776901;7521.811954701122;7522.736704215381;4966.566382472599;5131.486851314876;5266.131088370415;5269.789208431658;5278.577713782888;1780.4836597386743;1785.2504545545307;1813.1750053725523;1849.9815001849943;1851.6296740651924;21925.561488770294;22127.778722212894;22399.32802015942;22445.775542244693;22459.55080898389;6210.31686514483;6243.40687634683;6261.248650161919;6396.9360306397275;6437.195350581177;15303.38786448552;15325.157116358485;15328.693426131638;15331.693366132838;15399.769003464957;7182.209956904736;7386.815329616695;7403.407727381797;7440.4419668524;7456.254374562609;6748.595084294958;6794.490413219029;6956.930430695628;6969.721211151598;7032.718691252293;4752.500987396343;4933.925991110136;4959.404871415453;4997.525235102732;5029.044481548494;1416.8653977872086;1444.1407362619225;1454.941802327895;1468.875145612635;1481.029925398844;847.7922908887363;858.5492616376453;873.218469469821;875.4615911214557;898.8427025270682;8156.388270879707;8388.245057944814;8394.412391132562;8470.830583388297;8633.481991080555;940.7130825098274;974.2352253480983;1024.99487502562;1030.2324768047852;1033.9298825715348;5485.780568777284;5523;5601.355844077902;5608.214849921014;5663.150527420919;18253.726194107097;19070.61858762817;19112.904435477732;19209.32767353136;19303;18147.364842230458;18632.90683546601;18841.90579047096;18957.336493222672;18965.62068758645;10259.384436933808;10832.783344333227;10878.075363594025;10924.563017479371;11017.504212310465;7327.487075904849;8093.797655058671;8159.755207343789;8226.753197404087;8364.539950302791;15592.205394346076;16043.197840108181;16177.4337898173;16436.506904792874;16617.75073373876;16062.19689015568;16075.035497870165;16297.59256018609;16377.344906203618;17057.573560661083;10999;11158.49786759614;11275.379854108103;11325;11336.716582085513;12782;12816.102872798814;12874.356282185667;12888.291143987171;12959.35203239853;10217.795644087226;10471.476426178508;10591.682249532527;10695.94652026766;11105.777884442428;8901.421407608485;9412.01173876733;10037.498125093862;10505;10725.356478611307;8951;9202.171804537624;9215.49314787693;9278.95360523193;9434.905650943403;6697.727431788139;6716.731330746716;6892.793216203522;6902.8619427612175;7196.0285361475535;6676.799696009128;6679.219008953281;6797.422219111431;6806.149231346082;6900.068490753884 02:57:15 INFO - PID 29517 | |4;prototype.html;490.68841285783515;503.3908970146124;520.4171328112515;526.0504788856114;529.190338781664;6104.877902441954;6135.785247516338;6185.752569897199;6186.597871138373;6191.823553524827;5853.5902486825935;5906.734196961136;5921.253230297062;5952.345242023384;6086.634801911889;4833.226683730604;4879.219324907997;4888.608911287089;4912.606991440676;4935.210366341386;4863.562279394854;4866.343043689109;4878.9268160977435;4880.731559764212;4952.059108769322;4857.10143623429;4899.877503062434;4902.411710594733;4921.311016457699;4926.45808961014;4577.679562430648;4770.618350531984;4770.976145119287;4788.688735232234;4837.379477874916;4236.237477254093;4303.526612072669;4303.621656999272;4310.956890431118;4332.631726303268;5838.649681019152;5847.8012007538355;5860.267466566679;5911.201987731644;5915;5482.424345443711;5521.757604538987;5527.695976721278;5552.750126244328;5555.361133469622;6350.491960643184;6405.967970160119;6407.935920640781;6436.967815160941;6464.900966835602;4747.548982846624;4753.595944344735;4779.426468823764;4783.162946484386;4784.904301913977;6693.598384096969;6694.732210711614;6763.898541521881;6823.795286141374;6825.829354266133;4963.6277279204205;4982.626303027288;4985.476524964899;4994.8251811187165;5025.899482010339;5037.697738135724;5038.3198268234055;5059.19052951526;5077.339945807022;5079.7300674831295;5575.553955683536;5589.133684278943;5599.888002239933;5602;5607.6261315977845;6346.238451385863;6392.20097487814;6406.2953075161695;6414.903776443357;6450.161479007699;1728.6369862329052;1737.852282555997;1748.5366377909863;1752.4392194497639;1766.143420441085;1134.143721490286;1214.3624597086423;1220.4751956658722;1222.584321330752;1224.3349045298387;5473.38535132137;5595.328560572757;5634.802781902614;5646.57650676201;5649.090718280089;6432.871342573216;6618.106555614931;6693.431058359996;6701.497387695845;6705.497087718343;5601.29983752031;5636.718164091861;5637.43625637433;5679.659220446786;5697.772089116472;3492.89521314361;3500.579930408367;3515.6660117288816;3525.312564050037;3533.3110043541265;6301.6219026858535;6321.65230912295;6376.681165941777;6426.690254518927;6438.871222575523;6601.062527175361;6748.865022699519;6755.662216889136;6779.559328643622;6826.078479405316;6396.360363963567;6409.7115629795835;6428.228612566522;6473.935260647428;6488;6585.242697089704;6620.3710647488415;6629.7348106075215;6643.833904152435;6668.999650052531;6533.431976325743;6533.542652014314;6573.3098024706715;6589.924173885211;6605.834854128685;6296.748130074746;6340.175777148941;6376.585521941059;6378.45783108441;6400.839979000562;4815.22956326986;4847.497275844499;4878.243872199815;4912.95087049125;4942.207652676227;6538.411542961157;6557.967210163919;6566.474682025331;6612.867742645024;6633.800985970429;6225.626462412089;6302.180716506825;6326.873462530815;6402;6423.394151462135;6348.555601107878;6364.586301890362;6443.548951573345;6447.387498187664;6448.838779030561;6332.240131184288;6332.968335158294;6360.872782544231;6395.136656551492;6412.9358706414205;5736.254286942671;6363.745450181941;6368.808935731936;6413.4869210463985;6445.838854028687;6103.511719062376;6169.537284703575;6196.287426945959;6209.906851397142;6255.624662520263 02:57:15 INFO - PID 29517 | |5;yui.html;891.3715830339611;891.4740303221098;892.9062448442913;899.2760827533837;911.4759013567199;17392.391266305684;17830.108494575266;17936.730949035777;17987.010714410702;19930.302439414623;19866.205351785946;19952.102155403005;19960.800391996076;19980.100895459702;20020.399388018348;990.257307019737;1049.8162821506244;1055.8680164979378;1059.0256963593474;1065.8081545321838;1034.57065317893;1050.669039252633;1056.3345092591655;1057.6509751781932;1058.095328494138;1096.736783172041;1109.6504601050683;1115.4924509348227;1116.7264020314994;1119.065580240496;990.7869807991317;1037.6575730009154;1096.1888202730001;1111.016750176096;1111.4442778610694;794.8251384695358;794.8966634337557;795.6578671171394;795.8686816675241;796.9043714754208;15684.529464116094;15788.921055394765;15856.207189640587;15931.840681593152;15940.442084526985;17984.640307193913;18523.07384630763;18628.627427451374;18632.347867824697;18861.05694715259;14960.476383326532;15422.460213892573;15457.072575645385;15482.148481833494;15808.288627011698;3440.415129428003;3444.225049363898;3459.550258466383;3461.0828130545424;3465.480177973299;105695.47152264189;106742;113088.43455782751;116050;119489.40255298755;14288.142711437347;14353.497627582985;14530.128192308495;14647;14693;27419.725802742116;27852.72147278542;28015.299617509725;28050.579241311396;28065.579016314772;7935.325497332791;8231.09457959624;8274.710385136492;8281.047679516812;8380.329573634095;3463.6363181866045;3508.807015614115;3667.468217108504;3675.9816200918826;3686.7972261525338;4734.857954261378;4861.1006963711825;4862.367892173995;4890.021995600894;4904.313396124546;963.0754475703403;985.571276494727;997.3068717241592;1018.6383833738915;1025.9076683098558;635.8187916443791;640.1677818835495;661.3188415931598;674.0832467843728;685.533836990851;10676;11443.210930828498;11504.884951150549;11743.88256117445;11834.467448964646;651.6285717141184;693.2409012131708;698.1656919980676;699.6466784274011;704.2218348724688;5036.294918711384;5151.943851510431;5152.355955505562;5152.562032227228;5179.663321884065;97286.51356743312;99356.50321748489;99377.50311248397;99703.50148249212;101934;85562.57218713866;87653;90158.54920725485;90635;91064.5446772762;74422.62788686022;74461.25538744543;76759.61620191863;78243;78572;11269.887301126884;11632.651020469399;11683.299002059903;11809.291442513477;11864.466099025738;34109.48835767515;35028.64971350356;35274.470882936264;36220;37660;46945.06109877852;47551.52448475471;65862.85219573742;65875;67620.22761563149;18197.909010454863;18202.271909124018;18264.269429223215;18455.07724613791;18523.259069637603;19804;20220.39338819838;20262.18951241934;20826.791732083093;20831.791682082985;17800.55498612545;17933.820661793216;18094.819051809314;18265.08674566293;18718.344857929907;17330.30678772835;17764.378246761302;17952.91023544874;17972.370967016093;17988.730169047212;15315.846841531442;15462.917595768187;15984.920075399548;16640.75038874442;16679.08265045434;12166.270023798601;13081.67295817574;13266.668333291746;13414.195148290743;13458.192508449525;13465.663358416117;13499.122557033761;14238.359273832495;14273.64315892111;14399 02:57:15 INFO - PID 29517 | __end_tp_report 02:57:15 INFO - PID 29517 | __start_cc_report 02:57:15 INFO - PID 29517 | _x_x_mozilla_cycle_collect,338 02:57:15 INFO - PID 29517 | __end_cc_report 02:57:15 INFO - PID 29517 | __startTimestamp1500199035396__endTimestamp 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | ------- Summary: start ------- 02:57:15 INFO - PID 29517 | Number of tests: 6 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#0] dojo.html Cycles:165 Average:6032.29 Median:6258.47 stddev:705.52 (11.3%) stddev-sans-first:667.37 02:57:15 INFO - PID 29517 | Values: 3035.6 3064.0 3124.6 3130.0 3137.3 6098.2 6145.3 6152.4 6174.2 6197.2 6094.7 6179.8 6225.2 6252.0 6290.4 5672.1 5675.2 5689.0 5717.7 5764.3 5644.9 5650.4 5653.7 5697.0 5711.1 5484.5 5555.8 5567.8 5571.4 5660.9 5539.8 5557.2 5564.4 5579.4 5584.5 5462.8 5529.0 5550.3 5553.8 5555.7 5968.3 6001.1 6006.5 6011.0 6015.4 6462.1 6507.4 6516.8 6522.6 6556.9 6593.4 6598.2 6611.7 6613.2 6615.4 6083.5 6099.1 6148.4 6154.4 6157.3 6765.8 6791.8 6857.7 6867.6 6898.4 6258.5 6414.4 6477.4 6517.9 6536.4 6527.0 6569.5 6580.7 6581.8 6589.2 6504.5 6516.7 6524.2 6525.0 6538.9 5521.8 6367.1 6581.0 6668.0 6680.1 5336.8 5350.9 5410.4 5432.2 5438.8 4503.5 4584.0 4609.6 4612.3 4647.4 5599.9 5675.7 5677.3 5681.5 5684.8 6520.8 6554.9 6568.9 6571.7 6581.0 5681.7 5695.5 5733.9 5765.5 5776.4 5858.3 5867.7 5927.3 5942.8 5945.8 6242.9 6351.9 6361.5 6435.0 6518.2 6570.8 6575.2 6582.7 6587.0 6587.3 6304.8 6377.8 6378.7 6380.3 6399.7 6328.5 6383.4 6425.1 6445.9 6453.6 6552.2 6559.6 6585.4 6625.1 6647.0 6337.7 6344.7 6435.9 6450.9 6453.7 6298.1 6300.4 6309.3 6402.1 6411.8 6289.4 6324.6 6334.4 6338.2 6342.0 5542.5 6360.7 6377.3 6382.3 6451.1 6005.7 6123.8 6127.8 6139.1 6148.7 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#1] ext.html Cycles:180 Average:39445.51 Median:35346.23 stddev:56525.62 (159.9%) stddev-sans-first:56609.51 02:57:15 INFO - PID 29517 | Values: 749.6 808.5 846.8 867.7 868.2 42458.0 43479.6 43504.6 43570.0 43661.6 39426.8 39489.0 39545.0 39571.6 39596.4 6907.4 7015.2 7039.2 7040.3 7056.9 6928.5 6987.7 7008.5 7014.9 7017.9 6996.9 7012.3 7013.9 7017.4 7018.3 6938.7 6942.3 6951.1 6954.4 6981.2 6342.1 6343.7 6359.3 6359.4 6385.0 35040.8 35155.6 35203.6 35242.3 35322.8 3359.7 3400.0 3410.7 3565.4 3631.7 32821.3 33356.7 33555.3 33563.8 33565.3 4915.2 4950.4 4980.8 4988.1 5072.0 197625.0 201785.0 202285.0 207544.0 208488.0 44947.1 50249.0 51292.2 51362.7 51690.7 53867.2 54343.7 54460.7 54505.7 54552.2 16751.5 16762.3 16836.0 16889.8 16897.6 13950.4 14046.0 14058.3 14065.8 14067.7 14222.4 14242.6 14254.4 14322.3 14386.9 5652.1 5685.0 5687.5 5805.3 5820.0 981.5 998.3 1021.1 1048.5 1053.8 23243.9 23575.3 23617.9 23662.3 23780.0 1108.5 1114.2 1131.9 1138.7 1146.2 12089.2 12404.3 12434.4 12456.6 12487.6 230394.0 230730.0 230773.0 230832.0 231225.0 55396.4 55744.7 56045.0 56056.4 56289.2 1469.2 1513.1 1515.1 1515.9 1516.1 22860.7 23358.5 23626.4 27793.4 28862.0 53902.5 54177.0 54586.7 54618.5 54712.0 213741.0 217952.0 218181.0 218669.0 219038.0 36932.6 37555.0 37904.1 38375.4 38454.0 43608.6 46136.5 46240.8 46307.5 46803.8 33042.3 33342.5 33733.7 33963.8 34102.7 33124.5 33318.5 33422.0 33478.8 33514.3 35369.6 36855.6 36882.3 36987.6 37313.8 29628.4 31420.8 31845.8 32379.4 32651.2 23397.9 23788.9 23830.3 23982.5 24328.6 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#2] jquery.html Cycles:180 Average:36576.36 Median:12324.40 stddev:89832.54 (728.9%) stddev-sans-first:90043.86 02:57:15 INFO - PID 29517 | Values: 570.5 576.3 578.3 583.3 603.3 22354.9 22407.1 23345.6 23417.3 23468.6 26442.9 27241.9 27242.9 27253.7 27311.3 6417.1 6571.2 6577.7 6593.1 6605.6 3955.2 6568.9 6645.8 6646.4 6654.1 5528.9 6587.2 6591.5 6593.8 6665.3 6582.6 6588.2 6597.2 6610.6 6618.2 6093.2 6127.8 6147.2 6157.3 6166.5 28105.2 30111.1 30182.5 30269.2 30618.4 1884.1 1933.0 1935.7 1936.9 1940.1 18930.5 19245.6 19344.4 19381.3 19500.0 2181.2 2189.1 2238.1 2241.7 2263.9 137427.0 141020.3 141219.3 141307.0 141479.0 14501.7 14643.2 14856.9 14985.6 15228.7 24086.6 24177.2 24201.3 24226.5 24285.6 10398.6 10410.1 10450.3 10485.7 10754.0 9841.2 9879.6 9883.2 9893.7 10048.1 8758.5 9224.4 9235.0 9278.3 9551.3 2793.3 2803.2 2861.7 2866.4 2904.6 950.5 966.0 972.0 974.3 975.9 19468.6 19928.0 20064.9 20108.5 20232.9 1021.2 1046.1 1048.4 1054.3 1060.0 10884.7 10973.3 11192.6 11203.3 11322.5 513711.0 530586.0 537662.0 546001.0 547816.0 116440.0 123799.4 123867.0 124054.4 128094.4 1278.7 1280.4 1325.8 1329.8 1333.6 19590.3 20566.9 20864.2 20891.6 21185.8 54918.0 56421.0 57292.0 57397.4 57911.4 71191.3 71537.0 72399.6 72520.0 72774.0 14348.6 14390.9 14544.3 14618.3 14942.1 23211.8 23662.8 23704.5 23834.4 24049.0 18518.2 18642.9 18662.8 18745.0 18982.8 16025.6 16826.7 16879.2 17139.2 17565.6 19033.0 19294.5 19350.3 19382.3 19526.4 14200.4 14556.5 14686.6 14966.1 15102.4 18590.6 18850.7 18863.8 18924.9 18945.5 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#3] mootools.html Cycles:180 Average:8560.81 Median:2599.31 stddev:5750.71 (221.2%) stddev-sans-first:5741.29 02:57:15 INFO - PID 29517 | Values: 1346.3 1379.6 1399.8 1401.9 1403.9 13419.6 14069.7 14192.6 14211.3 14227.1 13637.4 14470.9 14539.4 14554.0 14608.9 2616.9 2678.8 2680.9 2685.5 2689.0 2587.9 2630.1 2646.1 2651.9 2653.2 2519.9 2559.4 2617.9 2627.7 2639.6 2676.6 2688.2 2691.7 2693.0 2694.1 2563.1 2594.3 2604.3 2604.8 2609.5 13528.5 13859.2 13864.9 13880.0 13885.3 7266.1 7422.7 7503.3 7521.8 7522.7 4966.6 5131.5 5266.1 5269.8 5278.6 1780.5 1785.3 1813.2 1850.0 1851.6 21925.6 22127.8 22399.3 22445.8 22459.6 6210.3 6243.4 6261.2 6396.9 6437.2 15303.4 15325.2 15328.7 15331.7 15399.8 7182.2 7386.8 7403.4 7440.4 7456.3 6748.6 6794.5 6956.9 6969.7 7032.7 4752.5 4933.9 4959.4 4997.5 5029.0 1416.9 1444.1 1454.9 1468.9 1481.0 847.8 858.5 873.2 875.5 898.8 8156.4 8388.2 8394.4 8470.8 8633.5 940.7 974.2 1025.0 1030.2 1033.9 5485.8 5523.0 5601.4 5608.2 5663.2 18253.7 19070.6 19112.9 19209.3 19303.0 18147.4 18632.9 18841.9 18957.3 18965.6 10259.4 10832.8 10878.1 10924.6 11017.5 7327.5 8093.8 8159.8 8226.8 8364.5 15592.2 16043.2 16177.4 16436.5 16617.8 16062.2 16075.0 16297.6 16377.3 17057.6 10999.0 11158.5 11275.4 11325.0 11336.7 12782.0 12816.1 12874.4 12888.3 12959.4 10217.8 10471.5 10591.7 10695.9 11105.8 8901.4 9412.0 10037.5 10505.0 10725.4 8951.0 9202.2 9215.5 9279.0 9434.9 6697.7 6716.7 6892.8 6902.9 7196.0 6676.8 6679.2 6797.4 6806.1 6900.1 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#4] prototype.html Cycles:180 Average:5394.94 Median:5908.97 stddev:1511.31 (25.6%) stddev-sans-first:1470.04 02:57:15 INFO - PID 29517 | Values: 490.7 503.4 520.4 526.1 529.2 6104.9 6135.8 6185.8 6186.6 6191.8 5853.6 5906.7 5921.3 5952.3 6086.6 4833.2 4879.2 4888.6 4912.6 4935.2 4863.6 4866.3 4878.9 4880.7 4952.1 4857.1 4899.9 4902.4 4921.3 4926.5 4577.7 4770.6 4771.0 4788.7 4837.4 4236.2 4303.5 4303.6 4311.0 4332.6 5838.6 5847.8 5860.3 5911.2 5915.0 5482.4 5521.8 5527.7 5552.8 5555.4 6350.5 6406.0 6407.9 6437.0 6464.9 4747.5 4753.6 4779.4 4783.2 4784.9 6693.6 6694.7 6763.9 6823.8 6825.8 4963.6 4982.6 4985.5 4994.8 5025.9 5037.7 5038.3 5059.2 5077.3 5079.7 5575.6 5589.1 5599.9 5602.0 5607.6 6346.2 6392.2 6406.3 6414.9 6450.2 1728.6 1737.9 1748.5 1752.4 1766.1 1134.1 1214.4 1220.5 1222.6 1224.3 5473.4 5595.3 5634.8 5646.6 5649.1 6432.9 6618.1 6693.4 6701.5 6705.5 5601.3 5636.7 5637.4 5679.7 5697.8 3492.9 3500.6 3515.7 3525.3 3533.3 6301.6 6321.7 6376.7 6426.7 6438.9 6601.1 6748.9 6755.7 6779.6 6826.1 6396.4 6409.7 6428.2 6473.9 6488.0 6585.2 6620.4 6629.7 6643.8 6669.0 6533.4 6533.5 6573.3 6589.9 6605.8 6296.7 6340.2 6376.6 6378.5 6400.8 4815.2 4847.5 4878.2 4913.0 4942.2 6538.4 6558.0 6566.5 6612.9 6633.8 6225.6 6302.2 6326.9 6402.0 6423.4 6348.6 6364.6 6443.5 6447.4 6448.8 6332.2 6333.0 6360.9 6395.1 6412.9 5736.3 6363.7 6368.8 6413.5 6445.8 6103.5 6169.5 6196.3 6209.9 6255.6 02:57:15 INFO - PID 29517 | 02:57:15 INFO - PID 29517 | [#5] yui.html Cycles:180 Average:21567.99 Median:19835.10 stddev:28642.82 (144.4%) stddev-sans-first:28681.09 02:57:15 INFO - PID 29517 | Values: 891.4 891.5 892.9 899.3 911.5 17392.4 17830.1 17936.7 17987.0 19930.3 19866.2 19952.1 19960.8 19980.1 20020.4 990.3 1049.8 1055.9 1059.0 1065.8 1034.6 1050.7 1056.3 1057.7 1058.1 1096.7 1109.7 1115.5 1116.7 1119.1 990.8 1037.7 1096.2 1111.0 1111.4 794.8 794.9 795.7 795.9 796.9 15684.5 15788.9 15856.2 15931.8 15940.4 17984.6 18523.1 18628.6 18632.3 18861.1 14960.5 15422.5 15457.1 15482.1 15808.3 3440.4 3444.2 3459.6 3461.1 3465.5 105695.5 106742.0 113088.4 116050.0 119489.4 14288.1 14353.5 14530.1 14647.0 14693.0 27419.7 27852.7 28015.3 28050.6 28065.6 7935.3 8231.1 8274.7 8281.0 8380.3 3463.6 3508.8 3667.5 3676.0 3686.8 4734.9 4861.1 4862.4 4890.0 4904.3 963.1 985.6 997.3 1018.6 1025.9 635.8 640.2 661.3 674.1 685.5 10676.0 11443.2 11504.9 11743.9 11834.5 651.6 693.2 698.2 699.6 704.2 5036.3 5151.9 5152.4 5152.6 5179.7 97286.5 99356.5 99377.5 99703.5 101934.0 85562.6 87653.0 90158.5 90635.0 91064.5 74422.6 74461.3 76759.6 78243.0 78572.0 11269.9 11632.7 11683.3 11809.3 11864.5 34109.5 35028.6 35274.5 36220.0 37660.0 46945.1 47551.5 65862.9 65875.0 67620.2 18197.9 18202.3 18264.3 18455.1 18523.3 19804.0 20220.4 20262.2 20826.8 20831.8 17800.6 17933.8 18094.8 18265.1 18718.3 17330.3 17764.4 17952.9 17972.4 17988.7 15315.8 15462.9 15984.9 16640.8 16679.1 12166.3 13081.7 13266.7 13414.2 13458.2 13465.7 13499.1 14238.4 14273.6 14399.0 02:57:15 INFO - PID 29517 | -------- Summary: end -------- 02:57:15 INFO - PID 29517 | 02:57:15 INFO - TEST-INFO | 29517: exit 0 02:57:15 INFO - TEST-OK | dromaeo_css | took 1111621ms 02:57:15 INFO - TEST-START | kraken 02:57:15 INFO - Initialising browser for kraken test... 02:57:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56482/getInfo.html -profile /tmp/tmp81ncvL/profile 02:57:15 INFO - TEST-INFO | started process 29928 (/builds/slave/test/build/application/firefox/firefox http://localhost:56482/getInfo.html) 02:57:21 INFO - TEST-INFO | 29928: exit 0 02:57:21 INFO - Browser initialized. 02:57:21 INFO - Running cycle 1/1 for kraken test... 02:57:21 INFO - TEST-INFO | started process 30155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81ncvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:33 INFO - PID 30155 | RSS: Main: 170196992 02:57:33 INFO - PID 30155 | 02:57:35 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56482/tests/kraken/driver.html?testName=audio-beat-detection) 02:57:36 INFO - PID 30155 | RSS: Main: 176873472 02:57:36 INFO - PID 30155 | 02:57:39 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56482/tests/kraken/driver.html?testName=audio-dft) 02:57:39 INFO - PID 30155 | RSS: Main: 176533504 02:57:39 INFO - PID 30155 | 02:57:42 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56482/tests/kraken/driver.html?testName=audio-fft) 02:57:43 INFO - PID 30155 | RSS: Main: 170762240 02:57:43 INFO - PID 30155 | 02:57:45 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56482/tests/kraken/driver.html?testName=audio-oscillator) 02:57:46 INFO - PID 30155 | RSS: Main: 171847680 02:57:46 INFO - PID 30155 | 02:57:48 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:48 INFO - PID 30155 | RSS: Main: 171798528 02:57:48 INFO - PID 30155 | 02:57:51 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56482/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:52 INFO - PID 30155 | RSS: Main: 175312896 02:57:52 INFO - PID 30155 | 02:57:55 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56482/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:56 INFO - PID 30155 | RSS: Main: 176750592 02:57:56 INFO - PID 30155 | 02:57:59 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56482/tests/kraken/driver.html?testName=json-parse-financial) 02:57:59 INFO - PID 30155 | RSS: Main: 175738880 02:57:59 INFO - PID 30155 | 02:58:01 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:02 INFO - PID 30155 | RSS: Main: 175460352 02:58:02 INFO - PID 30155 | 02:58:03 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:04 INFO - PID 30155 | RSS: Main: 175345664 02:58:04 INFO - PID 30155 | 02:58:06 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:07 INFO - PID 30155 | RSS: Main: 175333376 02:58:07 INFO - PID 30155 | 02:58:09 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:10 INFO - PID 30155 | RSS: Main: 175747072 02:58:10 INFO - PID 30155 | 02:58:13 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:14 INFO - PID 30155 | RSS: Main: 175992832 02:58:14 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | Cycle 1(1): loaded http://localhost:56482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56482/tests/kraken/driver.html?testName=ai-astar) 02:58:16 INFO - PID 30155 | RSS: Main: 177053696 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | __start_tp_report 02:58:16 INFO - PID 30155 | _x_x_mozilla_page_load 02:58:16 INFO - PID 30155 | _x_x_mozilla_page_load_details 02:58:16 INFO - PID 30155 | |i|pagename|runs| 02:58:16 INFO - PID 30155 | |0;ai-astar;101;108;109;108;108;110;106;108;109;111 02:58:16 INFO - PID 30155 | |1;audio-beat-detection;149;121;147;186;123;149;149;123;171;119 02:58:16 INFO - PID 30155 | |2;audio-dft;164;162;161;163;161;169;163;165;166;167 02:58:16 INFO - PID 30155 | |3;audio-fft;78;75;74;174;75;78;74;75;95;76 02:58:16 INFO - PID 30155 | |4;audio-oscillator;83;82;130;82;83;82;125;83;82;133 02:58:16 INFO - PID 30155 | |5;imaging-gaussian-blur;113;114;113;114;113;114;114;113;114;114 02:58:16 INFO - PID 30155 | |6;imaging-darkroom;149;151;149;150;150;151;150;150;149;153 02:58:16 INFO - PID 30155 | |7;imaging-desaturate;94;94;94;94;94;94;95;95;95;95 02:58:16 INFO - PID 30155 | |8;json-parse-financial;55;57;57;55;55;60;55;55;55;55 02:58:16 INFO - PID 30155 | |9;json-stringify-tinderbox;55;54;54;54;55;54;53;55;54;55 02:58:16 INFO - PID 30155 | |10;stanford-crypto-aes;78;76;87;78;80;76;79;77;76;76 02:58:16 INFO - PID 30155 | |11;stanford-crypto-ccm;127;134;127;127;127;129;128;124;132;168 02:58:16 INFO - PID 30155 | |12;stanford-crypto-pbkdf2;186;198;190;181;183;189;178;182;180;175 02:58:16 INFO - PID 30155 | |13;stanford-crypto-sha256-iterative;66;70;72;67;67;69;68;68;69;71 02:58:16 INFO - PID 30155 | __end_tp_report 02:58:16 INFO - PID 30155 | __start_cc_report 02:58:16 INFO - PID 30155 | _x_x_mozilla_cycle_collect,947 02:58:16 INFO - PID 30155 | __end_cc_report 02:58:16 INFO - PID 30155 | __startTimestamp1500199096290__endTimestamp 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | ------- Summary: start ------- 02:58:16 INFO - PID 30155 | Number of tests: 14 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.50 stddev:2.74 (2.5%) stddev-sans-first:1.42 02:58:16 INFO - PID 30155 | Values: 101.0 108.0 109.0 108.0 108.0 110.0 106.0 108.0 109.0 111.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:149.00 stddev:22.64 (15.2%) stddev-sans-first:23.93 02:58:16 INFO - PID 30155 | Values: 149.0 121.0 147.0 186.0 123.0 149.0 149.0 123.0 171.0 119.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.64 (1.6%) stddev-sans-first:2.80 02:58:16 INFO - PID 30155 | Values: 164.0 162.0 161.0 163.0 161.0 169.0 163.0 165.0 166.0 167.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.50 stddev:31.06 (41.1%) stddev-sans-first:32.76 02:58:16 INFO - PID 30155 | Values: 78.0 75.0 74.0 174.0 75.0 78.0 74.0 75.0 95.0 76.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:82.00 stddev:22.74 (27.7%) stddev-sans-first:23.59 02:58:16 INFO - PID 30155 | Values: 83.0 82.0 130.0 82.0 83.0 82.0 125.0 83.0 82.0 133.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:58:16 INFO - PID 30155 | Values: 113.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 02:58:16 INFO - PID 30155 | Values: 149.0 151.0 149.0 150.0 150.0 151.0 150.0 150.0 149.0 153.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:58:16 INFO - PID 30155 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.73 02:58:16 INFO - PID 30155 | Values: 55.0 57.0 57.0 55.0 55.0 60.0 55.0 55.0 55.0 55.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 02:58:16 INFO - PID 30155 | Values: 55.0 54.0 54.0 54.0 55.0 54.0 53.0 55.0 54.0 55.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:3.37 (4.3%) stddev-sans-first:3.57 02:58:16 INFO - PID 30155 | Values: 78.0 76.0 87.0 78.0 80.0 76.0 79.0 77.0 76.0 76.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:128.50 stddev:12.86 (10.0%) stddev-sans-first:13.49 02:58:16 INFO - PID 30155 | Values: 127.0 134.0 127.0 127.0 127.0 129.0 128.0 124.0 132.0 168.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:184.50 stddev:6.73 (3.6%) stddev-sans-first:7.11 02:58:16 INFO - PID 30155 | Values: 186.0 198.0 190.0 181.0 183.0 189.0 178.0 182.0 180.0 175.0 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:1.73 02:58:16 INFO - PID 30155 | Values: 66.0 70.0 72.0 67.0 67.0 69.0 68.0 68.0 69.0 71.0 02:58:16 INFO - PID 30155 | -------- Summary: end -------- 02:58:16 INFO - PID 30155 | 02:58:16 INFO - PID 30155 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:58:16 INFO - TEST-INFO | 30155: exit 0 02:58:16 INFO - TEST-OK | kraken | took 61042ms 02:58:16 INFO - SUITE-END | took 1172s 02:58:17 INFO - Completed test suite (00:19:33) 02:58:17 INFO - javascript benchmark 02:58:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8366.374947188351, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.5901953236307, 3063.958254193574, 3124.5781819454382, 3129.9687003129975, 3137.3097918457947, 6098.17674613927, 6145.293291271505, 6152.3540028297, 6174.197354343929, 6197.194364732579, 6094.664793436359, 6179.814605561829, 6225.221847269091, 6252.0, 6290.402411770886, 5672.092465205568, 5675.2054712340205, 5689.0, 5717.714114294289, 5764.25064741583, 5644.858878528049, 5650.434956504358, 5653.689047102408, 5696.971515142419, 5711.086226203808, 5484.506394424481, 5555.833325000216, 5567.777288908459, 5571.359293681217, 5660.943390566083, 5539.806106786243, 5557.221988921554, 5564.443555644443, 5579.358373787026, 5584.5253153482, 5462.8361149165585, 5528.9723551382385, 5550.333959924835, 5553.750081246354, 5555.722213889289, 5968.343482216953, 6001.129836173774, 6006.549508786815, 6011.0382338825575, 6015.428534289235, 6462.095306657072, 6507.381798729113, 6516.77191298307, 6522.5760325578685, 6556.93443065568, 6593.406593406568, 6598.175228096488, 6611.702473388709, 6613.173353330833, 6615.4046135848, 6083.482903953125, 6099.085137229406, 6148.354422785633, 6154.415330543591, 6157.261128664589, 6765.830854228585, 6791.830204244933, 6857.7256909723055, 6867.622280774605, 6898.379145876896, 6258.468030217391, 6414.358564143642, 6477.384648458389, 6517.934820651828, 6536.411722944863, 6527.0, 6569.507286953498, 6580.703868325937, 6581.769638062645, 6589.209294884548, 6504.544681872224, 6516.674166291761, 6524.249711283263, 6524.988626762859, 6538.934610653928, 5521.834344969658, 6367.140436041168, 6581.0, 6668.033135195369, 6680.0981867448245, 5336.810255593592, 5350.91973620396, 5410.3507579090765, 5432.239486471897, 5438.755256013489, 4503.459584849774, 4584.0, 4609.631229501631, 4612.308153776893, 4647.395838540968, 5599.860003499945, 5675.716214189274, 5677.290338707661, 5681.517071049007, 5684.8294551163535, 6520.836979075466, 6554.934450655433, 6568.901466478007, 6571.671416429255, 6581.0, 5681.744321505542, 5695.487406133385, 5733.913991290134, 5765.4811067004175, 5776.42235776419, 5858.2677165354335, 5867.656153370439, 5927.347991720907, 5942.7920022799, 5945.791897283574, 6242.875142497124, 6351.904721429275, 6361.522885783585, 6435.0, 6518.185226846645, 6570.8028759137305, 6575.24384695747, 6582.736690532517, 6586.967065164644, 6587.308332625005, 6304.810855674337, 6377.808665740035, 6378.6810659467765, 6380.298167201511, 6399.7440102395385, 6328.493720502441, 6383.39357761012, 6425.06836508713, 6445.935540644534, 6453.580517266362, 6552.246491653521, 6559.639219842955, 6585.440237579859, 6625.138731964814, 6647.0, 6337.683115844282, 6344.68276586178, 6435.935640643721, 6450.9354906450335, 6453.709583068679, 6298.11826344303, 6300.432961033529, 6309.2744334400295, 6402.135711678864, 6411.839704007437, 6289.433950944437, 6324.588901721373, 6334.398232167937, 6338.176037115146, 6342.0, 5542.528885044816, 6360.713767880364, 6377.266614339411, 6382.329855365306, 6451.096846441408, 6005.729742161526, 6123.785667501616, 6127.785527506516, 6139.079138129317, 6148.723307451086], "value": 5980.437344010647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5877267502872, 808.4785313472814, 846.8137009857832, 867.6876324523166, 868.1665601023019, 42458.0, 43479.56520434795, 43504.56495435045, 43570.0, 43661.56338436615, 39426.8028659857, 39489.0, 39545.0, 39571.60428395715, 39596.40605390922, 6907.378335949764, 7015.158181018285, 7039.225685174627, 7040.29597040297, 7056.929430705679, 6928.480363972697, 6987.68555415005, 7008.474364422663, 7014.859702805941, 7017.929820701805, 6996.930030699704, 7012.298770122998, 7013.929860701379, 7017.438604911595, 7018.298170182967, 6938.722451101949, 6942.340477654615, 6951.096357473496, 6954.37410633043, 6981.197162326347, 6342.143810585604, 6343.682815859234, 6359.300476947532, 6359.395857393541, 6384.968075159594, 35040.82479587611, 35155.64844351549, 35203.64796352029, 35242.29515409703, 35322.823385883166, 3359.6808303211155, 3400.0309911675054, 3410.658934106594, 3565.3760591896316, 3631.6731494165388, 32821.343573128644, 33356.6664333356, 33555.32889342224, 33563.83218083894, 33565.328693425996, 4915.21356582945, 4950.381202349707, 4980.800767969277, 4988.102141614508, 5071.974640126813, 197625.0, 201785.0, 202285.0, 207544.0, 208488.0, 44947.10105797866, 50249.0, 51292.23061654078, 51362.74318628383, 51690.70773230699, 53867.19199211936, 54343.72828135834, 54460.72769636127, 54505.727471363185, 54552.181717274274, 16751.497455076365, 16762.329506819835, 16836.0, 16889.831101689073, 16897.57756056084, 13950.441982320797, 14046.0, 14058.297085145701, 14065.789013164811, 14067.71864562703, 14222.431102755774, 14242.643933901736, 14254.360748513845, 14322.283885805668, 14386.85613143876, 5652.0718100920285, 5685.0, 5687.459691329317, 5805.303363596396, 5819.970900145472, 981.5141504955093, 998.3061772068343, 1021.1014307409432, 1048.4652827058255, 1053.7839742852698, 23243.883780581327, 23575.292741217792, 23617.88191059068, 23662.29013129609, 23780.048798048232, 1108.451316598289, 1114.1810769084716, 1131.9434028298551, 1138.6584024792694, 1146.2148428326623, 12089.214201076902, 12404.25574465535, 12434.440450179764, 12456.626301210978, 12487.625371238877, 230394.0, 230730.0, 230773.0, 230832.0, 231225.0, 55396.446035539935, 55744.72127639336, 56045.0, 56056.43943560512, 56289.15566266509, 1469.2139705257637, 1513.1072667126227, 1515.0758037597057, 1515.9166245856363, 1516.1282262698992, 22860.657090143995, 23358.532829343658, 23626.409339766644, 27793.44413111686, 28862.0, 53902.460975389746, 54177.0, 54586.727066364416, 54618.453815462926, 54712.0, 213741.0, 217952.0, 218181.0, 218669.0, 219038.0, 36932.63067369292, 37555.0, 37904.052398690255, 38375.42436863393, 38454.0, 43608.56391436172, 46136.53863461457, 46240.768796155804, 46307.53692463032, 46803.765981169876, 33042.33915321728, 33342.49986250257, 33733.662663373056, 33963.830180848934, 34102.658973410944, 33124.503132453516, 33318.50022249619, 33422.0, 33478.83260583682, 33514.329713406085, 35369.64630353663, 36855.63144368522, 36882.262354752216, 36987.63012369842, 37313.81343093267, 29628.40743185081, 31420.842895785376, 31845.840770795996, 32379.35241295114, 32651.18372040718, 23397.88301058484, 23788.88105559461, 23830.285091447284, 23982.52034959256, 24328.635070474313], "value": 17437.372502779916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4979617936218, 576.3372122059634, 578.2511647416595, 583.3466517500399, 603.2971588099863, 22354.88822555887, 22407.103715851346, 23345.649815252742, 23417.297481075573, 23468.64797028046, 26442.867785661092, 27241.86379068107, 27242.863785681046, 27253.72746272537, 27311.317217069583, 6417.101605775195, 6571.244306904719, 6577.7368905243975, 6593.142891424132, 6605.570637908545, 3955.189186216833, 6568.93431065688, 6645.767398141066, 6646.368594983469, 6654.134962454898, 5528.944710552883, 6587.242467116271, 6591.5056370772145, 6593.769218077368, 6665.300143484913, 6582.605043697369, 6588.176477940257, 6597.2083349998065, 6610.570312929644, 6618.238902526223, 6093.238345206849, 6127.846803829895, 6147.231596050494, 6157.2919114301985, 6166.506679465632, 28105.156845294674, 30111.09666710002, 30182.54726179109, 30269.24326891823, 30618.387632247453, 1884.123882394693, 1932.9806701932941, 1935.680612698903, 1936.883786972786, 1940.1075505267595, 18930.52673683155, 19245.615087698166, 19344.41966741, 19381.321653742194, 19500.0, 2181.214762685432, 2189.0805861538192, 2238.1271304191378, 2241.69737085493, 2263.909443622253, 137427.0, 141020.29489852587, 141219.29390353087, 141307.0, 141479.0, 14501.709965800625, 14643.194624295766, 14856.851431485762, 14985.625359366102, 15228.695426091415, 24086.63870041951, 24177.153799616928, 24201.273961781175, 24226.51546969051, 24285.635715464283, 10398.58405663765, 10410.115140213014, 10450.320729152581, 10485.652317318223, 10754.032137107697, 9841.163501102343, 9879.604815807432, 9883.209343252667, 9893.65372211969, 10048.14590759779, 8758.525921299188, 9224.354295199271, 9234.953825230965, 9278.257739380833, 9551.331406801597, 2793.3296008957705, 2803.159052284347, 2861.728135827093, 2866.4123854609757, 2904.622399088147, 950.458238803889, 966.0050148347214, 972.027972027972, 974.2644303550774, 975.878015248094, 19468.61062778765, 19928.0, 20064.89967550153, 20108.497287567927, 20232.89883550602, 1021.1728499915092, 1046.1369370269558, 1048.4233671480656, 1054.330500132406, 1060.0, 10884.673459796219, 10973.28673636227, 11192.608258710907, 11203.271787333797, 11322.547098116147, 513711.0, 530586.0, 537662.0, 546001.0, 547816.0, 116440.0, 123799.38100309442, 123867.0, 124054.37972810259, 128094.35952820176, 1278.7186818900013, 1280.4366078925243, 1325.754735373959, 1329.7872340425486, 1333.5532596580254, 19590.314338998065, 20566.897165514078, 20864.165433382495, 20891.582168356243, 21185.788142119, 54918.0, 56421.0, 57292.0, 57397.426025740875, 57911.420885792286, 71191.28808712054, 71537.0, 72399.63800180965, 72520.0, 72774.0, 14348.641283967567, 14390.85609143895, 14544.27278636085, 14618.342174601956, 14942.103473791607, 23211.76788232096, 23662.763372366746, 23704.525909482058, 23834.40413989595, 24049.0, 18518.16668249905, 18642.906785465984, 18662.81337186611, 18745.0, 18982.810171898105, 16025.599360015627, 16826.747598786274, 16879.156042198087, 17139.228734706718, 17565.648687026445, 19032.953187574818, 19294.517637059187, 19350.32273870408, 19382.321618743277, 19526.414207573795, 14200.43198272099, 14556.49052283165, 14686.63283417923, 14966.102033878002, 15102.39590416371, 18590.628187435905, 18850.71723924115, 18863.811361886754, 18924.905375473034, 18945.526361841064], "value": 12182.89429305102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.3133801761103, 1379.5930200590824, 1399.8180236569244, 1401.8738313551783, 1403.9298035098243, 13419.597412077641, 14069.71860562788, 14192.574222773308, 14211.289435528233, 14227.075240109385, 13637.386317615707, 14470.927645361784, 14539.418423263083, 14554.0, 14608.926955365208, 2616.869156542175, 2678.7723043541323, 2680.9463810723773, 2685.5434576122107, 2688.9731102689016, 2587.8964841406323, 2630.0794721847296, 2646.073874144053, 2651.920442386722, 2653.230563136688, 2519.86140762258, 2559.436923876744, 2617.8952841886303, 2627.6978147512996, 2639.5644718621406, 2676.5985102234627, 2688.1801050679537, 2691.663542057233, 2693.0305090167526, 2694.0705456617434, 2563.115725074846, 2594.2736033910537, 2604.348912771807, 2604.791616670662, 2609.4781043791127, 13528.526501572496, 13859.23774192419, 13864.861351386458, 13880.0, 13885.305734713224, 7266.128064632225, 7422.665980030912, 7503.324700776901, 7521.811954701122, 7522.736704215381, 4966.566382472599, 5131.486851314876, 5266.131088370415, 5269.789208431658, 5278.577713782888, 1780.4836597386743, 1785.2504545545307, 1813.1750053725523, 1849.9815001849943, 1851.6296740651924, 21925.561488770294, 22127.778722212894, 22399.32802015942, 22445.775542244693, 22459.55080898389, 6210.31686514483, 6243.40687634683, 6261.248650161919, 6396.9360306397275, 6437.195350581177, 15303.38786448552, 15325.157116358485, 15328.693426131638, 15331.693366132838, 15399.769003464957, 7182.209956904736, 7386.815329616695, 7403.407727381797, 7440.4419668524, 7456.254374562609, 6748.595084294958, 6794.490413219029, 6956.930430695628, 6969.721211151598, 7032.718691252293, 4752.500987396343, 4933.925991110136, 4959.404871415453, 4997.525235102732, 5029.044481548494, 1416.8653977872086, 1444.1407362619225, 1454.941802327895, 1468.875145612635, 1481.029925398844, 847.7922908887363, 858.5492616376453, 873.218469469821, 875.4615911214557, 898.8427025270682, 8156.388270879707, 8388.245057944814, 8394.412391132562, 8470.830583388297, 8633.481991080555, 940.7130825098274, 974.2352253480983, 1024.99487502562, 1030.2324768047852, 1033.9298825715348, 5485.780568777284, 5523.0, 5601.355844077902, 5608.214849921014, 5663.150527420919, 18253.726194107097, 19070.61858762817, 19112.904435477732, 19209.32767353136, 19303.0, 18147.364842230458, 18632.90683546601, 18841.90579047096, 18957.336493222672, 18965.62068758645, 10259.384436933808, 10832.783344333227, 10878.075363594025, 10924.563017479371, 11017.504212310465, 7327.487075904849, 8093.797655058671, 8159.755207343789, 8226.753197404087, 8364.539950302791, 15592.205394346076, 16043.197840108181, 16177.4337898173, 16436.506904792874, 16617.75073373876, 16062.19689015568, 16075.035497870165, 16297.59256018609, 16377.344906203618, 17057.573560661083, 10999.0, 11158.49786759614, 11275.379854108103, 11325.0, 11336.716582085513, 12782.0, 12816.102872798814, 12874.356282185667, 12888.291143987171, 12959.35203239853, 10217.795644087226, 10471.476426178508, 10591.682249532527, 10695.94652026766, 11105.777884442428, 8901.421407608485, 9412.01173876733, 10037.498125093862, 10505.0, 10725.356478611307, 8951.0, 9202.171804537624, 9215.49314787693, 9278.95360523193, 9434.905650943403, 6697.727431788139, 6716.731330746716, 6892.793216203522, 6902.8619427612175, 7196.0285361475535, 6676.799696009128, 6679.219008953281, 6797.422219111431, 6806.149231346082, 6900.068490753884], "value": 6297.641057048766, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.68841285783515, 503.3908970146124, 520.4171328112515, 526.0504788856114, 529.190338781664, 6104.877902441954, 6135.785247516338, 6185.752569897199, 6186.597871138373, 6191.823553524827, 5853.5902486825935, 5906.734196961136, 5921.253230297062, 5952.345242023384, 6086.634801911889, 4833.226683730604, 4879.219324907997, 4888.608911287089, 4912.606991440676, 4935.210366341386, 4863.562279394854, 4866.343043689109, 4878.9268160977435, 4880.731559764212, 4952.059108769322, 4857.10143623429, 4899.877503062434, 4902.411710594733, 4921.311016457699, 4926.45808961014, 4577.679562430648, 4770.618350531984, 4770.976145119287, 4788.688735232234, 4837.379477874916, 4236.237477254093, 4303.526612072669, 4303.621656999272, 4310.956890431118, 4332.631726303268, 5838.649681019152, 5847.8012007538355, 5860.267466566679, 5911.201987731644, 5915.0, 5482.424345443711, 5521.757604538987, 5527.695976721278, 5552.750126244328, 5555.361133469622, 6350.491960643184, 6405.967970160119, 6407.935920640781, 6436.967815160941, 6464.900966835602, 4747.548982846624, 4753.595944344735, 4779.426468823764, 4783.162946484386, 4784.904301913977, 6693.598384096969, 6694.732210711614, 6763.898541521881, 6823.795286141374, 6825.829354266133, 4963.6277279204205, 4982.626303027288, 4985.476524964899, 4994.8251811187165, 5025.899482010339, 5037.697738135724, 5038.3198268234055, 5059.19052951526, 5077.339945807022, 5079.7300674831295, 5575.553955683536, 5589.133684278943, 5599.888002239933, 5602.0, 5607.6261315977845, 6346.238451385863, 6392.20097487814, 6406.2953075161695, 6414.903776443357, 6450.161479007699, 1728.6369862329052, 1737.852282555997, 1748.5366377909863, 1752.4392194497639, 1766.143420441085, 1134.143721490286, 1214.3624597086423, 1220.4751956658722, 1222.584321330752, 1224.3349045298387, 5473.38535132137, 5595.328560572757, 5634.802781902614, 5646.57650676201, 5649.090718280089, 6432.871342573216, 6618.106555614931, 6693.431058359996, 6701.497387695845, 6705.497087718343, 5601.29983752031, 5636.718164091861, 5637.43625637433, 5679.659220446786, 5697.772089116472, 3492.89521314361, 3500.579930408367, 3515.6660117288816, 3525.312564050037, 3533.3110043541265, 6301.6219026858535, 6321.65230912295, 6376.681165941777, 6426.690254518927, 6438.871222575523, 6601.062527175361, 6748.865022699519, 6755.662216889136, 6779.559328643622, 6826.078479405316, 6396.360363963567, 6409.7115629795835, 6428.228612566522, 6473.935260647428, 6488.0, 6585.242697089704, 6620.3710647488415, 6629.7348106075215, 6643.833904152435, 6668.999650052531, 6533.431976325743, 6533.542652014314, 6573.3098024706715, 6589.924173885211, 6605.834854128685, 6296.748130074746, 6340.175777148941, 6376.585521941059, 6378.45783108441, 6400.839979000562, 4815.22956326986, 4847.497275844499, 4878.243872199815, 4912.95087049125, 4942.207652676227, 6538.411542961157, 6557.967210163919, 6566.474682025331, 6612.867742645024, 6633.800985970429, 6225.626462412089, 6302.180716506825, 6326.873462530815, 6402.0, 6423.394151462135, 6348.555601107878, 6364.586301890362, 6443.548951573345, 6447.387498187664, 6448.838779030561, 6332.240131184288, 6332.968335158294, 6360.872782544231, 6395.136656551492, 6412.9358706414205, 5736.254286942671, 6363.745450181941, 6368.808935731936, 6413.4869210463985, 6445.838854028687, 6103.511719062376, 6169.537284703575, 6196.287426945959, 6209.906851397142, 6255.624662520263], "value": 4954.352757881595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.3715830339611, 891.4740303221098, 892.9062448442913, 899.2760827533837, 911.4759013567199, 17392.391266305684, 17830.108494575266, 17936.730949035777, 17987.010714410702, 19930.302439414623, 19866.205351785946, 19952.102155403005, 19960.800391996076, 19980.100895459702, 20020.399388018348, 990.257307019737, 1049.8162821506244, 1055.8680164979378, 1059.0256963593474, 1065.8081545321838, 1034.57065317893, 1050.669039252633, 1056.3345092591655, 1057.6509751781932, 1058.095328494138, 1096.736783172041, 1109.6504601050683, 1115.4924509348227, 1116.7264020314994, 1119.065580240496, 990.7869807991317, 1037.6575730009154, 1096.1888202730001, 1111.016750176096, 1111.4442778610694, 794.8251384695358, 794.8966634337557, 795.6578671171394, 795.8686816675241, 796.9043714754208, 15684.529464116094, 15788.921055394765, 15856.207189640587, 15931.840681593152, 15940.442084526985, 17984.640307193913, 18523.07384630763, 18628.627427451374, 18632.347867824697, 18861.05694715259, 14960.476383326532, 15422.460213892573, 15457.072575645385, 15482.148481833494, 15808.288627011698, 3440.415129428003, 3444.225049363898, 3459.550258466383, 3461.0828130545424, 3465.480177973299, 105695.47152264189, 106742.0, 113088.43455782751, 116050.0, 119489.40255298755, 14288.142711437347, 14353.497627582985, 14530.128192308495, 14647.0, 14693.0, 27419.725802742116, 27852.72147278542, 28015.299617509725, 28050.579241311396, 28065.579016314772, 7935.325497332791, 8231.09457959624, 8274.710385136492, 8281.047679516812, 8380.329573634095, 3463.6363181866045, 3508.807015614115, 3667.468217108504, 3675.9816200918826, 3686.7972261525338, 4734.857954261378, 4861.1006963711825, 4862.367892173995, 4890.021995600894, 4904.313396124546, 963.0754475703403, 985.571276494727, 997.3068717241592, 1018.6383833738915, 1025.9076683098558, 635.8187916443791, 640.1677818835495, 661.3188415931598, 674.0832467843728, 685.533836990851, 10676.0, 11443.210930828498, 11504.884951150549, 11743.88256117445, 11834.467448964646, 651.6285717141184, 693.2409012131708, 698.1656919980676, 699.6466784274011, 704.2218348724688, 5036.294918711384, 5151.943851510431, 5152.355955505562, 5152.562032227228, 5179.663321884065, 97286.51356743312, 99356.50321748489, 99377.50311248397, 99703.50148249212, 101934.0, 85562.57218713866, 87653.0, 90158.54920725485, 90635.0, 91064.5446772762, 74422.62788686022, 74461.25538744543, 76759.61620191863, 78243.0, 78572.0, 11269.887301126884, 11632.651020469399, 11683.299002059903, 11809.291442513477, 11864.466099025738, 34109.48835767515, 35028.64971350356, 35274.470882936264, 36220.0, 37660.0, 46945.06109877852, 47551.52448475471, 65862.85219573742, 65875.0, 67620.22761563149, 18197.909010454863, 18202.271909124018, 18264.269429223215, 18455.07724613791, 18523.259069637603, 19804.0, 20220.39338819838, 20262.18951241934, 20826.791732083093, 20831.791682082985, 17800.55498612545, 17933.820661793216, 18094.819051809314, 18265.08674566293, 18718.344857929907, 17330.30678772835, 17764.378246761302, 17952.91023544874, 17972.370967016093, 17988.730169047212, 15315.846841531442, 15462.917595768187, 15984.920075399548, 16640.75038874442, 16679.08265045434, 12166.270023798601, 13081.67295817574, 13266.668333291746, 13414.195148290743, 13458.192508449525, 13465.663358416117, 13499.122557033761, 14238.359273832495, 14273.64315892111, 14399.0], "value": 8650.99611882731, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 108.0, 108.0, 110.0, 106.0, 108.0, 109.0, 111.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 147.0, 186.0, 123.0, 149.0, 149.0, 123.0, 171.0, 119.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 163.0, 161.0, 169.0, 163.0, 165.0, 166.0, 167.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 174.0, 75.0, 78.0, 74.0, 75.0, 95.0, 76.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 130.0, 82.0, 83.0, 82.0, 125.0, 83.0, 82.0, 133.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 150.0, 150.0, 151.0, 150.0, 150.0, 149.0, 153.0], "value": 150.2, "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, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 55.0, 55.0, 60.0, 55.0, 55.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 53.0, 55.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 87.0, 78.0, 80.0, 76.0, 79.0, 77.0, 76.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 127.0, 127.0, 127.0, 129.0, 128.0, 124.0, 132.0, 168.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 198.0, 190.0, 181.0, 183.0, 189.0, 178.0, 182.0, 180.0, 175.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 72.0, 67.0, 67.0, 69.0, 68.0, 68.0, 69.0, 71.0], "value": 68.7, "unit": "score"}]}]} 02:58:17 INFO - Return code: 0 02:58:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:58:17 INFO - # TBPL SUCCESS # 02:58:17 INFO - Running post-action listener: _package_coverage_data 02:58:17 INFO - Running post-action listener: _resource_record_post_action 02:58:17 INFO - [mozharness: 2017-07-16 09:58:17.567095Z] Finished run-tests step (success) 02:58:17 INFO - Running post-run listener: _resource_record_post_run 02:58:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437694464; Read time: 8; Write time: 295736 02:58:17 INFO - TinderboxPrint: CPU usage
13.1% 02:58:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:58:17 INFO - TinderboxPrint: I/O write bytes / time
437,694,464 / 295,736 02:58:17 INFO - TinderboxPrint: CPU idle
8,252.3 (86.9%) 02:58:17 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 02:58:17 INFO - TinderboxPrint: Swap in / out
0 / 0 02:58:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107393024; Read time: 0; Write time: 107768 02:58:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:58:17 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 330301440; Read time: 0; Write time: 187968 02:58:18 INFO - Running post-run listener: _upload_blobber_files 02:58:18 INFO - Blob upload gear active. 02:58:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:58:18 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 02:58:18 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'] 02:58:18 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 02:58:18 INFO - Traceback (most recent call last): 02:58:18 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 02:58:18 INFO - main() 02:58:18 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 02:58:18 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 02:58:18 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 02:58:18 INFO - return set(response.json().get('whitelist', [])) 02:58:18 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 02:58:18 INFO - return json.loads(self.text or self.content, **kwargs) 02:58:18 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 02:58:18 INFO - return _default_decoder.decode(s) 02:58:18 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 02:58:18 INFO - obj, end = self.raw_decode(s) 02:58:18 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 02:58:18 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 02:58:18 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 02:58:18 ERROR - Return code: 1 02:58:18 INFO - Setting buildbot property blobber_files to {} 02:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:58:18 INFO - Contents: 02:58:18 INFO - blobber_files:{} 02:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:58:18 INFO - Copying logs to upload dir... 02:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.030133 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-16 02:58:16.365051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 02:58:16.368890) ========= 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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/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-16 02:58:16.424036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:58:16.424847) ========= 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=ed14279e38b05397cf4aa391000001a4-1500180379.680447-397969535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:58:16.479904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:58:16.480719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:58:16.481433) ========= ========= Total master_lag: 0.18 =========