builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1498192663.43 results: success (0) revision: 7455c74d833a9db4e02be17eda14588c7ef0de76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.434894) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.435479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.435797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.452563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.452866) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-22 21:37:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.8M=0s 2017-06-22 21:37:43 (54.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139763 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.631808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.632162) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016749 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.681496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:43.681867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7455c74d833a9db4e02be17eda14588c7ef0de76 --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 7455c74d833a9db4e02be17eda14588c7ef0de76 --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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-22 21:37:43,478 truncating revision to first 12 chars 2017-06-22 21:37:43,478 Setting DEBUG logging. 2017-06-22 21:37:43,478 attempt 1/10 2017-06-22 21:37:43,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7455c74d833a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-22 21:37:43,917 unpacking tar archive at: mozilla-central-7455c74d833a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:44.494187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:44.494969) ========= script_repo_revision: 7455c74d833a9db4e02be17eda14588c7ef0de76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:44.496000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:44.496687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 21:37:44.507259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-06-22 21:37:44.507584) ========= /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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:37:44 INFO - MultiFileLogger online at 20170622 21:37:44 in /builds/slave/test 21:37:44 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 21:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:37:44 INFO - {'append_to_log': False, 21:37:44 INFO - 'base_work_dir': '/builds/slave/test', 21:37:44 INFO - 'blob_upload_branch': 'Firefox', 21:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:37:44 INFO - 'branch': 'Firefox', 21:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:37:44 INFO - 'config_files': ('talos/linux_config.py',), 21:37:44 INFO - 'default_actions': ('clobber', 21:37:44 INFO - 'read-buildbot-config', 21:37:44 INFO - 'download-and-extract', 21:37:44 INFO - 'populate-webroot', 21:37:44 INFO - 'create-virtualenv', 21:37:44 INFO - 'install', 21:37:44 INFO - 'setup-mitmproxy', 21:37:44 INFO - 'run-tests'), 21:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:37:44 INFO - 'download_minidump_stackwalk': True, 21:37:44 INFO - 'download_symbols': 'ondemand', 21:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 21:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 21:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:37:44 INFO - 'gecko_profile': False, 21:37:44 INFO - 'gecko_profile_interval': 0, 21:37:44 INFO - 'installer_path': 'installer.exe', 21:37:44 INFO - 'log_level': 'info', 21:37:44 INFO - 'log_name': 'talos', 21:37:44 INFO - 'log_to_console': True, 21:37:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:37:44 INFO - 'opt_config_files': (), 21:37:44 INFO - 'pip_index': False, 21:37:44 INFO - 'suite': 'dromaeojs-e10s', 21:37:44 INFO - 'system_bits': '32', 21:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:37:44 INFO - 'title': 'talos-linux64-ix-036', 21:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:37:44 INFO - 'use_talos_json': True, 21:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:37:44 INFO - 'work_dir': 'build'} 21:37:44 INFO - [mozharness: 2017-06-23 04:37:44.523108Z] Running clobber step. 21:37:44 INFO - Running pre-action listener: _resource_record_pre_action 21:37:44 INFO - Running main action method: clobber 21:37:44 INFO - rmtree: /builds/slave/test/build 21:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:37:45 INFO - Running post-action listener: _resource_record_post_action 21:37:45 INFO - [mozharness: 2017-06-23 04:37:45.567145Z] Finished clobber step (success) 21:37:45 INFO - [mozharness: 2017-06-23 04:37:45.567245Z] Running read-buildbot-config step. 21:37:45 INFO - Running pre-action listener: _resource_record_pre_action 21:37:45 INFO - Running main action method: read_buildbot_config 21:37:45 INFO - Using buildbot properties: 21:37:45 INFO - { 21:37:45 INFO - "project": "", 21:37:45 INFO - "product": "firefox", 21:37:45 INFO - "who": "philringnalda@gmail.com", 21:37:45 INFO - "installer_path": "public/build/target.tar.bz2", 21:37:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 21:37:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:37:45 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 21:37:45 INFO - "stage_platform": "linux64-stylo", 21:37:45 INFO - "basedir": "/builds/slave/test", 21:37:45 INFO - "buildnumber": 169, 21:37:45 INFO - "platform": "ubuntu64_hw_stylo", 21:37:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:37:45 INFO - "slavebuilddir": "test", 21:37:45 INFO - "taskId": "GaYlqJeDRxuUEuROVP8LSg", 21:37:45 INFO - "branch": "mozilla-central", 21:37:45 INFO - "script_repo_revision": "production", 21:37:45 INFO - "revision": "7455c74d833a9db4e02be17eda14588c7ef0de76", 21:37:45 INFO - "slavename": "talos-linux64-ix-036", 21:37:45 INFO - "repo_path": "mozilla-central" 21:37:45 INFO - } 21:37:45 INFO - Finding installer, test and symbols from parent task. 21:37:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaYlqJeDRxuUEuROVP8LSg'}, attempt #1 21:37:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaYlqJeDRxuUEuROVP8LSg'}, attempt #1 21:37:46 INFO - Task dependencies: W9j5yHgZQaeyrWT3vlLonw 21:37:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw'}, attempt #1 21:37:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 21:37:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/test_packages.json 21:37:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.crashreporter-symbols.zip 21:37:46 INFO - Running post-action listener: _resource_record_post_action 21:37:46 INFO - [mozharness: 2017-06-23 04:37:46.918362Z] Finished read-buildbot-config step (success) 21:37:46 INFO - [mozharness: 2017-06-23 04:37:46.918582Z] Running download-and-extract step. 21:37:46 INFO - Running pre-action listener: _resource_record_pre_action 21:37:46 INFO - Running main action method: download_and_extract 21:37:46 INFO - mkdir: /builds/slave/test/build/tests 21:37:46 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')]} 21:37:46 INFO - trying https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.test_packages.json 21:37:46 INFO - Downloading https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:37:47 INFO - Downloaded 989 bytes. 21:37:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:37:47 INFO - Using the following test package requirements: 21:37:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:37:47 INFO - u'common': [u'target.common.tests.zip'], 21:37:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:37:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:37:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:37:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:37:47 INFO - u'mozbase': [u'target.common.tests.zip'], 21:37:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:37:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:37:47 INFO - u'web-platform': [u'target.common.tests.zip', 21:37:47 INFO - u'target.web-platform.tests.tar.gz'], 21:37:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:37:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:37:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip 21:37:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:37:47 INFO - Fetch https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip into memory 21:37:48 INFO - Content-Length response header: 67975169 21:37:48 INFO - Bytes received: 67975169 21:38:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:38:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip 21:38:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:38:00 INFO - Fetch https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.common.tests.zip into memory 21:38:01 INFO - Content-Length response header: 67975169 21:38:01 INFO - Bytes received: 67975169 21:38:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.talos.tests.zip 21:38:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:38:15 INFO - Fetch https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.talos.tests.zip into memory 21:38:15 INFO - Content-Length response header: 14441306 21:38:15 INFO - Bytes received: 14441306 21: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')]} 21:38:16 INFO - trying https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 21:38:16 INFO - Downloading https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:38:17 INFO - Downloaded 61725721 bytes. 21:38:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 21:38:17 INFO - mkdir: /builds/slave/test/properties 21:38:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:17 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:17 INFO - Contents: 21:38:17 INFO - build_url:https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 21:38:17 INFO - Running post-action listener: _resource_record_post_action 21:38:17 INFO - Running post-action listener: set_extra_try_arguments 21:38:17 INFO - [mozharness: 2017-06-23 04:38:17.193553Z] Finished download-and-extract step (success) 21:38:17 INFO - [mozharness: 2017-06-23 04:38:17.193649Z] Running populate-webroot step. 21:38:17 INFO - Running pre-action listener: _resource_record_pre_action 21:38:17 INFO - Running main action method: populate_webroot 21:38:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:17 INFO - '--tppagecycles', 21:38:17 INFO - '7'], 21:38:17 INFO - 'tests': ['tsvgm']}}, 21:38:17 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['damp', 'tps']}, 21:38:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'tests': ['damp', 'tps']}, 21:38:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['dromaeo_dom']}, 21:38:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:38:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:38:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:38:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['a11yr', 21:38:17 INFO - 'ts_paint', 21:38:17 INFO - 'tpaint', 21:38:17 INFO - 'sessionrestore', 21:38:17 INFO - 'sessionrestore_no_auto_restore', 21:38:17 INFO - 'tabpaint']}, 21:38:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:38:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:38:17 INFO - 'bloom_basic_ref']}, 21:38:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:38:17 INFO - 'talos_options': ['--mitmproxy', 21:38:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:38:17 INFO - '--firstNonBlankPaint'], 21:38:17 INFO - 'tests': ['quantum_pageload_google', 21:38:17 INFO - 'quantum_pageload_youtube', 21:38:17 INFO - 'quantum_pageload_amazon', 21:38:17 INFO - 'quantum_pageload_facebook']}, 21:38:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['tsvgx', 21:38:17 INFO - 'tsvgr_opacity', 21:38:17 INFO - 'tart', 21:38:17 INFO - 'tscrollx', 21:38:17 INFO - 'cart', 21:38:17 INFO - 'tsvg_static']}, 21:38:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:17 INFO - 'tsvgr_opacity', 21:38:17 INFO - 'tart', 21:38:17 INFO - 'tscrollx', 21:38:17 INFO - 'cart', 21:38:17 INFO - 'tsvg_static']}, 21:38:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'talos_options': ['--disable-e10s'], 21:38:17 INFO - 'tests': ['tp5o']}, 21:38:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:38:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'talos_options': ['--disable-e10s', 21:38:17 INFO - '--xperf_path', 21:38:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:17 INFO - 'tests': ['tp5n']}, 21:38:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:38:17 INFO - 'talos_options': ['--xperf_path', 21:38:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:17 INFO - 'tests': ['tp5n']}}, 21:38:17 INFO - 'talos.zip': {'path': '', 21:38:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:17 INFO - Running post-action listener: _resource_record_post_action 21:38:17 INFO - [mozharness: 2017-06-23 04:38:17.208579Z] Finished populate-webroot step (success) 21:38:17 INFO - [mozharness: 2017-06-23 04:38:17.208669Z] Running create-virtualenv step. 21:38:17 INFO - Running pre-action listener: _resource_record_pre_action 21:38:17 INFO - Running main action method: create_virtualenv 21:38:17 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:17 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 21:38:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:38:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:17 INFO - Using real prefix '/usr' 21:38:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:20 INFO - Installing pip.................done. 21:38:20 INFO - Return code: 0 21:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:38:20 INFO - Reading from file tmpfile_stdout 21:38:20 INFO - Output received: 21:38:20 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) 21:38:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:20 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')]} 21:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:20 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')]} 21:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:20 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:20 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 21:38:20 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 21:38:20 INFO - Using env: {'DISPLAY': ':0', 21:38:20 INFO - 'HOME': '/home/cltbld', 21:38:20 INFO - 'LANG': 'en_US.UTF-8', 21:38:20 INFO - 'LANGUAGE': 'en_US:en', 21:38:20 INFO - 'LOGNAME': 'cltbld', 21:38:20 INFO - 'MAIL': '/var/mail/cltbld', 21:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:20 INFO - 'MOZ_NO_REMOTE': '1', 21:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:20 INFO - 'NO_EM_RESTART': '1', 21:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:20 INFO - 'PWD': '/builds/slave/test', 21:38:20 INFO - 'SHELL': '/bin/bash', 21:38:20 INFO - 'SHLVL': '1', 21:38:20 INFO - 'TERM': 'linux', 21:38:20 INFO - 'TMOUT': '86400', 21:38:20 INFO - 'USER': 'cltbld', 21:38:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:20 INFO - '_': '/tools/buildbot/bin/python'} 21:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:20 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 21:38:20 INFO - Cleaning up... 21:38:21 INFO - Return code: 0 21:38:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:21 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:21 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 21:38:21 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 21:38:21 INFO - Using env: {'DISPLAY': ':0', 21:38:21 INFO - 'HOME': '/home/cltbld', 21:38:21 INFO - 'LANG': 'en_US.UTF-8', 21:38:21 INFO - 'LANGUAGE': 'en_US:en', 21:38:21 INFO - 'LOGNAME': 'cltbld', 21:38:21 INFO - 'MAIL': '/var/mail/cltbld', 21:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:21 INFO - 'MOZ_NO_REMOTE': '1', 21:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:21 INFO - 'NO_EM_RESTART': '1', 21:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:21 INFO - 'PWD': '/builds/slave/test', 21:38:21 INFO - 'SHELL': '/bin/bash', 21:38:21 INFO - 'SHLVL': '1', 21:38:21 INFO - 'TERM': 'linux', 21:38:21 INFO - 'TMOUT': '86400', 21:38:21 INFO - 'USER': 'cltbld', 21:38:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:21 INFO - '_': '/tools/buildbot/bin/python'} 21:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:21 INFO - Downloading/unpacking psutil>=3.1.1 21: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 21: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 21: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 21: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 21:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:22 INFO - Installing collected packages: psutil 21:38:22 INFO - Running setup.py install for psutil 21:38:22 INFO - building 'psutil._psutil_linux' extension 21:38:22 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 21:38:23 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 21:38:23 INFO - building 'psutil._psutil_posix' extension 21:38:23 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 21:38:23 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 21:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:23 INFO - Successfully installed psutil 21:38:23 INFO - Cleaning up... 21:38:23 INFO - Return code: 0 21:38:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:23 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')]} 21:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:23 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')]} 21:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:23 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:23 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 21:38:23 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 21:38:23 INFO - Using env: {'DISPLAY': ':0', 21:38:23 INFO - 'HOME': '/home/cltbld', 21:38:23 INFO - 'LANG': 'en_US.UTF-8', 21:38:23 INFO - 'LANGUAGE': 'en_US:en', 21:38:23 INFO - 'LOGNAME': 'cltbld', 21:38:23 INFO - 'MAIL': '/var/mail/cltbld', 21:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:23 INFO - 'MOZ_NO_REMOTE': '1', 21:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:23 INFO - 'NO_EM_RESTART': '1', 21:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:23 INFO - 'PWD': '/builds/slave/test', 21:38:23 INFO - 'SHELL': '/bin/bash', 21:38:23 INFO - 'SHLVL': '1', 21:38:23 INFO - 'TERM': 'linux', 21:38:23 INFO - 'TMOUT': '86400', 21:38:23 INFO - 'USER': 'cltbld', 21:38:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:23 INFO - '_': '/tools/buildbot/bin/python'} 21:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 21: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 21: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 21: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 21: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 21:38:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:25 INFO - Installing collected packages: mozsystemmonitor 21:38:25 INFO - Running setup.py install for mozsystemmonitor 21:38:25 INFO - Successfully installed mozsystemmonitor 21:38:25 INFO - Cleaning up... 21:38:25 INFO - Return code: 0 21:38:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21: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')]} 21:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21: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')]} 21:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21: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==2.5.1'] in /builds/slave/test/build 21: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==2.5.1 21:38:25 INFO - Using env: {'DISPLAY': ':0', 21:38:25 INFO - 'HOME': '/home/cltbld', 21:38:25 INFO - 'LANG': 'en_US.UTF-8', 21:38:25 INFO - 'LANGUAGE': 'en_US:en', 21:38:25 INFO - 'LOGNAME': 'cltbld', 21:38:25 INFO - 'MAIL': '/var/mail/cltbld', 21:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:25 INFO - 'MOZ_NO_REMOTE': '1', 21:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:25 INFO - 'NO_EM_RESTART': '1', 21:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:25 INFO - 'PWD': '/builds/slave/test', 21:38:25 INFO - 'SHELL': '/bin/bash', 21:38:25 INFO - 'SHLVL': '1', 21:38:25 INFO - 'TERM': 'linux', 21:38:25 INFO - 'TMOUT': '86400', 21:38:25 INFO - 'USER': 'cltbld', 21:38:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:25 INFO - '_': '/tools/buildbot/bin/python'} 21:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:26 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 21:38:26 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 21:38:26 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 21:38:26 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 21:38:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:26 INFO - warning: no files found matching '*.txt' 21:38:26 INFO - no previously-included directories found matching 'build' 21:38:26 INFO - no previously-included directories found matching 'dist' 21:38:26 INFO - no previously-included directories found matching '.git*' 21:38:26 INFO - Installing collected packages: jsonschema, functools32 21:38:26 INFO - Running setup.py install for functools32 21:38:26 INFO - warning: no files found matching '*.txt' 21:38:26 INFO - no previously-included directories found matching 'build' 21:38:26 INFO - no previously-included directories found matching 'dist' 21:38:26 INFO - no previously-included directories found matching '.git*' 21:38:27 INFO - Successfully installed jsonschema functools32 21:38:27 INFO - Cleaning up... 21:38:27 INFO - Return code: 0 21:38:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:27 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:27 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 21:38:27 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 21:38:27 INFO - Using env: {'DISPLAY': ':0', 21:38:27 INFO - 'HOME': '/home/cltbld', 21:38:27 INFO - 'LANG': 'en_US.UTF-8', 21:38:27 INFO - 'LANGUAGE': 'en_US:en', 21:38:27 INFO - 'LOGNAME': 'cltbld', 21:38:27 INFO - 'MAIL': '/var/mail/cltbld', 21:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:27 INFO - 'MOZ_NO_REMOTE': '1', 21:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:27 INFO - 'NO_EM_RESTART': '1', 21:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:27 INFO - 'PWD': '/builds/slave/test', 21:38:27 INFO - 'SHELL': '/bin/bash', 21:38:27 INFO - 'SHLVL': '1', 21:38:27 INFO - 'TERM': 'linux', 21:38:27 INFO - 'TMOUT': '86400', 21:38:27 INFO - 'USER': 'cltbld', 21:38:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:27 INFO - '_': '/tools/buildbot/bin/python'} 21:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:27 INFO - Cleaning up... 21:38:27 INFO - Return code: 0 21:38:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:27 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:27 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 21:38:27 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 21:38:27 INFO - Using env: {'DISPLAY': ':0', 21:38:27 INFO - 'HOME': '/home/cltbld', 21:38:27 INFO - 'LANG': 'en_US.UTF-8', 21:38:27 INFO - 'LANGUAGE': 'en_US:en', 21:38:27 INFO - 'LOGNAME': 'cltbld', 21:38:27 INFO - 'MAIL': '/var/mail/cltbld', 21:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:27 INFO - 'MOZ_NO_REMOTE': '1', 21:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:27 INFO - 'NO_EM_RESTART': '1', 21:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:27 INFO - 'PWD': '/builds/slave/test', 21:38:27 INFO - 'SHELL': '/bin/bash', 21:38:27 INFO - 'SHLVL': '1', 21:38:27 INFO - 'TERM': 'linux', 21:38:27 INFO - 'TMOUT': '86400', 21:38:27 INFO - 'USER': 'cltbld', 21:38:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:27 INFO - '_': '/tools/buildbot/bin/python'} 21:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:29 INFO - Downloading docopt-0.6.1.tar.gz 21:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:29 INFO - Running setup.py install for blobuploader 21:38:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:29 INFO - Running setup.py install for requests 21:38:29 INFO - Running setup.py install for docopt 21:38:29 INFO - Successfully installed blobuploader requests docopt 21:38:29 INFO - Cleaning up... 21:38:29 INFO - Return code: 0 21:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:29 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')]} 21:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:29 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')]} 21:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:29 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:29 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 21:38:29 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 21:38:29 INFO - Using env: {'DISPLAY': ':0', 21:38:29 INFO - 'HOME': '/home/cltbld', 21:38:29 INFO - 'LANG': 'en_US.UTF-8', 21:38:29 INFO - 'LANGUAGE': 'en_US:en', 21:38:29 INFO - 'LOGNAME': 'cltbld', 21:38:29 INFO - 'MAIL': '/var/mail/cltbld', 21:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:29 INFO - 'MOZ_NO_REMOTE': '1', 21:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:29 INFO - 'NO_EM_RESTART': '1', 21:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:29 INFO - 'PWD': '/builds/slave/test', 21:38:29 INFO - 'SHELL': '/bin/bash', 21:38:29 INFO - 'SHLVL': '1', 21:38:29 INFO - 'TERM': 'linux', 21:38:29 INFO - 'TMOUT': '86400', 21:38:29 INFO - 'USER': 'cltbld', 21:38:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:29 INFO - '_': '/tools/buildbot/bin/python'} 21:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:29 INFO - Running setup.py (path:/tmp/pip-hw1aNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:30 INFO - Running setup.py (path:/tmp/pip-6ZvYj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:30 INFO - Running setup.py (path:/tmp/pip-4yOrK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:30 INFO - Running setup.py (path:/tmp/pip-n_9HWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:30 INFO - Running setup.py (path:/tmp/pip-kofp8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:30 INFO - Running setup.py (path:/tmp/pip-OqmOjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:30 INFO - Running setup.py (path:/tmp/pip-Z8Snas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:30 INFO - Running setup.py (path:/tmp/pip-rSMMCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:30 INFO - Running setup.py (path:/tmp/pip-h3AEAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:30 INFO - Running setup.py (path:/tmp/pip-bqAkOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:30 INFO - Running setup.py (path:/tmp/pip-ogKShG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:30 INFO - Running setup.py (path:/tmp/pip-t1VDgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:30 INFO - Running setup.py (path:/tmp/pip-LAmnhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:30 INFO - Running setup.py (path:/tmp/pip-f3fOGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:30 INFO - Running setup.py (path:/tmp/pip-Efhevk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:31 INFO - Running setup.py (path:/tmp/pip-A9C8Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:31 INFO - Running setup.py (path:/tmp/pip-3ALXjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:31 INFO - Running setup.py install for manifestparser 21:38:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Running setup.py install for mozcrash 21:38:31 INFO - Running setup.py install for mozdebug 21:38:31 INFO - Running setup.py install for mozdevice 21:38:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Running setup.py install for mozfile 21:38:31 INFO - Running setup.py install for mozhttpd 21:38:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Running setup.py install for mozinfo 21:38:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Running setup.py install for mozInstall 21:38:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:31 INFO - Running setup.py install for mozleak 21:38:32 INFO - Running setup.py install for mozlog 21:38:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Running setup.py install for moznetwork 21:38:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Running setup.py install for mozprocess 21:38:32 INFO - Running setup.py install for mozprofile 21:38:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Running setup.py install for mozrunner 21:38:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Running setup.py install for mozscreenshot 21:38:32 INFO - Running setup.py install for moztest 21:38:32 INFO - Running setup.py install for mozversion 21:38:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:32 INFO - Cleaning up... 21:38:32 INFO - Return code: 0 21:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:32 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:32 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 21:38:32 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 21:38:32 INFO - Using env: {'DISPLAY': ':0', 21:38:32 INFO - 'HOME': '/home/cltbld', 21:38:32 INFO - 'LANG': 'en_US.UTF-8', 21:38:32 INFO - 'LANGUAGE': 'en_US:en', 21:38:32 INFO - 'LOGNAME': 'cltbld', 21:38:32 INFO - 'MAIL': '/var/mail/cltbld', 21:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:32 INFO - 'MOZ_NO_REMOTE': '1', 21:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:32 INFO - 'NO_EM_RESTART': '1', 21:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:32 INFO - 'PWD': '/builds/slave/test', 21:38:32 INFO - 'SHELL': '/bin/bash', 21:38:32 INFO - 'SHLVL': '1', 21:38:32 INFO - 'TERM': 'linux', 21:38:32 INFO - 'TMOUT': '86400', 21:38:32 INFO - 'USER': 'cltbld', 21:38:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:32 INFO - '_': '/tools/buildbot/bin/python'} 21:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:33 INFO - Running setup.py (path:/tmp/pip-M9YN9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:33 INFO - Running setup.py (path:/tmp/pip-TpYkQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:33 INFO - Running setup.py (path:/tmp/pip-hxnoJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:33 INFO - Running setup.py (path:/tmp/pip-CP6uf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:33 INFO - Running setup.py (path:/tmp/pip-qqoIxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:33 INFO - Running setup.py (path:/tmp/pip-GsczEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:33 INFO - Running setup.py (path:/tmp/pip-VtCMf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:33 INFO - Running setup.py (path:/tmp/pip-VAHPcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:33 INFO - Running setup.py (path:/tmp/pip-GdNuoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:33 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:33 INFO - Running setup.py (path:/tmp/pip-mMerND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 21:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:33 INFO - Running setup.py (path:/tmp/pip-HkYKnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:34 INFO - Running setup.py (path:/tmp/pip-lycpbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:34 INFO - Running setup.py (path:/tmp/pip-gExcLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:34 INFO - Running setup.py (path:/tmp/pip-Zxmlyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:34 INFO - Running setup.py (path:/tmp/pip-TAFauD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:34 INFO - Running setup.py (path:/tmp/pip-eEoREE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:34 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)) 21:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:34 INFO - Running setup.py (path:/tmp/pip-9rO6ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:34 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)) 21:38:34 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)) 21:38:34 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)) 21:38:34 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)) 21:38:34 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)) 21:38:34 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)) 21:38:34 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)) 21:38:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:34 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 21:38:34 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 21:38:34 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 21:38:34 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 21:38:35 INFO - Downloading blessings-1.6.tar.gz 21:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:35 INFO - Installing collected packages: blessings 21:38:35 INFO - Running setup.py install for blessings 21:38:35 INFO - Successfully installed blessings 21:38:35 INFO - Cleaning up... 21:38:35 INFO - Return code: 0 21:38:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:36 INFO - Reading from file tmpfile_stdout 21:38:36 INFO - Current package versions: 21:38:36 INFO - argparse == 1.2.1 21:38:36 INFO - blessings == 1.6 21:38:36 INFO - blobuploader == 1.2.4 21:38:36 INFO - docopt == 0.6.1 21:38:36 INFO - functools32 == 3.2.3-2 21:38:36 INFO - jsonschema == 2.5.1 21:38:36 INFO - manifestparser == 1.1 21:38:36 INFO - mozInstall == 1.13 21:38:36 INFO - mozcrash == 1.0 21:38:36 INFO - mozdebug == 0.1 21:38:36 INFO - mozdevice == 0.51 21:38:36 INFO - mozfile == 1.2 21:38:36 INFO - mozhttpd == 0.7 21:38:36 INFO - mozinfo == 0.10 21:38:36 INFO - mozleak == 0.1 21:38:36 INFO - mozlog == 3.4 21:38:36 INFO - moznetwork == 0.27 21:38:36 INFO - mozprocess == 0.25 21:38:36 INFO - mozprofile == 0.28 21:38:36 INFO - mozrunner == 6.13 21:38:36 INFO - mozscreenshot == 0.1 21:38:36 INFO - mozsystemmonitor == 0.3 21:38:36 INFO - moztest == 0.8 21:38:36 INFO - mozversion == 1.4 21:38:36 INFO - psutil == 3.1.1 21:38:36 INFO - requests == 1.2.3 21:38:36 INFO - wsgiref == 0.1.2 21:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:36 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 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:36 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 21:38:36 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 21:38:36 INFO - Using env: {'DISPLAY': ':0', 21:38:36 INFO - 'HOME': '/home/cltbld', 21:38:36 INFO - 'LANG': 'en_US.UTF-8', 21:38:36 INFO - 'LANGUAGE': 'en_US:en', 21:38:36 INFO - 'LOGNAME': 'cltbld', 21:38:36 INFO - 'MAIL': '/var/mail/cltbld', 21:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:36 INFO - 'MOZ_NO_REMOTE': '1', 21:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:36 INFO - 'NO_EM_RESTART': '1', 21:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:36 INFO - 'PWD': '/builds/slave/test', 21:38:36 INFO - 'SHELL': '/bin/bash', 21:38:36 INFO - 'SHLVL': '1', 21:38:36 INFO - 'TERM': 'linux', 21:38:36 INFO - 'TMOUT': '86400', 21:38:36 INFO - 'USER': 'cltbld', 21:38:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:36 INFO - '_': '/tools/buildbot/bin/python'} 21:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 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)) 21:38:36 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:37 INFO - Downloading marionette_driver-1.4.0.tar.gz 21:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 21:38:37 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)) 21:38:37 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)) 21:38:37 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)) 21:38:37 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)) 21:38:37 INFO - Installing collected packages: marionette-driver 21:38:37 INFO - Running setup.py install for marionette-driver 21:38:37 INFO - Successfully installed marionette-driver 21:38:37 INFO - Cleaning up... 21:38:37 INFO - Return code: 0 21:38:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38: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')]} 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13473b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', '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 21:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:38:37 INFO - Using env: {'DISPLAY': ':0', 21:38:37 INFO - 'HOME': '/home/cltbld', 21:38:37 INFO - 'LANG': 'en_US.UTF-8', 21:38:37 INFO - 'LANGUAGE': 'en_US:en', 21:38:37 INFO - 'LOGNAME': 'cltbld', 21:38:37 INFO - 'MAIL': '/var/mail/cltbld', 21:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:37 INFO - 'MOZ_NO_REMOTE': '1', 21:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:37 INFO - 'NO_EM_RESTART': '1', 21:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:37 INFO - 'PWD': '/builds/slave/test', 21:38:37 INFO - 'SHELL': '/bin/bash', 21:38:37 INFO - 'SHLVL': '1', 21:38:37 INFO - 'TERM': 'linux', 21:38:37 INFO - 'TMOUT': '86400', 21:38:37 INFO - 'USER': 'cltbld', 21:38:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:37 INFO - '_': '/tools/buildbot/bin/python'} 21:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:37 INFO - Cleaning up... 21:38:37 INFO - Return code: 0 21:38:37 INFO - Running post-action listener: _resource_record_post_action 21:38:37 INFO - Running post-action listener: _start_resource_monitoring 21:38:37 INFO - Starting resource monitoring. 21:38:37 INFO - [mozharness: 2017-06-23 04:38:37.831414Z] Finished create-virtualenv step (success) 21:38:37 INFO - [mozharness: 2017-06-23 04:38:37.832399Z] Running install step. 21:38:37 INFO - Running pre-action listener: _resource_record_pre_action 21:38:37 INFO - Running main action method: install 21:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:38 INFO - Reading from file tmpfile_stdout 21:38:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:38 INFO - Reading from file tmpfile_stdout 21:38:38 INFO - Output received: 21:38:38 INFO - Usage: mozinstall [options] installer 21:38:38 INFO - Options: 21:38:38 INFO - -h, --help show this help message and exit 21:38:38 INFO - -d DEST, --destination=DEST 21:38:38 INFO - Directory to install application into. [default: 21:38:38 INFO - "/builds/slave/test"] 21:38:38 INFO - --app=APP Application being installed. [default: firefox] 21:38:38 INFO - mkdir: /builds/slave/test/build/application 21:38:38 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'] 21:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:38:56 INFO - Reading from file tmpfile_stdout 21:38:56 INFO - Output received: 21:38:56 INFO - /builds/slave/test/build/application/firefox/firefox 21:38:56 INFO - Running post-action listener: _resource_record_post_action 21:38:56 INFO - [mozharness: 2017-06-23 04:38:56.067691Z] Finished install step (success) 21:38:56 INFO - [mozharness: 2017-06-23 04:38:56.067840Z] Running setup-mitmproxy step. 21:38:56 INFO - Running pre-action listener: _resource_record_pre_action 21:38:56 INFO - Running main action method: setup_mitmproxy 21:38:56 INFO - Skipping: mitmproxy is not required 21:38:56 INFO - Running post-action listener: _resource_record_post_action 21:38:56 INFO - [mozharness: 2017-06-23 04:38:56.068373Z] Finished setup-mitmproxy step (success) 21:38:56 INFO - [mozharness: 2017-06-23 04:38:56.068483Z] Running run-tests step. 21:38:56 INFO - Running pre-action listener: _resource_record_pre_action 21:38:56 INFO - Running main action method: run_tests 21:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:38:56 INFO - Python 2.7.3 21:38:56 INFO - Return code: 0 21:38:56 INFO - grabbing minidump binary from tooltool 21:38:56 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')]} 21:38:56 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 0x16c3140>, '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 0x16c3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c3ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:38:56 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 21:38:56 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 21:38:56 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 21:38:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:38:56 INFO - Return code: 0 21:38:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:38:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:38:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:38:56 INFO - ENV: RUST_BACKTRACE is now 1 21:38:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:38:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:38:56 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/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 21:38:56 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/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 21:38:56 INFO - Using env: {'DISPLAY': ':0', 21:38:56 INFO - 'HOME': '/home/cltbld', 21:38:56 INFO - 'LANG': 'en_US.UTF-8', 21:38:56 INFO - 'LANGUAGE': 'en_US:en', 21:38:56 INFO - 'LOGNAME': 'cltbld', 21:38:56 INFO - 'MAIL': '/var/mail/cltbld', 21:38:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:38:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:56 INFO - 'MOZ_NO_REMOTE': '1', 21:38:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:56 INFO - 'NO_EM_RESTART': '1', 21:38:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:56 INFO - 'PWD': '/builds/slave/test', 21:38:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:38:56 INFO - 'RUST_BACKTRACE': '1', 21:38:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:38:56 INFO - 'SHELL': '/bin/bash', 21:38:56 INFO - 'SHLVL': '1', 21:38:56 INFO - 'TERM': 'linux', 21:38:56 INFO - 'TMOUT': '86400', 21:38:56 INFO - 'USER': 'cltbld', 21:38:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450', 21:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:56 INFO - '_': '/tools/buildbot/bin/python'} 21:38:56 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/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 21:38:56 INFO - mozversion application_buildid: 20170623034504 21:38:56 INFO - mozversion application_changeset: 7455c74d833a9db4e02be17eda14588c7ef0de76 21:38:56 INFO - mozversion application_display_name: Nightly 21:38:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:38:56 INFO - mozversion application_name: Firefox 21:38:56 INFO - mozversion application_remotingname: firefox 21:38:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:38:56 INFO - mozversion application_vendor: Mozilla 21:38:56 INFO - mozversion application_version: 56.0a1 21:38:56 INFO - mozversion platform_buildid: 20170623034504 21:38:56 INFO - mozversion platform_changeset: 7455c74d833a9db4e02be17eda14588c7ef0de76 21:38:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:38:56 INFO - mozversion platform_version: 56.0a1 21:38:56 INFO - using testdate: 1498192736 21:38:56 INFO - actual date: 1498192736 21:38:56 INFO - starting webserver on 'localhost:55856' 21:38:56 INFO - SUITE-START | Running 2 tests 21:38:56 INFO - TEST-START | dromaeo_css 21:38:56 INFO - operating with platform_type : linux_ 21:38:56 INFO - Initialising browser for dromaeo_css test... 21:38:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55856/getInfo.html -profile /tmp/tmppYPMWA/profile 21:38:56 INFO - TEST-INFO | started process 3303 (/builds/slave/test/build/application/firefox/firefox http://localhost:55856/getInfo.html) 21:39:08 INFO - TEST-INFO | 3303: exit 0 21:39:08 INFO - Browser initialized. 21:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:08 INFO - TEST-INFO | started process 3535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppYPMWA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:19 INFO - PID 3535 | RSS: Main: 179408896 21:39:19 INFO - PID 3535 | 21:42:23 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55856/tests/dromaeo/cssquery-ext.html) 21:42:25 INFO - PID 3535 | RSS: Main: 185479168 21:42:25 INFO - PID 3535 | 21:45:27 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-ext.html (next: http://localhost:55856/tests/dromaeo/cssquery-jquery.html) 21:45:27 INFO - PID 3535 | RSS: Main: 182296576 21:45:27 INFO - PID 3535 | 21:48:29 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55856/tests/dromaeo/cssquery-mootools.html) 21:48:30 INFO - PID 3535 | RSS: Main: 186609664 21:48:30 INFO - PID 3535 | 21:51:31 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55856/tests/dromaeo/cssquery-prototype.html) 21:51:32 INFO - PID 3535 | RSS: Main: 181764096 21:51:32 INFO - PID 3535 | 21:54:35 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55856/tests/dromaeo/cssquery-yui.html) 21:54:35 INFO - PID 3535 | RSS: Main: 185061376 21:54:35 INFO - PID 3535 | 21:57:37 INFO - PID 3535 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-yui.html (next: http://localhost:55856/tests/dromaeo/cssquery-dojo.html) 21:57:38 INFO - PID 3535 | RSS: Main: 183869440 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | __start_tp_report 21:57:38 INFO - PID 3535 | _x_x_mozilla_page_load 21:57:38 INFO - PID 3535 | _x_x_mozilla_page_load_details 21:57:38 INFO - PID 3535 | |i|pagename|runs| 21:57:38 INFO - PID 3535 | |0;dojo.html;3071.631404231492;3082.1061892051307;3103.581016562763;3114.8286844223558;3127.155667969649;6124.540659450542;6125.754969801208;6161.075838624209;6186.381361863817;6195.070739389094;5975.312839023502;6054.212952316204;6084.178635884155;6104.847378815532;6136.601120927136;5582.692951887645;5639.661620302774;5664.886702265952;5693.629914055594;5712.143178523234;5668.036433806242;5702.059160238577;5704.800331988381;5741.655500669973;5789.0448076067605;5707.714614269291;5763.366029736726;5774.451427114417;5801.622894511865;5808.680522571257;5735.885282294352;5753.223314852483;5761.078227483583;5781.103928891029;5801.970990145064;5355.3305836770405;5647.830565083054;5751.597388182829;5759.798407055775;5804.216430781833;5963.552733544958;6073.787417440369;6080.270367555878;6187.597806142587;6203.193584833988;6507.154069970874;6566.80299591013;6600.702968366435;6601;6610.338966103399;6595.208574971034;6631.767888123941;6670.366315200048;6687.996800479918;6727.697253623599;6176.320604733476;6197.752089916443;6203.31763506014;6212.285587157445;6218.098375735493;6820.079289295882;6822.863542729117;6842.5552339098795;6845.14435695538;6850.109485766918;6307.684615769193;6339.334369891188;6424.743010279536;6545.836354091186;6550.6069635822005;6495.058216558573;6596.80209593713;6629.436497897636;6640.435562977104;6651.700673469705;6620.404163625297;6645.003249512612;6653.401193892476;6653.767118150841;6661.933380666228;6707.496937729592;6712;6718.025886246467;6725.9663701681175;6735.865282694319;5212.530872221519;5229.712365819841;5259.000789849916;5301.125314323093;5352.4915133062295;4489.9551004490195;4512.887177820515;4518.638508919278;4526.207913615104;4558.452985641744;5705.885882282331;5706.914396284059;5776.508996735324;5795.971020144872;5825.679587622722;6680.5323627345615;6715.56348837324;6736.326367363225;6755.763548275787;6756.459483241329;5766.04860198071;5790.392008839095;5799.652020878761;5805.622634528742;5810.82567522975;5844.6785426801935;5848.736806843617;5882.970585147047;5883.823485295448;5891.322497912709;6329.177206963157;6377.744890204525;6414.069959855701;6421.133147025279;6441.1626488556185;6591.802245932629;6698.062271282122;6712.026756120237;6729.596224226562;6729.899051514133;6482;6493.253275873335;6496.967515162394;6498.772542960974;6503.934960650333;6550.148480697479;6563.0811686362995;6564.4420224281475;6564.573302735307;6574;6552.180977377828;6563.146790917151;6641.701123449359;6642.734290628321;6712.865742685217;6416.00551914454;6464.159659244268;6464.933286007756;6485.6108633482145;6494.805155845333;6454.5159113065765;6492.058651495601;6511.316311787384;6516.152900123143;6547.148870646785;6432.2281326241155;6469.385408386196;6477.578957367756;6497.415232629086;6498.740050397932;6535.967320163369;6550.443212327005;6556.573822701509;6558.213014438298;6558.737650494118;6119.07606531266;6211.409916057967;6257.5932564383165;6275.403836635513;6317.842053948504 21:57:38 INFO - PID 3535 | |1;ext.html;789.8657228271194;825.8926339575854;853.7566793463864;877.6401675313123;888.6667499687617;38809;39419.80290098552;39471;39659.801700991455;39741.40387894177;36048.2790344193;36133.0966725832;36395.272094558095;36554.268914621694;36832.63167368325;6834.760783372583;6946.965265173667;6971.163460384761;6986.965065174667;6999.545029573062;6881.552699074544;6946.340097690711;6991.965040174792;7004.194517630462;7009.75465858695;6944.895826562581;6998.160220773514;7019.262977387378;7022.754203602875;7023.438124949992;6940.514164008521;6952.860942781142;7513.398928085768;7686.46194766361;7720.613969301568;7526.774196774106;7575.810604734871;7618;7634.160242373335;7650.693972241103;37411;37726.81136594327;37737.24525509474;37767.24465510702;37798.43302350467;3484.4599087141532;3504.036389992747;3507.5264839246884;3510.1049232445816;3510.8946731598094;29074.563881541795;29350.706492935013;29482.85258573715;29566;29609.259768505744;3655.1227705350525;3680.429533422297;3681.1717363593243;3685;3697.242065376591;187395;187613;187789;192914;193005;41094.38358424566;46334.304985425246;46356.3046554302;46385.76807115943;46845;49679;49885.25172122421;49899.75050124799;49974;50195.24707129396;15436.768448473282;15472.226388680747;15531.301091450912;15577;15615.609609759847;12788;12829.871701282867;12848.48606055766;12858;12869.4208760606;14009.08940918837;14012.369443374868;14210.928945355206;14244.928775356057;14307.85692143086;5620.297462817148;5661.631993920382;5752;5794.188813566104;5795.13073039039;974.7222041718077;994.5027486256871;1002.6290272599039;1023.4166525080782;1040.9479526023667;21410;22349.442379182157;22640.773592264195;22813.201537946425;23466.76533234646;1082.3936531031698;1083.285031878956;1105.7069876482738;1120.5797825815318;1125.6454216921643;11430.885691142983;11789.785984095013;11889.167758257012;12099.455524501418;12211.084168687385;207480;207716;208098;209575;210029;49692.254616180784;50101.49898501041;50337.24494132591;50395;50480;1425.337218193545;1449.4330886281473;1464.3044553836842;1476.9556913292618;1486.7323881701398;21099.343824168835;21920.713362727805;21921.890390548582;22689.20587779486;22975.195868144536;35921.46117808287;36007.81996090108;36021;36137.81931090328;36227.45658815067;166964;167594.1620291891;167673;167900;169252.1537392305;29411.264718381357;29738.405231895675;30088.398232035674;31943;32683.182920427178;40120;40901.38647920224;40985.38521922114;41619.375709363776;42296.57703422927;28618.713812861606;28774.42451151007;29862;30373.848130759205;30943.381132376777;29435.705642943296;29596.556051658812;29962.25094372658;30448.695513044586;31033.37933241368;33693.83153084317;33975.66024339824;34174.487382688785;34252.828735856165;34264.48603270903;27932.58101128444;29629.851850740608;29630;29782.404351912406;30188;21749;23918.282451526484;24153.75846241515;24270.63594046126;24289.75710242875 21:57:38 INFO - PID 3535 | |2;jquery.html;555.1866515554711;559.6893723983188;561.3039830610039;580.7125472890918;586;20579.897100514496;21434.71391716498;21501.354959351207;21541.67687484685;21549.892250538764;23635.290941271745;25080.62379064311;25782.48435031298;25922.481550368982;26304;6138.907916381247;6243.781467648633;6250.874982500347;6252.280987686406;6323.241211054657;6227.501799856023;6268.310485846553;6276.654783986879;6278.843028924291;6302.810915672537;5672.461116193955;5928.851778705523;6184.907226391608;6265.404786545294;6280.340564240758;6183.505319574423;6187.35032821554;6213.03697926822;6227.43953044226;6233.252009758812;5791.739371728282;5796.652200867961;5808.099744539603;5812.186293918855;5823;27027.864860675767;27327.863360683266;27786.583201251997;27787.58318625202;27971;1861.3671351740472;1921.980780192194;1933.690609502487;1936.7772706138692;1937.3994061840733;17446.738298925527;17877.910610446994;17897.642047159115;17991.73012404815;18117.275308987624;2249.381420109483;2288.588054150269;2312.190733243368;2328;2341.8477798943013;120735;124875.3756231222;125858.37070814587;125989;127153.36423317916;13791;14051.508197213252;14615.196164211071;14902.478413255483;15270.396608356185;22922.541549168924;23060.423489412562;23144.42138946506;23147.189848355563;23191.53616927652;9340.953295233481;9576.616935322509;9596.760080997892;9648.71053868385;9719.41683498978;8524.531150786766;8570.74287771368;8682.30541556674;8684.43551169172;8717.30261579072;8904.19862212404;8924.036711923367;8983.730488085368;9164.816703665889;9270.860937085949;2655.3892604701027;2763.1434255380896;2873.2478675113316;2879.3809330993936;2884.8990285340333;946.7727745341206;953.1802649721234;968.912797848183;973.6738192705382;1010.4190090697878;18832.52918677044;19073.141708623145;19444.513887152934;19562.70655940162;19799.802001979795;986.156835905305;986.2405947420447;1006.1397505133152;1021.8875923648393;1030.4156440346194;10348.586056557653;10420.218483613759;10588;10721.41032243234;11043.116550675926;446205;459211;460007;463443;463454;105376.47311763545;108591.45704271586;109171;110625;111412;1136.7840110379168;1163.5345861655237;1168.2698313554029;1169.1990986174499;1170.8829117088223;15842;16215.108169050816;16757.07836069028;16819.495415137564;17282.481525554253;47718.860099005324;47881.52118478771;48848.75575622241;48973;50068.749656251486;64941.02588461271;66383;66432;66557.66721166363;66679;11962.760744784882;12025.4588543514;12063.095267854771;12069;12102.910738033619;18026.098695065455;19352.129154187813;19554.21783128659;19614.411567652995;19739.11173997145;15564.221788910283;15590;15598.142102184034;15707.921460392625;15808.288627011581;13627.38676759568;13903.304834758424;13905.791413128609;14008.229547374585;14834.406623734929;15089.698206035599;15879.52361429159;15984.760228596813;16236.756448653516;16248.675026499168;12812.359382030674;12880.42038108306;12894.742105158031;12988.805167922677;13061.542846000344;15933.20333983273;15954.760678590063;15965.121918294606;16034.198290085216;16112.355505779638 21:57:38 INFO - PID 3535 | |3;mootools.html;1332.8467226268979;1390.7218556288744;1392.1368751374143;1396.7625503664376;1413.4487549855558;13149.211047337154;13569.457221711144;13645.795313070312;13669.863301366984;13724.245166515837;12963.675908102303;13554.254516001616;13609.047366684312;13618.659533511667;13619.931900340509;2574.317805781465;2628.2378110348072;2634.262406526166;2644.074573899139;2648.1658277642578;2520.117958714454;2570.640110384548;2580.2259322203263;2583.2121203033066;2584.612308153773;2418.2866054513875;2515.9748402515925;2549.107812265711;2550.0564791027346;2554.846709197445;2512.836665616738;2588.72818354072;2614.0720044384257;2619.305883940757;2640.4587059652727;2489.65144879717;2492.5887228607257;2504.6368276599974;2519.206449968254;2527.229195095495;12750.10749247553;13005.674858128528;13028.80456793149;13040.087193896432;13047.869521304856;7238.819029524251;7606.695732170707;7625.313721765012;7637.847243055107;7643.770686879402;4055.7566546007038;4169.91660166795;4203.516595591485;4264.189803937242;4270.572942705736;1551.8913676042682;1615.8545730884277;1642.170703794588;1678.8656907447375;1681.159420289855;20793;21195.788042119537;21206.681899771516;21232.363029108998;21269.78730212709;6703.195616526048;6730.93269067303;6807.217170025411;6894.310568943066;7108.147022357247;17142.828571714123;17169;17179.742303865452;17198.39805606823;17221.794474386672;7401.925980740124;7675;7686.116096648845;7697.960775295375;7700.499467534592;6784.457243420515;6931;6941.062956500808;6962.721491140399;7023.543469674455;5106.259592359162;5370;5377.489138531833;5397.703126328011;5637.577181711388;1626.2356692354574;1663.2931004323113;1675.5308513616208;1683.3151123957268;1712.6317841664102;864.3430992445786;880.5773228850188;881.9514926678966;900.1718419054355;911.3483859040817;6669.233038200572;6763.661816909135;6805.795826125224;6975.058367120475;7093.361597456254;717.2970488920782;717.6698718589403;720.538855132705;731.3799933148102;741.1476801678006;4047.1233681941526;4071.9389209161886;4170.311898536707;4895.437024742129;5013.8718788272345;17069.7439538407;17604.823951760318;17895;17988.91005544964;18034.458966231035;16954.830451695572;17027.659446810994;17557.034363110153;17746.911265443847;17807.821921780876;9622.278329125344;9692.806143877224;9766.414015159113;9774;10125.189984801345;6992.370686638227;7354.4484163689;7373.483856130234;7554.6600402983095;7639.04511936008;15393.230338483256;15421.614459638598;15464.072155670696;15668.921655392107;15894.205289735699;14876;15153.54539363821;15864.44474443389;15898.52304430869;16079.67840643204;10699;10857.34855908648;10863.728406789893;10865.837012444661;10868.07621352194;12307.876921230672;12445.066620003356;12486.687832804253;12493.812592811297;12576.811347829973;8921.821563568563;9844.556994935389;10082.395056296646;10427.635032773816;10584.523696433833;10320.587176512856;10399.792004159723;10515.78968420612;10631.893681063091;10666.46667666629;8443.746687599381;8588;8639.352048596254;8684.001339845998;8795.604197810986;6445.70994305248;6456.192975878015;6677.966610166918;6814.318568143146;6914.688839002358;6679.9332006679315;6728.966355168192;6880.31196880328;6979.930200697928;7020.894686579808 21:57:38 INFO - PID 3535 | |4;prototype.html;490.426201344427;496.91296554471216;514.6294667839155;518.7821115131644;523.3275241314911;6284.905726414102;6294.150289710888;6304.432601065909;6357.23713154421;6368.4147413862065;5991.550633702468;6214.5649804513705;6224.28420731616;6225.906611400833;6229.781957631484;5000.649954503196;5032.899342013157;5067.695938243699;5081.2124120761155;5091.185410334348;5048.848534543969;5053.004063394957;5059.898802023958;5060.39275286966;5108.8211912583065;5009.874753131183;5031.974840125794;5034.471380505049;5042.268871013701;5050.116229659813;4823.276508523714;4994.425641051289;4995.425526064513;5001.949980500185;5008.574271186953;4424.336349547561;4437.556244375569;4437.911241775147;4456.710313829591;4497.865064048084;5966.850828729316;5974.6713930733795;5981.970090149565;6006.8498287542725;6007.36922623127;5685.459881311269;5723.456271654186;5735.770569177228;5740.368559458456;5757;6566.93433065668;6569.441597464222;6580.967095164541;6595.307492713244;6596;4873.269009648546;4930.827421040282;4937.407511098691;4942.901141977176;4957.727324997124;6870.106886104824;6899.931000689979;6944.72221111155;6957.930420695779;6960.512764106515;5006.823396501819;5020.447750747415;5045.394552653705;5057;5059.519345662156;5089.9745501272255;5098.796048158032;5111.87220319495;5137.152369858932;5144.636671282114;5707.771689132472;5737.942620573825;5745.1669507921115;5756.884862302814;5775.855603609859;6652.767153149616;6654.900176497356;6657.966710166515;6661.866762664719;6669.366410191024;1670.5573023148875;1771.14099661664;1771.16755125091;1798.52339130128;1806.3406856497547;1204.307523174161;1205.8432403787451;1208.0697862645889;1245.17818239963;1248.887600115994;5579.38626751057;5724.227229323988;5738.1679656450415;5761.654300741969;5782.855428614318;6606.735730570819;6743.224529179207;6751.392374686302;6765.985102234704;6767.627780472121;5774.2782152230975;5785.218995435646;5818.243628328375;5819.418058194231;5820.912686309709;3538.8230588470474;3558.3417067842533;3569.12620874038;3569.6430356964615;3576.481410195507;6505.902411463831;6533.248676402274;6548.937084818267;6571;6583.604983700898;6847.246802851682;6867.759628413081;6890.625312256448;6900.654967251618;6910.20532638753;6453.1610890583925;6523.673816309166;6538.1500404947055;6546.934530654633;6556.213254409501;6654.234763002317;6668.933310667026;6676.866462670622;6678.131842860591;6708.664566771544;6650.83610368174;6667.133272674521;6671.499637527302;6672.833179170365;6677.43241824431;6163.476104531165;6499.28507864144;6530.771423000172;6536.346365363425;6543.05998970774;4944.332515110414;4952.380952380952;4969.776360063878;4975.228839529878;5008.899822003613;6718.193816742022;6740.359665831738;6753.561018533779;6758.357955994173;6777.966110169417;6558.8360290991195;6561.7034038088195;6569.671516424064;6570.342965703582;6595.965855706429;6494.740210391531;6571.4557079087335;6577.868442631217;6579.2104947406615;6582.736690532325;6476.676166191766;6491.837704057436;6504.902426463512;6511.967440162958;6521.576097553644;6605.966970165118;6629;6633.711369577488;6652.634105124071;6675.165604299463;6401.527648640746;6410.711517981609;6424.775132870327;6432.163818703539;6440.8389790255615 21:57:38 INFO - PID 3535 | |5;yui.html;837.7151768398743;862.0991064337767;871.0592560035159;878.5212059427612;891.8840550728406;16939.661206775858;17348.21933013014;17768.289268429246;18130.093495325214;20209.898950505227;19394.70907936382;20148.597028059467;20281.594368112666;20287.08708108135;20352.796472035276;990.1929927109419;999.8650182225398;1052.1582733812957;1053.483792941457;1057.1120258982453;1054.520193312045;1056.9418681972488;1058.227493929432;1062.3625824505311;1064.6593090211136;1114.6043154680094;1115.3530952047834;1117.5027112934747;1122.691259903529;1124.6232512108413;1083.804915115283;1114.509615769063;1120.495776900394;1130.7060164357245;1139.2139423797553;794.6582969323189;795.4511387142853;796.3867821777256;798.6166640012768;798.6964953317702;18493.815061849346;18728.62542749151;18874.81125188758;18980.715289270673;19009.33467328637;19453.221871125137;19465.221391144478;19940.202391904306;20121.195152193894;20137.39587812368;15433.691326173526;15461.458848940345;15469.5359139226;15483.380664773396;15591.1424871632;3457.533233013561;3525.4359302511475;3561.519194908706;3581.6418358164237;3646.890593282206;95511.52244238804;96177;98546.50726746392;101219.95120195257;102514.99999999926;15148.772768408482;15235.314410851539;15474;15509;15514.37942482288;26639.46721065568;28373.574396384072;28486.71513284882;28633.14100576986;28871.71128288732;8368.20502052304;8394.412391132684;8611.95694021526;8690.565471726388;8795.912040879637;3589.5513060867393;3734.626537346244;3746.4193050077283;4051.2505186540584;4244.745315281093;4620.283856002325;4740.976295118502;4741.857744267678;4752.429708434941;4775.2598347256235;894.5080205886867;947.7630592351912;956.3974695941512;958.3770549143113;961.7451375385529;661.4708233413251;672.2135101930753;676.88378033206;697.6197972105215;710.7761055267574;11452.541898323974;11650.601034881342;12208.86495319414;12412.875871241353;12482.563110291096;686.5606012152226;688.1913751342153;691.2016620802981;704.827317307263;708.9042979197742;5169.922451163236;5231.686098834082;5443.618946673695;5514.255575497256;6017;90249;91773;94558;95705.5214723922;96683;76126;79164.20835791569;80019.19980800233;81581;83066.58466707749;67832.60836958133;68215.3178468209;68532.97200541996;70865.64567177132;72695.27304726886;11272.774544509228;12048.337341446304;12280.81578776337;12668.366581671064;12743.87256127427;32627.510587340734;33229.50155747714;33302.66697332996;33607.65569377197;33843.3231335367;58082.7095864518;60670.393296066475;61871;62435.687821560605;62943.68528157513;18216.635667286846;18289.817101828812;18769.90615046916;18946.526336841136;19073.523161920508;19921.203151873764;20234.59530809405;20555.38333849987;20637.277695280594;20768.688469672667;17074.562266378027;17833.375831845824;18286.908565457088;18552.81447185511;18692.626147477247;17712.645747084727;18552.721709174642;18879.528011799815;18917.054147292303;19058.904705476383;17182.484525464257;18048.005436085998;18365.908170459596;18446.90776546109;18725.25098996025;11857.407129643656;11943.163978521769;12377.938110309391;12431.751364972832;13008.089433739926;13464.394102265225;14515.129092254498;14623.122612643276;14965;15142.167180805161 21:57:38 INFO - PID 3535 | __end_tp_report 21:57:38 INFO - PID 3535 | __start_cc_report 21:57:38 INFO - PID 3535 | _x_x_mozilla_cycle_collect,367 21:57:38 INFO - PID 3535 | __end_cc_report 21:57:38 INFO - PID 3535 | __startTimestamp1498193858032__endTimestamp 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | ------- Summary: start ------- 21:57:38 INFO - PID 3535 | Number of tests: 6 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#0] dojo.html Cycles:165 Average:6110.41 Median:6339.33 stddev:731.58 (11.5%) stddev-sans-first:693.89 21:57:38 INFO - PID 3535 | Values: 3071.6 3082.1 3103.6 3114.8 3127.2 6124.5 6125.8 6161.1 6186.4 6195.1 5975.3 6054.2 6084.2 6104.8 6136.6 5582.7 5639.7 5664.9 5693.6 5712.1 5668.0 5702.1 5704.8 5741.7 5789.0 5707.7 5763.4 5774.5 5801.6 5808.7 5735.9 5753.2 5761.1 5781.1 5802.0 5355.3 5647.8 5751.6 5759.8 5804.2 5963.6 6073.8 6080.3 6187.6 6203.2 6507.2 6566.8 6600.7 6601.0 6610.3 6595.2 6631.8 6670.4 6688.0 6727.7 6176.3 6197.8 6203.3 6212.3 6218.1 6820.1 6822.9 6842.6 6845.1 6850.1 6307.7 6339.3 6424.7 6545.8 6550.6 6495.1 6596.8 6629.4 6640.4 6651.7 6620.4 6645.0 6653.4 6653.8 6661.9 6707.5 6712.0 6718.0 6726.0 6735.9 5212.5 5229.7 5259.0 5301.1 5352.5 4490.0 4512.9 4518.6 4526.2 4558.5 5705.9 5706.9 5776.5 5796.0 5825.7 6680.5 6715.6 6736.3 6755.8 6756.5 5766.0 5790.4 5799.7 5805.6 5810.8 5844.7 5848.7 5883.0 5883.8 5891.3 6329.2 6377.7 6414.1 6421.1 6441.2 6591.8 6698.1 6712.0 6729.6 6729.9 6482.0 6493.3 6497.0 6498.8 6503.9 6550.1 6563.1 6564.4 6564.6 6574.0 6552.2 6563.1 6641.7 6642.7 6712.9 6416.0 6464.2 6464.9 6485.6 6494.8 6454.5 6492.1 6511.3 6516.2 6547.1 6432.2 6469.4 6477.6 6497.4 6498.7 6536.0 6550.4 6556.6 6558.2 6558.7 6119.1 6211.4 6257.6 6275.4 6317.8 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#1] ext.html Cycles:180 Average:35053.61 Median:34213.66 stddev:49041.02 (143.3%) stddev-sans-first:49111.10 21:57:38 INFO - PID 3535 | Values: 789.9 825.9 853.8 877.6 888.7 38809.0 39419.8 39471.0 39659.8 39741.4 36048.3 36133.1 36395.3 36554.3 36832.6 6834.8 6947.0 6971.2 6987.0 6999.5 6881.6 6946.3 6992.0 7004.2 7009.8 6944.9 6998.2 7019.3 7022.8 7023.4 6940.5 6952.9 7513.4 7686.5 7720.6 7526.8 7575.8 7618.0 7634.2 7650.7 37411.0 37726.8 37737.2 37767.2 37798.4 3484.5 3504.0 3507.5 3510.1 3510.9 29074.6 29350.7 29482.9 29566.0 29609.3 3655.1 3680.4 3681.2 3685.0 3697.2 187395.0 187613.0 187789.0 192914.0 193005.0 41094.4 46334.3 46356.3 46385.8 46845.0 49679.0 49885.3 49899.8 49974.0 50195.2 15436.8 15472.2 15531.3 15577.0 15615.6 12788.0 12829.9 12848.5 12858.0 12869.4 14009.1 14012.4 14210.9 14244.9 14307.9 5620.3 5661.6 5752.0 5794.2 5795.1 974.7 994.5 1002.6 1023.4 1040.9 21410.0 22349.4 22640.8 22813.2 23466.8 1082.4 1083.3 1105.7 1120.6 1125.6 11430.9 11789.8 11889.2 12099.5 12211.1 207480.0 207716.0 208098.0 209575.0 210029.0 49692.3 50101.5 50337.2 50395.0 50480.0 1425.3 1449.4 1464.3 1477.0 1486.7 21099.3 21920.7 21921.9 22689.2 22975.2 35921.5 36007.8 36021.0 36137.8 36227.5 166964.0 167594.2 167673.0 167900.0 169252.2 29411.3 29738.4 30088.4 31943.0 32683.2 40120.0 40901.4 40985.4 41619.4 42296.6 28618.7 28774.4 29862.0 30373.8 30943.4 29435.7 29596.6 29962.3 30448.7 31033.4 33693.8 33975.7 34174.5 34252.8 34264.5 27932.6 29629.9 29630.0 29782.4 30188.0 21749.0 23918.3 24153.8 24270.6 24289.8 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#2] jquery.html Cycles:180 Average:32167.33 Median:12605.56 stddev:77136.92 (611.9%) stddev-sans-first:77316.79 21:57:38 INFO - PID 3535 | Values: 555.2 559.7 561.3 580.7 586.0 20579.9 21434.7 21501.4 21541.7 21549.9 23635.3 25080.6 25782.5 25922.5 26304.0 6138.9 6243.8 6250.9 6252.3 6323.2 6227.5 6268.3 6276.7 6278.8 6302.8 5672.5 5928.9 6184.9 6265.4 6280.3 6183.5 6187.4 6213.0 6227.4 6233.3 5791.7 5796.7 5808.1 5812.2 5823.0 27027.9 27327.9 27786.6 27787.6 27971.0 1861.4 1922.0 1933.7 1936.8 1937.4 17446.7 17877.9 17897.6 17991.7 18117.3 2249.4 2288.6 2312.2 2328.0 2341.8 120735.0 124875.4 125858.4 125989.0 127153.4 13791.0 14051.5 14615.2 14902.5 15270.4 22922.5 23060.4 23144.4 23147.2 23191.5 9341.0 9576.6 9596.8 9648.7 9719.4 8524.5 8570.7 8682.3 8684.4 8717.3 8904.2 8924.0 8983.7 9164.8 9270.9 2655.4 2763.1 2873.2 2879.4 2884.9 946.8 953.2 968.9 973.7 1010.4 18832.5 19073.1 19444.5 19562.7 19799.8 986.2 986.2 1006.1 1021.9 1030.4 10348.6 10420.2 10588.0 10721.4 11043.1 446205.0 459211.0 460007.0 463443.0 463454.0 105376.5 108591.5 109171.0 110625.0 111412.0 1136.8 1163.5 1168.3 1169.2 1170.9 15842.0 16215.1 16757.1 16819.5 17282.5 47718.9 47881.5 48848.8 48973.0 50068.7 64941.0 66383.0 66432.0 66557.7 66679.0 11962.8 12025.5 12063.1 12069.0 12102.9 18026.1 19352.1 19554.2 19614.4 19739.1 15564.2 15590.0 15598.1 15707.9 15808.3 13627.4 13903.3 13905.8 14008.2 14834.4 15089.7 15879.5 15984.8 16236.8 16248.7 12812.4 12880.4 12894.7 12988.8 13061.5 15933.2 15954.8 15965.1 16034.2 16112.4 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#3] mootools.html Cycles:180 Average:8240.33 Median:2562.74 stddev:5539.94 (216.2%) stddev-sans-first:5531.17 21:57:38 INFO - PID 3535 | Values: 1332.8 1390.7 1392.1 1396.8 1413.4 13149.2 13569.5 13645.8 13669.9 13724.2 12963.7 13554.3 13609.0 13618.7 13619.9 2574.3 2628.2 2634.3 2644.1 2648.2 2520.1 2570.6 2580.2 2583.2 2584.6 2418.3 2516.0 2549.1 2550.1 2554.8 2512.8 2588.7 2614.1 2619.3 2640.5 2489.7 2492.6 2504.6 2519.2 2527.2 12750.1 13005.7 13028.8 13040.1 13047.9 7238.8 7606.7 7625.3 7637.8 7643.8 4055.8 4169.9 4203.5 4264.2 4270.6 1551.9 1615.9 1642.2 1678.9 1681.2 20793.0 21195.8 21206.7 21232.4 21269.8 6703.2 6730.9 6807.2 6894.3 7108.1 17142.8 17169.0 17179.7 17198.4 17221.8 7401.9 7675.0 7686.1 7698.0 7700.5 6784.5 6931.0 6941.1 6962.7 7023.5 5106.3 5370.0 5377.5 5397.7 5637.6 1626.2 1663.3 1675.5 1683.3 1712.6 864.3 880.6 882.0 900.2 911.3 6669.2 6763.7 6805.8 6975.1 7093.4 717.3 717.7 720.5 731.4 741.1 4047.1 4071.9 4170.3 4895.4 5013.9 17069.7 17604.8 17895.0 17988.9 18034.5 16954.8 17027.7 17557.0 17746.9 17807.8 9622.3 9692.8 9766.4 9774.0 10125.2 6992.4 7354.4 7373.5 7554.7 7639.0 15393.2 15421.6 15464.1 15668.9 15894.2 14876.0 15153.5 15864.4 15898.5 16079.7 10699.0 10857.3 10863.7 10865.8 10868.1 12307.9 12445.1 12486.7 12493.8 12576.8 8921.8 9844.6 10082.4 10427.6 10584.5 10320.6 10399.8 10515.8 10631.9 10666.5 8443.7 8588.0 8639.4 8684.0 8795.6 6445.7 6456.2 6678.0 6814.3 6914.7 6679.9 6729.0 6880.3 6979.9 7020.9 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#4] prototype.html Cycles:180 Average:5534.89 Median:6085.42 stddev:1552.51 (25.5%) stddev-sans-first:1509.99 21:57:38 INFO - PID 3535 | Values: 490.4 496.9 514.6 518.8 523.3 6284.9 6294.2 6304.4 6357.2 6368.4 5991.6 6214.6 6224.3 6225.9 6229.8 5000.6 5032.9 5067.7 5081.2 5091.2 5048.8 5053.0 5059.9 5060.4 5108.8 5009.9 5032.0 5034.5 5042.3 5050.1 4823.3 4994.4 4995.4 5001.9 5008.6 4424.3 4437.6 4437.9 4456.7 4497.9 5966.9 5974.7 5982.0 6006.8 6007.4 5685.5 5723.5 5735.8 5740.4 5757.0 6566.9 6569.4 6581.0 6595.3 6596.0 4873.3 4930.8 4937.4 4942.9 4957.7 6870.1 6899.9 6944.7 6957.9 6960.5 5006.8 5020.4 5045.4 5057.0 5059.5 5090.0 5098.8 5111.9 5137.2 5144.6 5707.8 5737.9 5745.2 5756.9 5775.9 6652.8 6654.9 6658.0 6661.9 6669.4 1670.6 1771.1 1771.2 1798.5 1806.3 1204.3 1205.8 1208.1 1245.2 1248.9 5579.4 5724.2 5738.2 5761.7 5782.9 6606.7 6743.2 6751.4 6766.0 6767.6 5774.3 5785.2 5818.2 5819.4 5820.9 3538.8 3558.3 3569.1 3569.6 3576.5 6505.9 6533.2 6548.9 6571.0 6583.6 6847.2 6867.8 6890.6 6900.7 6910.2 6453.2 6523.7 6538.2 6546.9 6556.2 6654.2 6668.9 6676.9 6678.1 6708.7 6650.8 6667.1 6671.5 6672.8 6677.4 6163.5 6499.3 6530.8 6536.3 6543.1 4944.3 4952.4 4969.8 4975.2 5008.9 6718.2 6740.4 6753.6 6758.4 6778.0 6558.8 6561.7 6569.7 6570.3 6596.0 6494.7 6571.5 6577.9 6579.2 6582.7 6476.7 6491.8 6504.9 6512.0 6521.6 6606.0 6629.0 6633.7 6652.6 6675.2 6401.5 6410.7 6424.8 6432.2 6440.8 21:57:38 INFO - PID 3535 | 21:57:38 INFO - PID 3535 | [#5] yui.html Cycles:180 Average:20893.99 Median:20319.94 stddev:26058.95 (128.2%) stddev-sans-first:26088.53 21:57:38 INFO - PID 3535 | Values: 837.7 862.1 871.1 878.5 891.9 16939.7 17348.2 17768.3 18130.1 20209.9 19394.7 20148.6 20281.6 20287.1 20352.8 990.2 999.9 1052.2 1053.5 1057.1 1054.5 1056.9 1058.2 1062.4 1064.7 1114.6 1115.4 1117.5 1122.7 1124.6 1083.8 1114.5 1120.5 1130.7 1139.2 794.7 795.5 796.4 798.6 798.7 18493.8 18728.6 18874.8 18980.7 19009.3 19453.2 19465.2 19940.2 20121.2 20137.4 15433.7 15461.5 15469.5 15483.4 15591.1 3457.5 3525.4 3561.5 3581.6 3646.9 95511.5 96177.0 98546.5 101220.0 102515.0 15148.8 15235.3 15474.0 15509.0 15514.4 26639.5 28373.6 28486.7 28633.1 28871.7 8368.2 8394.4 8612.0 8690.6 8795.9 3589.6 3734.6 3746.4 4051.3 4244.7 4620.3 4741.0 4741.9 4752.4 4775.3 894.5 947.8 956.4 958.4 961.7 661.5 672.2 676.9 697.6 710.8 11452.5 11650.6 12208.9 12412.9 12482.6 686.6 688.2 691.2 704.8 708.9 5169.9 5231.7 5443.6 5514.3 6017.0 90249.0 91773.0 94558.0 95705.5 96683.0 76126.0 79164.2 80019.2 81581.0 83066.6 67832.6 68215.3 68533.0 70865.6 72695.3 11272.8 12048.3 12280.8 12668.4 12743.9 32627.5 33229.5 33302.7 33607.7 33843.3 58082.7 60670.4 61871.0 62435.7 62943.7 18216.6 18289.8 18769.9 18946.5 19073.5 19921.2 20234.6 20555.4 20637.3 20768.7 17074.6 17833.4 18286.9 18552.8 18692.6 17712.6 18552.7 18879.5 18917.1 19058.9 17182.5 18048.0 18365.9 18446.9 18725.3 11857.4 11943.2 12377.9 12431.8 13008.1 13464.4 14515.1 14623.1 14965.0 15142.2 21:57:38 INFO - PID 3535 | -------- Summary: end -------- 21:57:38 INFO - PID 3535 | 21:57:38 INFO - TEST-INFO | 3535: exit 0 21:57:38 INFO - TEST-OK | dromaeo_css | took 1122203ms 21:57:38 INFO - TEST-START | kraken 21:57:38 INFO - operating with platform_type : linux_ 21:57:38 INFO - Initialising browser for kraken test... 21:57:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55856/getInfo.html -profile /tmp/tmpjCvT8B/profile 21:57:38 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox http://localhost:55856/getInfo.html) 21:57:44 INFO - TEST-INFO | 3953: exit 0 21:57:45 INFO - Browser initialized. 21:57:45 INFO - Running cycle 1/1 for kraken test... 21:57:45 INFO - TEST-INFO | started process 4183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjCvT8B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:56 INFO - PID 4183 | RSS: Main: 172019712 21:57:56 INFO - PID 4183 | 21:57:59 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:00 INFO - PID 4183 | RSS: Main: 176087040 21:58:00 INFO - PID 4183 | 21:58:02 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-dft) 21:58:03 INFO - PID 4183 | RSS: Main: 176992256 21:58:03 INFO - PID 4183 | 21:58:06 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-fft) 21:58:06 INFO - PID 4183 | RSS: Main: 171749376 21:58:06 INFO - PID 4183 | 21:58:08 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-oscillator) 21:58:09 INFO - PID 4183 | RSS: Main: 172752896 21:58:09 INFO - PID 4183 | 21:58:11 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:12 INFO - PID 4183 | RSS: Main: 173105152 21:58:12 INFO - PID 4183 | 21:58:15 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:16 INFO - PID 4183 | RSS: Main: 176308224 21:58:16 INFO - PID 4183 | 21:58:19 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:20 INFO - PID 4183 | RSS: Main: 177594368 21:58:20 INFO - PID 4183 | 21:58:22 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55856/tests/kraken/driver.html?testName=json-parse-financial) 21:58:23 INFO - PID 4183 | RSS: Main: 177000448 21:58:23 INFO - PID 4183 | 21:58:25 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:25 INFO - PID 4183 | RSS: Main: 177197056 21:58:25 INFO - PID 4183 | 21:58:27 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:28 INFO - PID 4183 | RSS: Main: 176922624 21:58:28 INFO - PID 4183 | 21:58:30 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:30 INFO - PID 4183 | RSS: Main: 176398336 21:58:30 INFO - PID 4183 | 21:58:33 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:34 INFO - PID 4183 | RSS: Main: 176537600 21:58:34 INFO - PID 4183 | 21:58:37 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:37 INFO - PID 4183 | RSS: Main: 177004544 21:58:37 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55856/tests/kraken/driver.html?testName=ai-astar) 21:58:39 INFO - PID 4183 | RSS: Main: 179159040 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | __start_tp_report 21:58:39 INFO - PID 4183 | _x_x_mozilla_page_load 21:58:39 INFO - PID 4183 | _x_x_mozilla_page_load_details 21:58:39 INFO - PID 4183 | |i|pagename|runs| 21:58:39 INFO - PID 4183 | |0;ai-astar;99;108;108;108;108;107;109;108;108;110 21:58:39 INFO - PID 4183 | |1;audio-beat-detection;147;118;144;171;123;153;148;135;162;121 21:58:39 INFO - PID 4183 | |2;audio-dft;164;162;163;164;162;169;162;164;166;166 21:58:39 INFO - PID 4183 | |3;audio-fft;74;75;75;176;73;74;74;73;101;75 21:58:39 INFO - PID 4183 | |4;audio-oscillator;89;82;143;82;83;82;131;82;81;132 21:58:39 INFO - PID 4183 | |5;imaging-gaussian-blur;113;113;114;114;113;114;114;115;113;114 21:58:39 INFO - PID 4183 | |6;imaging-darkroom;150;150;149;150;153;149;150;152;151;150 21:58:39 INFO - PID 4183 | |7;imaging-desaturate;94;94;94;94;95;95;95;94;93;93 21:58:39 INFO - PID 4183 | |8;json-parse-financial;53;53;54;53;56;54;56;54;53;54 21:58:39 INFO - PID 4183 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;54;54 21:58:39 INFO - PID 4183 | |10;stanford-crypto-aes;77;76;77;76;76;78;76;77;75;87 21:58:39 INFO - PID 4183 | |11;stanford-crypto-ccm;129;136;128;129;128;132;133;132;128;156 21:58:39 INFO - PID 4183 | |12;stanford-crypto-pbkdf2;189;189;180;185;191;186;183;184;180;181 21:58:39 INFO - PID 4183 | |13;stanford-crypto-sha256-iterative;67;67;70;68;70;68;68;68;67;69 21:58:39 INFO - PID 4183 | __end_tp_report 21:58:39 INFO - PID 4183 | __start_cc_report 21:58:39 INFO - PID 4183 | _x_x_mozilla_cycle_collect,917 21:58:39 INFO - PID 4183 | __end_cc_report 21:58:39 INFO - PID 4183 | __startTimestamp1498193919826__endTimestamp 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | ------- Summary: start ------- 21:58:39 INFO - PID 4183 | Number of tests: 14 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#0] ai-astar Cycles:10 Average:107.30 Median:108.00 stddev:3.02 (2.8%) stddev-sans-first:0.83 21:58:39 INFO - PID 4183 | Values: 99.0 108.0 108.0 108.0 108.0 107.0 109.0 108.0 108.0 110.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:147.50 stddev:17.81 (12.1%) stddev-sans-first:18.80 21:58:39 INFO - PID 4183 | Values: 147.0 118.0 144.0 171.0 123.0 153.0 148.0 135.0 162.0 121.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.25 (1.4%) stddev-sans-first:2.39 21:58:39 INFO - PID 4183 | Values: 164.0 162.0 163.0 164.0 162.0 169.0 162.0 164.0 166.0 166.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#3] audio-fft Cycles:10 Average:87.00 Median:74.00 stddev:32.40 (43.8%) stddev-sans-first:34.02 21:58:39 INFO - PID 4183 | Values: 74.0 75.0 75.0 176.0 73.0 74.0 74.0 73.0 101.0 75.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:82.00 stddev:25.57 (31.2%) stddev-sans-first:26.88 21:58:39 INFO - PID 4183 | Values: 89.0 82.0 143.0 82.0 83.0 82.0 131.0 82.0 81.0 132.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 21:58:39 INFO - PID 4183 | Values: 113.0 113.0 114.0 114.0 113.0 114.0 114.0 115.0 113.0 114.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 21:58:39 INFO - PID 4183 | Values: 150.0 150.0 149.0 150.0 153.0 149.0 150.0 152.0 151.0 150.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 21:58:39 INFO - PID 4183 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 93.0 93.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.17 21:58:39 INFO - PID 4183 | Values: 53.0 53.0 54.0 53.0 56.0 54.0 56.0 54.0 53.0 54.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:58:39 INFO - PID 4183 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:3.44 (4.5%) stddev-sans-first:3.64 21:58:39 INFO - PID 4183 | Values: 77.0 76.0 77.0 76.0 76.0 78.0 76.0 77.0 75.0 87.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:132.00 stddev:8.48 (6.4%) stddev-sans-first:8.86 21:58:39 INFO - PID 4183 | Values: 129.0 136.0 128.0 129.0 128.0 132.0 133.0 132.0 128.0 156.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:185.50 stddev:3.94 (2.1%) stddev-sans-first:3.87 21:58:39 INFO - PID 4183 | Values: 189.0 189.0 180.0 185.0 191.0 186.0 183.0 184.0 180.0 181.0 21:58:39 INFO - PID 4183 | 21:58:39 INFO - PID 4183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 21:58:39 INFO - PID 4183 | Values: 67.0 67.0 70.0 68.0 70.0 68.0 68.0 68.0 67.0 69.0 21:58:39 INFO - PID 4183 | -------- Summary: end -------- 21:58:39 INFO - PID 4183 | 21:58:40 INFO - TEST-INFO | 4183: exit 0 21:58:40 INFO - TEST-OK | kraken | took 62001ms 21:58:40 INFO - SUITE-END | took 1184s 21:58:41 INFO - Completed test suite (00:19:44) 21:58:41 INFO - javascript benchmark 21:58:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8154.305807155944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.631404231492, 3082.1061892051307, 3103.581016562763, 3114.8286844223558, 3127.155667969649, 6124.540659450542, 6125.754969801208, 6161.075838624209, 6186.381361863817, 6195.070739389094, 5975.312839023502, 6054.212952316204, 6084.178635884155, 6104.847378815532, 6136.601120927136, 5582.692951887645, 5639.661620302774, 5664.886702265952, 5693.629914055594, 5712.143178523234, 5668.036433806242, 5702.059160238577, 5704.800331988381, 5741.655500669973, 5789.0448076067605, 5707.714614269291, 5763.366029736726, 5774.451427114417, 5801.622894511865, 5808.680522571257, 5735.885282294352, 5753.223314852483, 5761.078227483583, 5781.103928891029, 5801.970990145064, 5355.3305836770405, 5647.830565083054, 5751.597388182829, 5759.798407055775, 5804.216430781833, 5963.552733544958, 6073.787417440369, 6080.270367555878, 6187.597806142587, 6203.193584833988, 6507.154069970874, 6566.80299591013, 6600.702968366435, 6601.0, 6610.338966103399, 6595.208574971034, 6631.767888123941, 6670.366315200048, 6687.996800479918, 6727.697253623599, 6176.320604733476, 6197.752089916443, 6203.31763506014, 6212.285587157445, 6218.098375735493, 6820.079289295882, 6822.863542729117, 6842.5552339098795, 6845.14435695538, 6850.109485766918, 6307.684615769193, 6339.334369891188, 6424.743010279536, 6545.836354091186, 6550.6069635822005, 6495.058216558573, 6596.80209593713, 6629.436497897636, 6640.435562977104, 6651.700673469705, 6620.404163625297, 6645.003249512612, 6653.401193892476, 6653.767118150841, 6661.933380666228, 6707.496937729592, 6712.0, 6718.025886246467, 6725.9663701681175, 6735.865282694319, 5212.530872221519, 5229.712365819841, 5259.000789849916, 5301.125314323093, 5352.4915133062295, 4489.9551004490195, 4512.887177820515, 4518.638508919278, 4526.207913615104, 4558.452985641744, 5705.885882282331, 5706.914396284059, 5776.508996735324, 5795.971020144872, 5825.679587622722, 6680.5323627345615, 6715.56348837324, 6736.326367363225, 6755.763548275787, 6756.459483241329, 5766.04860198071, 5790.392008839095, 5799.652020878761, 5805.622634528742, 5810.82567522975, 5844.6785426801935, 5848.736806843617, 5882.970585147047, 5883.823485295448, 5891.322497912709, 6329.177206963157, 6377.744890204525, 6414.069959855701, 6421.133147025279, 6441.1626488556185, 6591.802245932629, 6698.062271282122, 6712.026756120237, 6729.596224226562, 6729.899051514133, 6482.0, 6493.253275873335, 6496.967515162394, 6498.772542960974, 6503.934960650333, 6550.148480697479, 6563.0811686362995, 6564.4420224281475, 6564.573302735307, 6574.0, 6552.180977377828, 6563.146790917151, 6641.701123449359, 6642.734290628321, 6712.865742685217, 6416.00551914454, 6464.159659244268, 6464.933286007756, 6485.6108633482145, 6494.805155845333, 6454.5159113065765, 6492.058651495601, 6511.316311787384, 6516.152900123143, 6547.148870646785, 6432.2281326241155, 6469.385408386196, 6477.578957367756, 6497.415232629086, 6498.740050397932, 6535.967320163369, 6550.443212327005, 6556.573822701509, 6558.213014438298, 6558.737650494118, 6119.07606531266, 6211.409916057967, 6257.5932564383165, 6275.403836635513, 6317.842053948504], "value": 6054.304401092339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.8657228271194, 825.8926339575854, 853.7566793463864, 877.6401675313123, 888.6667499687617, 38809.0, 39419.80290098552, 39471.0, 39659.801700991455, 39741.40387894177, 36048.2790344193, 36133.0966725832, 36395.272094558095, 36554.268914621694, 36832.63167368325, 6834.760783372583, 6946.965265173667, 6971.163460384761, 6986.965065174667, 6999.545029573062, 6881.552699074544, 6946.340097690711, 6991.965040174792, 7004.194517630462, 7009.75465858695, 6944.895826562581, 6998.160220773514, 7019.262977387378, 7022.754203602875, 7023.438124949992, 6940.514164008521, 6952.860942781142, 7513.398928085768, 7686.46194766361, 7720.613969301568, 7526.774196774106, 7575.810604734871, 7618.0, 7634.160242373335, 7650.693972241103, 37411.0, 37726.81136594327, 37737.24525509474, 37767.24465510702, 37798.43302350467, 3484.4599087141532, 3504.036389992747, 3507.5264839246884, 3510.1049232445816, 3510.8946731598094, 29074.563881541795, 29350.706492935013, 29482.85258573715, 29566.0, 29609.259768505744, 3655.1227705350525, 3680.429533422297, 3681.1717363593243, 3685.0, 3697.242065376591, 187395.0, 187613.0, 187789.0, 192914.0, 193005.0, 41094.38358424566, 46334.304985425246, 46356.3046554302, 46385.76807115943, 46845.0, 49679.0, 49885.25172122421, 49899.75050124799, 49974.0, 50195.24707129396, 15436.768448473282, 15472.226388680747, 15531.301091450912, 15577.0, 15615.609609759847, 12788.0, 12829.871701282867, 12848.48606055766, 12858.0, 12869.4208760606, 14009.08940918837, 14012.369443374868, 14210.928945355206, 14244.928775356057, 14307.85692143086, 5620.297462817148, 5661.631993920382, 5752.0, 5794.188813566104, 5795.13073039039, 974.7222041718077, 994.5027486256871, 1002.6290272599039, 1023.4166525080782, 1040.9479526023667, 21410.0, 22349.442379182157, 22640.773592264195, 22813.201537946425, 23466.76533234646, 1082.3936531031698, 1083.285031878956, 1105.7069876482738, 1120.5797825815318, 1125.6454216921643, 11430.885691142983, 11789.785984095013, 11889.167758257012, 12099.455524501418, 12211.084168687385, 207480.0, 207716.0, 208098.0, 209575.0, 210029.0, 49692.254616180784, 50101.49898501041, 50337.24494132591, 50395.0, 50480.0, 1425.337218193545, 1449.4330886281473, 1464.3044553836842, 1476.9556913292618, 1486.7323881701398, 21099.343824168835, 21920.713362727805, 21921.890390548582, 22689.20587779486, 22975.195868144536, 35921.46117808287, 36007.81996090108, 36021.0, 36137.81931090328, 36227.45658815067, 166964.0, 167594.1620291891, 167673.0, 167900.0, 169252.1537392305, 29411.264718381357, 29738.405231895675, 30088.398232035674, 31943.0, 32683.182920427178, 40120.0, 40901.38647920224, 40985.38521922114, 41619.375709363776, 42296.57703422927, 28618.713812861606, 28774.42451151007, 29862.0, 30373.848130759205, 30943.381132376777, 29435.705642943296, 29596.556051658812, 29962.25094372658, 30448.695513044586, 31033.37933241368, 33693.83153084317, 33975.66024339824, 34174.487382688785, 34252.828735856165, 34264.48603270903, 27932.58101128444, 29629.851850740608, 29630.0, 29782.404351912406, 30188.0, 21749.0, 23918.282451526484, 24153.75846241515, 24270.63594046126, 24289.75710242875], "value": 16235.135222263993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1866515554711, 559.6893723983188, 561.3039830610039, 580.7125472890918, 586.0, 20579.897100514496, 21434.71391716498, 21501.354959351207, 21541.67687484685, 21549.892250538764, 23635.290941271745, 25080.62379064311, 25782.48435031298, 25922.481550368982, 26304.0, 6138.907916381247, 6243.781467648633, 6250.874982500347, 6252.280987686406, 6323.241211054657, 6227.501799856023, 6268.310485846553, 6276.654783986879, 6278.843028924291, 6302.810915672537, 5672.461116193955, 5928.851778705523, 6184.907226391608, 6265.404786545294, 6280.340564240758, 6183.505319574423, 6187.35032821554, 6213.03697926822, 6227.43953044226, 6233.252009758812, 5791.739371728282, 5796.652200867961, 5808.099744539603, 5812.186293918855, 5823.0, 27027.864860675767, 27327.863360683266, 27786.583201251997, 27787.58318625202, 27971.0, 1861.3671351740472, 1921.980780192194, 1933.690609502487, 1936.7772706138692, 1937.3994061840733, 17446.738298925527, 17877.910610446994, 17897.642047159115, 17991.73012404815, 18117.275308987624, 2249.381420109483, 2288.588054150269, 2312.190733243368, 2328.0, 2341.8477798943013, 120735.0, 124875.3756231222, 125858.37070814587, 125989.0, 127153.36423317916, 13791.0, 14051.508197213252, 14615.196164211071, 14902.478413255483, 15270.396608356185, 22922.541549168924, 23060.423489412562, 23144.42138946506, 23147.189848355563, 23191.53616927652, 9340.953295233481, 9576.616935322509, 9596.760080997892, 9648.71053868385, 9719.41683498978, 8524.531150786766, 8570.74287771368, 8682.30541556674, 8684.43551169172, 8717.30261579072, 8904.19862212404, 8924.036711923367, 8983.730488085368, 9164.816703665889, 9270.860937085949, 2655.3892604701027, 2763.1434255380896, 2873.2478675113316, 2879.3809330993936, 2884.8990285340333, 946.7727745341206, 953.1802649721234, 968.912797848183, 973.6738192705382, 1010.4190090697878, 18832.52918677044, 19073.141708623145, 19444.513887152934, 19562.70655940162, 19799.802001979795, 986.156835905305, 986.2405947420447, 1006.1397505133152, 1021.8875923648393, 1030.4156440346194, 10348.586056557653, 10420.218483613759, 10588.0, 10721.41032243234, 11043.116550675926, 446205.0, 459211.0, 460007.0, 463443.0, 463454.0, 105376.47311763545, 108591.45704271586, 109171.0, 110625.0, 111412.0, 1136.7840110379168, 1163.5345861655237, 1168.2698313554029, 1169.1990986174499, 1170.8829117088223, 15842.0, 16215.108169050816, 16757.07836069028, 16819.495415137564, 17282.481525554253, 47718.860099005324, 47881.52118478771, 48848.75575622241, 48973.0, 50068.749656251486, 64941.02588461271, 66383.0, 66432.0, 66557.66721166363, 66679.0, 11962.760744784882, 12025.4588543514, 12063.095267854771, 12069.0, 12102.910738033619, 18026.098695065455, 19352.129154187813, 19554.21783128659, 19614.411567652995, 19739.11173997145, 15564.221788910283, 15590.0, 15598.142102184034, 15707.921460392625, 15808.288627011581, 13627.38676759568, 13903.304834758424, 13905.791413128609, 14008.229547374585, 14834.406623734929, 15089.698206035599, 15879.52361429159, 15984.760228596813, 16236.756448653516, 16248.675026499168, 12812.359382030674, 12880.42038108306, 12894.742105158031, 12988.805167922677, 13061.542846000344, 15933.20333983273, 15954.760678590063, 15965.121918294606, 16034.198290085216, 16112.355505779638], "value": 11166.150886730804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.8467226268979, 1390.7218556288744, 1392.1368751374143, 1396.7625503664376, 1413.4487549855558, 13149.211047337154, 13569.457221711144, 13645.795313070312, 13669.863301366984, 13724.245166515837, 12963.675908102303, 13554.254516001616, 13609.047366684312, 13618.659533511667, 13619.931900340509, 2574.317805781465, 2628.2378110348072, 2634.262406526166, 2644.074573899139, 2648.1658277642578, 2520.117958714454, 2570.640110384548, 2580.2259322203263, 2583.2121203033066, 2584.612308153773, 2418.2866054513875, 2515.9748402515925, 2549.107812265711, 2550.0564791027346, 2554.846709197445, 2512.836665616738, 2588.72818354072, 2614.0720044384257, 2619.305883940757, 2640.4587059652727, 2489.65144879717, 2492.5887228607257, 2504.6368276599974, 2519.206449968254, 2527.229195095495, 12750.10749247553, 13005.674858128528, 13028.80456793149, 13040.087193896432, 13047.869521304856, 7238.819029524251, 7606.695732170707, 7625.313721765012, 7637.847243055107, 7643.770686879402, 4055.7566546007038, 4169.91660166795, 4203.516595591485, 4264.189803937242, 4270.572942705736, 1551.8913676042682, 1615.8545730884277, 1642.170703794588, 1678.8656907447375, 1681.159420289855, 20793.0, 21195.788042119537, 21206.681899771516, 21232.363029108998, 21269.78730212709, 6703.195616526048, 6730.93269067303, 6807.217170025411, 6894.310568943066, 7108.147022357247, 17142.828571714123, 17169.0, 17179.742303865452, 17198.39805606823, 17221.794474386672, 7401.925980740124, 7675.0, 7686.116096648845, 7697.960775295375, 7700.499467534592, 6784.457243420515, 6931.0, 6941.062956500808, 6962.721491140399, 7023.543469674455, 5106.259592359162, 5370.0, 5377.489138531833, 5397.703126328011, 5637.577181711388, 1626.2356692354574, 1663.2931004323113, 1675.5308513616208, 1683.3151123957268, 1712.6317841664102, 864.3430992445786, 880.5773228850188, 881.9514926678966, 900.1718419054355, 911.3483859040817, 6669.233038200572, 6763.661816909135, 6805.795826125224, 6975.058367120475, 7093.361597456254, 717.2970488920782, 717.6698718589403, 720.538855132705, 731.3799933148102, 741.1476801678006, 4047.1233681941526, 4071.9389209161886, 4170.311898536707, 4895.437024742129, 5013.8718788272345, 17069.7439538407, 17604.823951760318, 17895.0, 17988.91005544964, 18034.458966231035, 16954.830451695572, 17027.659446810994, 17557.034363110153, 17746.911265443847, 17807.821921780876, 9622.278329125344, 9692.806143877224, 9766.414015159113, 9774.0, 10125.189984801345, 6992.370686638227, 7354.4484163689, 7373.483856130234, 7554.6600402983095, 7639.04511936008, 15393.230338483256, 15421.614459638598, 15464.072155670696, 15668.921655392107, 15894.205289735699, 14876.0, 15153.54539363821, 15864.44474443389, 15898.52304430869, 16079.67840643204, 10699.0, 10857.34855908648, 10863.728406789893, 10865.837012444661, 10868.07621352194, 12307.876921230672, 12445.066620003356, 12486.687832804253, 12493.812592811297, 12576.811347829973, 8921.821563568563, 9844.556994935389, 10082.395056296646, 10427.635032773816, 10584.523696433833, 10320.587176512856, 10399.792004159723, 10515.78968420612, 10631.893681063091, 10666.46667666629, 8443.746687599381, 8588.0, 8639.352048596254, 8684.001339845998, 8795.604197810986, 6445.70994305248, 6456.192975878015, 6677.966610166918, 6814.318568143146, 6914.688839002358, 6679.9332006679315, 6728.966355168192, 6880.31196880328, 6979.930200697928, 7020.894686579808], "value": 6040.924627798686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.426201344427, 496.91296554471216, 514.6294667839155, 518.7821115131644, 523.3275241314911, 6284.905726414102, 6294.150289710888, 6304.432601065909, 6357.23713154421, 6368.4147413862065, 5991.550633702468, 6214.5649804513705, 6224.28420731616, 6225.906611400833, 6229.781957631484, 5000.649954503196, 5032.899342013157, 5067.695938243699, 5081.2124120761155, 5091.185410334348, 5048.848534543969, 5053.004063394957, 5059.898802023958, 5060.39275286966, 5108.8211912583065, 5009.874753131183, 5031.974840125794, 5034.471380505049, 5042.268871013701, 5050.116229659813, 4823.276508523714, 4994.425641051289, 4995.425526064513, 5001.949980500185, 5008.574271186953, 4424.336349547561, 4437.556244375569, 4437.911241775147, 4456.710313829591, 4497.865064048084, 5966.850828729316, 5974.6713930733795, 5981.970090149565, 6006.8498287542725, 6007.36922623127, 5685.459881311269, 5723.456271654186, 5735.770569177228, 5740.368559458456, 5757.0, 6566.93433065668, 6569.441597464222, 6580.967095164541, 6595.307492713244, 6596.0, 4873.269009648546, 4930.827421040282, 4937.407511098691, 4942.901141977176, 4957.727324997124, 6870.106886104824, 6899.931000689979, 6944.72221111155, 6957.930420695779, 6960.512764106515, 5006.823396501819, 5020.447750747415, 5045.394552653705, 5057.0, 5059.519345662156, 5089.9745501272255, 5098.796048158032, 5111.87220319495, 5137.152369858932, 5144.636671282114, 5707.771689132472, 5737.942620573825, 5745.1669507921115, 5756.884862302814, 5775.855603609859, 6652.767153149616, 6654.900176497356, 6657.966710166515, 6661.866762664719, 6669.366410191024, 1670.5573023148875, 1771.14099661664, 1771.16755125091, 1798.52339130128, 1806.3406856497547, 1204.307523174161, 1205.8432403787451, 1208.0697862645889, 1245.17818239963, 1248.887600115994, 5579.38626751057, 5724.227229323988, 5738.1679656450415, 5761.654300741969, 5782.855428614318, 6606.735730570819, 6743.224529179207, 6751.392374686302, 6765.985102234704, 6767.627780472121, 5774.2782152230975, 5785.218995435646, 5818.243628328375, 5819.418058194231, 5820.912686309709, 3538.8230588470474, 3558.3417067842533, 3569.12620874038, 3569.6430356964615, 3576.481410195507, 6505.902411463831, 6533.248676402274, 6548.937084818267, 6571.0, 6583.604983700898, 6847.246802851682, 6867.759628413081, 6890.625312256448, 6900.654967251618, 6910.20532638753, 6453.1610890583925, 6523.673816309166, 6538.1500404947055, 6546.934530654633, 6556.213254409501, 6654.234763002317, 6668.933310667026, 6676.866462670622, 6678.131842860591, 6708.664566771544, 6650.83610368174, 6667.133272674521, 6671.499637527302, 6672.833179170365, 6677.43241824431, 6163.476104531165, 6499.28507864144, 6530.771423000172, 6536.346365363425, 6543.05998970774, 4944.332515110414, 4952.380952380952, 4969.776360063878, 4975.228839529878, 5008.899822003613, 6718.193816742022, 6740.359665831738, 6753.561018533779, 6758.357955994173, 6777.966110169417, 6558.8360290991195, 6561.7034038088195, 6569.671516424064, 6570.342965703582, 6595.965855706429, 6494.740210391531, 6571.4557079087335, 6577.868442631217, 6579.2104947406615, 6582.736690532325, 6476.676166191766, 6491.837704057436, 6504.902426463512, 6511.967440162958, 6521.576097553644, 6605.966970165118, 6629.0, 6633.711369577488, 6652.634105124071, 6675.165604299463, 6401.527648640746, 6410.711517981609, 6424.775132870327, 6432.163818703539, 6440.8389790255615], "value": 5075.906063156579, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.7151768398743, 862.0991064337767, 871.0592560035159, 878.5212059427612, 891.8840550728406, 16939.661206775858, 17348.21933013014, 17768.289268429246, 18130.093495325214, 20209.898950505227, 19394.70907936382, 20148.597028059467, 20281.594368112666, 20287.08708108135, 20352.796472035276, 990.1929927109419, 999.8650182225398, 1052.1582733812957, 1053.483792941457, 1057.1120258982453, 1054.520193312045, 1056.9418681972488, 1058.227493929432, 1062.3625824505311, 1064.6593090211136, 1114.6043154680094, 1115.3530952047834, 1117.5027112934747, 1122.691259903529, 1124.6232512108413, 1083.804915115283, 1114.509615769063, 1120.495776900394, 1130.7060164357245, 1139.2139423797553, 794.6582969323189, 795.4511387142853, 796.3867821777256, 798.6166640012768, 798.6964953317702, 18493.815061849346, 18728.62542749151, 18874.81125188758, 18980.715289270673, 19009.33467328637, 19453.221871125137, 19465.221391144478, 19940.202391904306, 20121.195152193894, 20137.39587812368, 15433.691326173526, 15461.458848940345, 15469.5359139226, 15483.380664773396, 15591.1424871632, 3457.533233013561, 3525.4359302511475, 3561.519194908706, 3581.6418358164237, 3646.890593282206, 95511.52244238804, 96177.0, 98546.50726746392, 101219.95120195257, 102514.99999999926, 15148.772768408482, 15235.314410851539, 15474.0, 15509.0, 15514.37942482288, 26639.46721065568, 28373.574396384072, 28486.71513284882, 28633.14100576986, 28871.71128288732, 8368.20502052304, 8394.412391132684, 8611.95694021526, 8690.565471726388, 8795.912040879637, 3589.5513060867393, 3734.626537346244, 3746.4193050077283, 4051.2505186540584, 4244.745315281093, 4620.283856002325, 4740.976295118502, 4741.857744267678, 4752.429708434941, 4775.2598347256235, 894.5080205886867, 947.7630592351912, 956.3974695941512, 958.3770549143113, 961.7451375385529, 661.4708233413251, 672.2135101930753, 676.88378033206, 697.6197972105215, 710.7761055267574, 11452.541898323974, 11650.601034881342, 12208.86495319414, 12412.875871241353, 12482.563110291096, 686.5606012152226, 688.1913751342153, 691.2016620802981, 704.827317307263, 708.9042979197742, 5169.922451163236, 5231.686098834082, 5443.618946673695, 5514.255575497256, 6017.0, 90249.0, 91773.0, 94558.0, 95705.5214723922, 96683.0, 76126.0, 79164.20835791569, 80019.19980800233, 81581.0, 83066.58466707749, 67832.60836958133, 68215.3178468209, 68532.97200541996, 70865.64567177132, 72695.27304726886, 11272.774544509228, 12048.337341446304, 12280.81578776337, 12668.366581671064, 12743.87256127427, 32627.510587340734, 33229.50155747714, 33302.66697332996, 33607.65569377197, 33843.3231335367, 58082.7095864518, 60670.393296066475, 61871.0, 62435.687821560605, 62943.68528157513, 18216.635667286846, 18289.817101828812, 18769.90615046916, 18946.526336841136, 19073.523161920508, 19921.203151873764, 20234.59530809405, 20555.38333849987, 20637.277695280594, 20768.688469672667, 17074.562266378027, 17833.375831845824, 18286.908565457088, 18552.81447185511, 18692.626147477247, 17712.645747084727, 18552.721709174642, 18879.528011799815, 18917.054147292303, 19058.904705476383, 17182.484525464257, 18048.005436085998, 18365.908170459596, 18446.90776546109, 18725.25098996025, 11857.407129643656, 11943.163978521769, 12377.938110309391, 12431.751364972832, 13008.089433739926, 13464.394102265225, 14515.129092254498, 14623.122612643276, 14965.0, 15142.167180805161], "value": 8734.867734651412, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 108.0, 108.0, 108.0, 107.0, 109.0, 108.0, 108.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 144.0, 171.0, 123.0, 153.0, 148.0, 135.0, 162.0, 121.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 164.0, 162.0, 169.0, 162.0, 164.0, 166.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 176.0, 73.0, 74.0, 74.0, 73.0, 101.0, 75.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 143.0, 82.0, 83.0, 82.0, 131.0, 82.0, 81.0, 132.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 153.0, 149.0, 150.0, 152.0, 151.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 93.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 56.0, 54.0, 56.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 76.0, 78.0, 76.0, 77.0, 75.0, 87.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 128.0, 129.0, 128.0, 132.0, 133.0, 132.0, 128.0, 156.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 189.0, 180.0, 185.0, 191.0, 186.0, 183.0, 184.0, 180.0, 181.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 68.0, 70.0, 68.0, 68.0, 68.0, 67.0, 69.0], "value": 68.2, "unit": "score"}]}]} 21:58:41 INFO - Return code: 0 21:58:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:41 INFO - # TBPL SUCCESS # 21:58:41 INFO - Running post-action listener: _resource_record_post_action 21:58:41 INFO - [mozharness: 2017-06-23 04:58:41.213266Z] Finished run-tests step (success) 21:58:41 INFO - Running post-run listener: _resource_record_post_run 21:58:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8593408; Write bytes: 444149760; Read time: 1896; Write time: 539020 21:58:41 INFO - TinderboxPrint: CPU usage
13.2% 21:58:41 INFO - TinderboxPrint: I/O read bytes / time
8,593,408 / 1,896 21:58:41 INFO - TinderboxPrint: I/O write bytes / time
444,149,760 / 539,020 21:58:41 INFO - TinderboxPrint: CPU idle
8,321.7 (86.7%) 21:58:41 INFO - TinderboxPrint: CPU user
1,211.4 (12.6%) 21:58:41 INFO - TinderboxPrint: Swap in / out
0 / 0 21:58:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116113408; Read time: 0; Write time: 87380 21:58:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:58:41 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6221824; Write bytes: 327405568; Read time: 1316; Write time: 451532 21:58:41 INFO - Running post-run listener: _upload_blobber_files 21:58:41 INFO - Blob upload gear active. 21:58:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:41 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 21:58:41 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'] 21:58:41 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 21:58:42 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:43 INFO - (blobuploader) - INFO - Done attempting. 21:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:44 INFO - (blobuploader) - INFO - Done attempting. 21:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:45 INFO - (blobuploader) - INFO - Done attempting. 21:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:51 INFO - (blobuploader) - INFO - Done attempting. 21:58:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:51 INFO - Return code: 0 21:58:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d556dfcd99f16f702c80bdf7794d505659eaf4617540de1e10d5e0aa0ef42ecc736e4f6470192011b8fbb89d47933ccc5446867393b6bcd9ce5d94270b8962", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d1bfa398bd7ad0da18c18a64c34e3bb6628f702ce8d613def641af9716d2641f1e6a1f08df5a0da96fc4e44cf9eacd43608c6060de24b62a3eac6fe5abdfa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028f5e6ae3fb5e3221552b606b95e7520a838469a025d1f7c87c9cb0e5e092e575eca000d42035907e3d11513d9d9d5d309ccb4ecaf7ca03f3aafdc645a8dd8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8d34be4e14b2e7e3e9403716491fbafe1e5b7d1fbd243ee3e9341fb62884abfde948f621130a882bbf15175a69668ed11b6fd2ba070a40fa150e34c4fc476a"} 21:58:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:51 INFO - Contents: 21:58:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d556dfcd99f16f702c80bdf7794d505659eaf4617540de1e10d5e0aa0ef42ecc736e4f6470192011b8fbb89d47933ccc5446867393b6bcd9ce5d94270b8962", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d1bfa398bd7ad0da18c18a64c34e3bb6628f702ce8d613def641af9716d2641f1e6a1f08df5a0da96fc4e44cf9eacd43608c6060de24b62a3eac6fe5abdfa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028f5e6ae3fb5e3221552b606b95e7520a838469a025d1f7c87c9cb0e5e092e575eca000d42035907e3d11513d9d9d5d309ccb4ecaf7ca03f3aafdc645a8dd8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8d34be4e14b2e7e3e9403716491fbafe1e5b7d1fbd243ee3e9341fb62884abfde948f621130a882bbf15175a69668ed11b6fd2ba070a40fa150e34c4fc476a"} 21:58:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:51 INFO - Copying logs to upload dir... 21:58:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.958704 ========= master_lag: -0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-06-22 21:58:51.176218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 21:58:51.179885) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d556dfcd99f16f702c80bdf7794d505659eaf4617540de1e10d5e0aa0ef42ecc736e4f6470192011b8fbb89d47933ccc5446867393b6bcd9ce5d94270b8962", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d1bfa398bd7ad0da18c18a64c34e3bb6628f702ce8d613def641af9716d2641f1e6a1f08df5a0da96fc4e44cf9eacd43608c6060de24b62a3eac6fe5abdfa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028f5e6ae3fb5e3221552b606b95e7520a838469a025d1f7c87c9cb0e5e092e575eca000d42035907e3d11513d9d9d5d309ccb4ecaf7ca03f3aafdc645a8dd8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8d34be4e14b2e7e3e9403716491fbafe1e5b7d1fbd243ee3e9341fb62884abfde948f621130a882bbf15175a69668ed11b6fd2ba070a40fa150e34c4fc476a"} build_url:https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/W9j5yHgZQaeyrWT3vlLonw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d556dfcd99f16f702c80bdf7794d505659eaf4617540de1e10d5e0aa0ef42ecc736e4f6470192011b8fbb89d47933ccc5446867393b6bcd9ce5d94270b8962", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d1bfa398bd7ad0da18c18a64c34e3bb6628f702ce8d613def641af9716d2641f1e6a1f08df5a0da96fc4e44cf9eacd43608c6060de24b62a3eac6fe5abdfa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/028f5e6ae3fb5e3221552b606b95e7520a838469a025d1f7c87c9cb0e5e092e575eca000d42035907e3d11513d9d9d5d309ccb4ecaf7ca03f3aafdc645a8dd8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8d34be4e14b2e7e3e9403716491fbafe1e5b7d1fbd243ee3e9341fb62884abfde948f621130a882bbf15175a69668ed11b6fd2ba070a40fa150e34c4fc476a"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 21:58:51.257560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:58:51.257941) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498192662.87868-1430858450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 21:58:51.340494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 21:58:51.340862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 21:58:51.341188) ========= ========= Total master_lag: -0.06 =========