builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1496141688.81 results: success (0) revision: 286f71223256cbb3a769432fd860f563c4886e81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.806000) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.806445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.806715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.840950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.841470) ========= 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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 03:54:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2017-05-30 03:54:49 (25.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.975959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:48.979256) ========= 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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017682 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:49.028659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 03:54:49.028976) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 286f71223256cbb3a769432fd860f563c4886e81 --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 286f71223256cbb3a769432fd860f563c4886e81 --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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 03:54:49,518 truncating revision to first 12 chars 2017-05-30 03:54:49,519 Setting DEBUG logging. 2017-05-30 03:54:49,519 attempt 1/10 2017-05-30 03:54:49,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/286f71223256?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 03:54:50,922 unpacking tar archive at: mozilla-central-286f71223256/testing/mozharness/ program finished with exit code 0 elapsedTime=1.755222 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 03:54:50.799147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:50.802472) ========= script_repo_revision: 286f71223256cbb3a769432fd860f563c4886e81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:50.802831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:50.803087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 03:54:50.811843) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2017-05-30 03:54:50.812103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:54:51 INFO - MultiFileLogger online at 20170530 03:54:51 in /builds/slave/test 03:54:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:54:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:51 INFO - {'append_to_log': False, 03:54:51 INFO - 'base_work_dir': '/builds/slave/test', 03:54:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:54:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:51 INFO - 'branch': 'Firefox-Non-PGO', 03:54:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:51 INFO - 'config_files': ('talos/linux_config.py',), 03:54:51 INFO - 'default_actions': ('clobber', 03:54:51 INFO - 'read-buildbot-config', 03:54:51 INFO - 'download-and-extract', 03:54:51 INFO - 'populate-webroot', 03:54:51 INFO - 'create-virtualenv', 03:54:51 INFO - 'install', 03:54:51 INFO - 'setup-mitmproxy', 03:54:51 INFO - 'run-tests'), 03:54:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:51 INFO - 'download_minidump_stackwalk': True, 03:54:51 INFO - 'download_symbols': 'ondemand', 03:54:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:51 INFO - 'gecko_profile': False, 03:54:51 INFO - 'gecko_profile_interval': 0, 03:54:51 INFO - 'installer_path': 'installer.exe', 03:54:51 INFO - 'log_level': 'info', 03:54:51 INFO - 'log_name': 'talos', 03:54:51 INFO - 'log_to_console': True, 03:54:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:54:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:54:51 INFO - 'opt_config_files': (), 03:54:51 INFO - 'pip_index': False, 03:54:51 INFO - 'suite': 'dromaeojs-e10s', 03:54:51 INFO - 'system_bits': '32', 03:54:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:51 INFO - 'title': 'talos-linux64-ix-077', 03:54:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:51 INFO - 'use_talos_json': True, 03:54:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:51 INFO - 'work_dir': 'build'} 03:54:51 INFO - [mozharness: 2017-05-30 10:54:51.397535Z] Running clobber step. 03:54:51 INFO - Running pre-action listener: _resource_record_pre_action 03:54:51 INFO - Running main action method: clobber 03:54:51 INFO - rmtree: /builds/slave/test/build 03:54:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:52 INFO - Running post-action listener: _resource_record_post_action 03:54:52 INFO - [mozharness: 2017-05-30 10:54:52.407989Z] Finished clobber step (success) 03:54:52 INFO - [mozharness: 2017-05-30 10:54:52.408089Z] Running read-buildbot-config step. 03:54:52 INFO - Running pre-action listener: _resource_record_pre_action 03:54:52 INFO - Running main action method: read_buildbot_config 03:54:52 INFO - Using buildbot properties: 03:54:52 INFO - { 03:54:52 INFO - "project": "", 03:54:52 INFO - "product": "firefox", 03:54:52 INFO - "who": "nobody@mozilla.org", 03:54:52 INFO - "installer_path": "public/build/target.tar.bz2", 03:54:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:54:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:54:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:54:52 INFO - "stage_platform": "linux64", 03:54:52 INFO - "basedir": "/builds/slave/test", 03:54:52 INFO - "buildnumber": 867, 03:54:52 INFO - "platform": "ubuntu64_hw", 03:54:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:54:52 INFO - "slavebuilddir": "test", 03:54:52 INFO - "taskId": "ct-kpmMGQ5e3wmGB6Lkk6A", 03:54:52 INFO - "branch": "mozilla-central", 03:54:52 INFO - "script_repo_revision": "production", 03:54:52 INFO - "revision": "286f71223256cbb3a769432fd860f563c4886e81", 03:54:52 INFO - "slavename": "talos-linux64-ix-077", 03:54:52 INFO - "repo_path": "mozilla-central" 03:54:52 INFO - } 03:54:52 INFO - Finding installer, test and symbols from parent task. 03:54:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ct-kpmMGQ5e3wmGB6Lkk6A'}, attempt #1 03:54:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ct-kpmMGQ5e3wmGB6Lkk6A'}, attempt #1 03:54:53 INFO - Task dependencies: KJMV0DeVRp-9cI_dTrOG-w 03:54:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w'}, attempt #1 03:54:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 03:54:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/test_packages.json 03:54:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.crashreporter-symbols.zip 03:54:53 INFO - Running post-action listener: _resource_record_post_action 03:54:53 INFO - [mozharness: 2017-05-30 10:54:53.752199Z] Finished read-buildbot-config step (success) 03:54:53 INFO - [mozharness: 2017-05-30 10:54:53.752418Z] Running download-and-extract step. 03:54:53 INFO - Running pre-action listener: _resource_record_pre_action 03:54:53 INFO - Running main action method: download_and_extract 03:54:53 INFO - mkdir: /builds/slave/test/build/tests 03:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:53 INFO - trying https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.test_packages.json 03:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:54:54 INFO - Downloaded 986 bytes. 03:54:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:54:54 INFO - Using the following test package requirements: 03:54:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:54:54 INFO - u'common': [u'target.common.tests.zip'], 03:54:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:54:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:54:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:54:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:54:54 INFO - u'mozbase': [u'target.common.tests.zip'], 03:54:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:54:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:54:54 INFO - u'web-platform': [u'target.common.tests.zip', 03:54:54 INFO - u'target.web-platform.tests.zip'], 03:54:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:54:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:54:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip 03:54:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:54:54 INFO - Fetch https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip into memory 03:54:55 INFO - Content-Length response header: 65722190 03:54:55 INFO - Bytes received: 65722190 03:55:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:55:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip 03:55:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:55:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.common.tests.zip into memory 03:55:07 INFO - Content-Length response header: 65722190 03:55:07 INFO - Bytes received: 65722190 03:55:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.talos.tests.zip 03:55:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:55:19 INFO - Fetch https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.talos.tests.zip into memory 03:55:19 INFO - Content-Length response header: 14447425 03:55:19 INFO - Bytes received: 14447425 03:55: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')]} 03:55:20 INFO - trying https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 03:55:20 INFO - Downloading https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:55:21 INFO - Downloaded 59738838 bytes. 03:55:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 03:55:21 INFO - mkdir: /builds/slave/test/properties 03:55:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:21 INFO - Contents: 03:55:21 INFO - build_url:https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 03:55:21 INFO - Running post-action listener: _resource_record_post_action 03:55:21 INFO - Running post-action listener: set_extra_try_arguments 03:55:21 INFO - [mozharness: 2017-05-30 10:55:21.673023Z] Finished download-and-extract step (success) 03:55:21 INFO - [mozharness: 2017-05-30 10:55:21.673119Z] Running populate-webroot step. 03:55:21 INFO - Running pre-action listener: _resource_record_pre_action 03:55:21 INFO - Running main action method: populate_webroot 03:55:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:21 INFO - '--tppagecycles', 03:55:21 INFO - '7'], 03:55:21 INFO - 'tests': ['tsvgm']}}, 03:55:21 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:55:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['damp', 'tps']}, 03:55:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'tests': ['damp', 'tps']}, 03:55:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['dromaeo_dom']}, 03:55:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:55:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:55:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:55:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['a11yr', 03:55:21 INFO - 'ts_paint', 03:55:21 INFO - 'tpaint', 03:55:21 INFO - 'sessionrestore', 03:55:21 INFO - 'sessionrestore_no_auto_restore', 03:55:21 INFO - 'tabpaint']}, 03:55:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:55:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:55:21 INFO - 'bloom_basic_ref']}, 03:55:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:55:21 INFO - 'talos_options': ['--mitmproxy', 03:55:21 INFO - 'mitmproxy-recording-1.mp', 03:55:21 INFO - '--firstNonBlankPaint'], 03:55:21 INFO - 'tests': ['Quantum_1']}, 03:55:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['tsvgx', 03:55:21 INFO - 'tsvgr_opacity', 03:55:21 INFO - 'tart', 03:55:21 INFO - 'tscrollx', 03:55:21 INFO - 'cart', 03:55:21 INFO - 'tsvg_static']}, 03:55:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:21 INFO - 'tsvgr_opacity', 03:55:21 INFO - 'tart', 03:55:21 INFO - 'tscrollx', 03:55:21 INFO - 'cart', 03:55:21 INFO - 'tsvg_static']}, 03:55:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'talos_options': ['--disable-e10s'], 03:55:21 INFO - 'tests': ['tp5o']}, 03:55:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:55:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'talos_options': ['--disable-e10s', 03:55:21 INFO - '--xperf_path', 03:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:21 INFO - 'tests': ['tp5n']}, 03:55:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:55:21 INFO - 'talos_options': ['--xperf_path', 03:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:21 INFO - 'tests': ['tp5n']}}, 03:55:21 INFO - 'talos.zip': {'path': '', 03:55:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:21 INFO - Running post-action listener: _resource_record_post_action 03:55:21 INFO - [mozharness: 2017-05-30 10:55:21.687403Z] Finished populate-webroot step (success) 03:55:21 INFO - [mozharness: 2017-05-30 10:55:21.687497Z] Running create-virtualenv step. 03:55:21 INFO - Running pre-action listener: _resource_record_pre_action 03:55:21 INFO - Running main action method: create_virtualenv 03:55:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:21 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 03:55:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:55:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:21 INFO - Using real prefix '/usr' 03:55:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:22 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:24 INFO - Installing pip.................done. 03:55:24 INFO - Return code: 0 03:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:55:24 INFO - Reading from file tmpfile_stdout 03:55:24 INFO - Output received: 03:55:24 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) 03:55:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:24 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:24 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 03:55:24 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 03:55:24 INFO - Using env: {'DISPLAY': ':0', 03:55:24 INFO - 'HOME': '/home/cltbld', 03:55:24 INFO - 'LANG': 'en_US.UTF-8', 03:55:24 INFO - 'LANGUAGE': 'en_US:en', 03:55:24 INFO - 'LOGNAME': 'cltbld', 03:55:24 INFO - 'MAIL': '/var/mail/cltbld', 03:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:24 INFO - 'MOZ_NO_REMOTE': '1', 03:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:24 INFO - 'NO_EM_RESTART': '1', 03:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:24 INFO - 'PWD': '/builds/slave/test', 03:55:24 INFO - 'SHELL': '/bin/bash', 03:55:24 INFO - 'SHLVL': '1', 03:55:24 INFO - 'TERM': 'linux', 03:55:24 INFO - 'TMOUT': '86400', 03:55:24 INFO - 'USER': 'cltbld', 03:55:24 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:24 INFO - '_': '/tools/buildbot/bin/python'} 03:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:24 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 03:55:24 INFO - Cleaning up... 03:55:24 INFO - Return code: 0 03:55:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:24 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:24 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 03:55:24 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 03:55:24 INFO - Using env: {'DISPLAY': ':0', 03:55:24 INFO - 'HOME': '/home/cltbld', 03:55:24 INFO - 'LANG': 'en_US.UTF-8', 03:55:24 INFO - 'LANGUAGE': 'en_US:en', 03:55:24 INFO - 'LOGNAME': 'cltbld', 03:55:24 INFO - 'MAIL': '/var/mail/cltbld', 03:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:24 INFO - 'MOZ_NO_REMOTE': '1', 03:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:24 INFO - 'NO_EM_RESTART': '1', 03:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:24 INFO - 'PWD': '/builds/slave/test', 03:55:24 INFO - 'SHELL': '/bin/bash', 03:55:24 INFO - 'SHLVL': '1', 03:55:24 INFO - 'TERM': 'linux', 03:55:24 INFO - 'TMOUT': '86400', 03:55:24 INFO - 'USER': 'cltbld', 03:55:24 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:24 INFO - '_': '/tools/buildbot/bin/python'} 03:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:24 INFO - Downloading/unpacking psutil>=3.1.1 03:55: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 03:55: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 03:55: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 03:55: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 03:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:26 INFO - Installing collected packages: psutil 03:55:26 INFO - Running setup.py install for psutil 03:55:26 INFO - building 'psutil._psutil_linux' extension 03:55:26 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 03:55:26 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 03:55:26 INFO - building 'psutil._psutil_posix' extension 03:55:26 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 03:55:26 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 03:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:26 INFO - Successfully installed psutil 03:55:26 INFO - Cleaning up... 03:55:26 INFO - Return code: 0 03:55:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55:26 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')]} 03:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:26 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')]} 03:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:26 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:26 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 03:55:26 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 03:55:26 INFO - Using env: {'DISPLAY': ':0', 03:55:26 INFO - 'HOME': '/home/cltbld', 03:55:26 INFO - 'LANG': 'en_US.UTF-8', 03:55:26 INFO - 'LANGUAGE': 'en_US:en', 03:55:26 INFO - 'LOGNAME': 'cltbld', 03:55:26 INFO - 'MAIL': '/var/mail/cltbld', 03:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:26 INFO - 'MOZ_NO_REMOTE': '1', 03:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:26 INFO - 'NO_EM_RESTART': '1', 03:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:26 INFO - 'PWD': '/builds/slave/test', 03:55:26 INFO - 'SHELL': '/bin/bash', 03:55:26 INFO - 'SHLVL': '1', 03:55:26 INFO - 'TERM': 'linux', 03:55:26 INFO - 'TMOUT': '86400', 03:55:26 INFO - 'USER': 'cltbld', 03:55:26 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:26 INFO - '_': '/tools/buildbot/bin/python'} 03:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55: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 03:55: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 03:55: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 03:55: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 03:55:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:27 INFO - Installing collected packages: mozsystemmonitor 03:55:27 INFO - Running setup.py install for mozsystemmonitor 03:55:28 INFO - Successfully installed mozsystemmonitor 03:55:28 INFO - Cleaning up... 03:55:28 INFO - Return code: 0 03:55:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:28 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')]} 03:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:28 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')]} 03:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:28 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:28 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 03:55:28 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 03:55:28 INFO - Using env: {'DISPLAY': ':0', 03:55:28 INFO - 'HOME': '/home/cltbld', 03:55:28 INFO - 'LANG': 'en_US.UTF-8', 03:55:28 INFO - 'LANGUAGE': 'en_US:en', 03:55:28 INFO - 'LOGNAME': 'cltbld', 03:55:28 INFO - 'MAIL': '/var/mail/cltbld', 03:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:28 INFO - 'MOZ_NO_REMOTE': '1', 03:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:28 INFO - 'NO_EM_RESTART': '1', 03:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:28 INFO - 'PWD': '/builds/slave/test', 03:55:28 INFO - 'SHELL': '/bin/bash', 03:55:28 INFO - 'SHLVL': '1', 03:55:28 INFO - 'TERM': 'linux', 03:55:28 INFO - 'TMOUT': '86400', 03:55:28 INFO - 'USER': 'cltbld', 03:55:28 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:28 INFO - '_': '/tools/buildbot/bin/python'} 03:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:55: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 03:55: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 03:55: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 03:55: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 03:55:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:29 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 03:55:29 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 03:55:29 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 03:55:29 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 03:55:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:29 INFO - warning: no files found matching '*.txt' 03:55:29 INFO - no previously-included directories found matching 'build' 03:55:29 INFO - no previously-included directories found matching 'dist' 03:55:29 INFO - no previously-included directories found matching '.git*' 03:55:29 INFO - Installing collected packages: jsonschema, functools32 03:55:29 INFO - Running setup.py install for functools32 03:55:29 INFO - warning: no files found matching '*.txt' 03:55:29 INFO - no previously-included directories found matching 'build' 03:55:29 INFO - no previously-included directories found matching 'dist' 03:55:29 INFO - no previously-included directories found matching '.git*' 03:55:29 INFO - Successfully installed jsonschema functools32 03:55:29 INFO - Cleaning up... 03:55:29 INFO - Return code: 0 03:55:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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')]} 03:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:29 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:29 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 03:55:29 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 03:55:29 INFO - Using env: {'DISPLAY': ':0', 03:55:29 INFO - 'HOME': '/home/cltbld', 03:55:29 INFO - 'LANG': 'en_US.UTF-8', 03:55:29 INFO - 'LANGUAGE': 'en_US:en', 03:55:29 INFO - 'LOGNAME': 'cltbld', 03:55:29 INFO - 'MAIL': '/var/mail/cltbld', 03:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:29 INFO - 'MOZ_NO_REMOTE': '1', 03:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:29 INFO - 'NO_EM_RESTART': '1', 03:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:29 INFO - 'PWD': '/builds/slave/test', 03:55:29 INFO - 'SHELL': '/bin/bash', 03:55:29 INFO - 'SHLVL': '1', 03:55:29 INFO - 'TERM': 'linux', 03:55:29 INFO - 'TMOUT': '86400', 03:55:29 INFO - 'USER': 'cltbld', 03:55:29 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:29 INFO - '_': '/tools/buildbot/bin/python'} 03:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:30 INFO - Cleaning up... 03:55:30 INFO - Return code: 0 03:55:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:55:30 INFO - Using env: {'DISPLAY': ':0', 03:55:30 INFO - 'HOME': '/home/cltbld', 03:55:30 INFO - 'LANG': 'en_US.UTF-8', 03:55:30 INFO - 'LANGUAGE': 'en_US:en', 03:55:30 INFO - 'LOGNAME': 'cltbld', 03:55:30 INFO - 'MAIL': '/var/mail/cltbld', 03:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:30 INFO - 'MOZ_NO_REMOTE': '1', 03:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:30 INFO - 'NO_EM_RESTART': '1', 03:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:30 INFO - 'PWD': '/builds/slave/test', 03:55:30 INFO - 'SHELL': '/bin/bash', 03:55:30 INFO - 'SHLVL': '1', 03:55:30 INFO - 'TERM': 'linux', 03:55:30 INFO - 'TMOUT': '86400', 03:55:30 INFO - 'USER': 'cltbld', 03:55:30 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:30 INFO - '_': '/tools/buildbot/bin/python'} 03:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:30 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 03:55:30 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 03:55:30 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 03:55:30 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 03:55:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55:31 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 03:55:31 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 03:55:31 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 03:55:31 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 03:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:31 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 03:55:31 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 03:55:31 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 03:55:31 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 03:55:31 INFO - Downloading docopt-0.6.1.tar.gz 03:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:31 INFO - Running setup.py install for blobuploader 03:55:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:32 INFO - Running setup.py install for requests 03:55:32 INFO - Running setup.py install for docopt 03:55:32 INFO - Successfully installed blobuploader requests docopt 03:55:32 INFO - Cleaning up... 03:55:32 INFO - Return code: 0 03:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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')]} 03:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:32 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:32 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 03:55:32 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 03:55:32 INFO - Using env: {'DISPLAY': ':0', 03:55:32 INFO - 'HOME': '/home/cltbld', 03:55:32 INFO - 'LANG': 'en_US.UTF-8', 03:55:32 INFO - 'LANGUAGE': 'en_US:en', 03:55:32 INFO - 'LOGNAME': 'cltbld', 03:55:32 INFO - 'MAIL': '/var/mail/cltbld', 03:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:32 INFO - 'MOZ_NO_REMOTE': '1', 03:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:32 INFO - 'NO_EM_RESTART': '1', 03:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:32 INFO - 'PWD': '/builds/slave/test', 03:55:32 INFO - 'SHELL': '/bin/bash', 03:55:32 INFO - 'SHLVL': '1', 03:55:32 INFO - 'TERM': 'linux', 03:55:32 INFO - 'TMOUT': '86400', 03:55:32 INFO - 'USER': 'cltbld', 03:55:32 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:32 INFO - '_': '/tools/buildbot/bin/python'} 03:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:32 INFO - Running setup.py (path:/tmp/pip-uEAiBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:32 INFO - Running setup.py (path:/tmp/pip-aKvXPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:32 INFO - Running setup.py (path:/tmp/pip-dTok4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:32 INFO - Running setup.py (path:/tmp/pip-6zMyCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:33 INFO - Running setup.py (path:/tmp/pip-qFhnnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:33 INFO - Running setup.py (path:/tmp/pip-pUs5et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:33 INFO - Running setup.py (path:/tmp/pip-Zw04eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:33 INFO - Running setup.py (path:/tmp/pip-8vCZYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:33 INFO - Running setup.py (path:/tmp/pip-esqWZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:33 INFO - Running setup.py (path:/tmp/pip-ZNgdeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:33 INFO - Running setup.py (path:/tmp/pip-gSuasy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:33 INFO - Running setup.py (path:/tmp/pip-SRXY9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:33 INFO - Running setup.py (path:/tmp/pip-xSu0J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:33 INFO - Running setup.py (path:/tmp/pip-X9WkGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:33 INFO - Running setup.py (path:/tmp/pip-qSm4_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:33 INFO - Running setup.py (path:/tmp/pip-HFqN2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:33 INFO - Running setup.py (path:/tmp/pip-CZiTdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:33 INFO - Running setup.py install for manifestparser 03:55:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for mozcrash 03:55:34 INFO - Running setup.py install for mozdebug 03:55:34 INFO - Running setup.py install for mozdevice 03:55:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for mozfile 03:55:34 INFO - Running setup.py install for mozhttpd 03:55:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for mozinfo 03:55:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for mozInstall 03:55:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for mozleak 03:55:34 INFO - Running setup.py install for mozlog 03:55:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:34 INFO - Running setup.py install for moznetwork 03:55:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Running setup.py install for mozprocess 03:55:35 INFO - Running setup.py install for mozprofile 03:55:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Running setup.py install for mozrunner 03:55:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Running setup.py install for mozscreenshot 03:55:35 INFO - Running setup.py install for moztest 03:55:35 INFO - Running setup.py install for mozversion 03:55:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:55:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:55:35 INFO - Cleaning up... 03:55:35 INFO - Return code: 0 03:55:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:35 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')]} 03:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:35 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')]} 03:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:35 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:35 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 03:55:35 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 03:55:35 INFO - Using env: {'DISPLAY': ':0', 03:55:35 INFO - 'HOME': '/home/cltbld', 03:55:35 INFO - 'LANG': 'en_US.UTF-8', 03:55:35 INFO - 'LANGUAGE': 'en_US:en', 03:55:35 INFO - 'LOGNAME': 'cltbld', 03:55:35 INFO - 'MAIL': '/var/mail/cltbld', 03:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:35 INFO - 'MOZ_NO_REMOTE': '1', 03:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:35 INFO - 'NO_EM_RESTART': '1', 03:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:35 INFO - 'PWD': '/builds/slave/test', 03:55:35 INFO - 'SHELL': '/bin/bash', 03:55:35 INFO - 'SHLVL': '1', 03:55:35 INFO - 'TERM': 'linux', 03:55:35 INFO - 'TMOUT': '86400', 03:55:35 INFO - 'USER': 'cltbld', 03:55:35 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:35 INFO - '_': '/tools/buildbot/bin/python'} 03:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:35 INFO - Running setup.py (path:/tmp/pip-dZOZOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:36 INFO - Running setup.py (path:/tmp/pip-2XH2r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:36 INFO - Running setup.py (path:/tmp/pip-E5AbgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:36 INFO - Running setup.py (path:/tmp/pip-stCCHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:36 INFO - Running setup.py (path:/tmp/pip-Gdvi56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:36 INFO - Running setup.py (path:/tmp/pip-dv8cbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:36 INFO - Running setup.py (path:/tmp/pip-9yPyc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:36 INFO - Running setup.py (path:/tmp/pip-motplI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:36 INFO - Running setup.py (path:/tmp/pip-0EVV7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:36 INFO - Running setup.py (path:/tmp/pip-AJau6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:36 INFO - Running setup.py (path:/tmp/pip-8cuclP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:36 INFO - Running setup.py (path:/tmp/pip-Y17z0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:36 INFO - Running setup.py (path:/tmp/pip-FWn__v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:36 INFO - Running setup.py (path:/tmp/pip-OZiZgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:36 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)) 03:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:36 INFO - Running setup.py (path:/tmp/pip-SLiMks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:37 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)) 03:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:37 INFO - Running setup.py (path:/tmp/pip-1e4b5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:37 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)) 03:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:37 INFO - Running setup.py (path:/tmp/pip-wPwgJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:37 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)) 03:55:37 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)) 03:55:37 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)) 03:55:37 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)) 03:55:37 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)) 03:55:37 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)) 03:55:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55:37 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 03:55:37 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 03:55:37 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 03:55:37 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 03:55:38 INFO - Downloading blessings-1.6.tar.gz 03:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:55:38 INFO - Installing collected packages: blessings 03:55:38 INFO - Running setup.py install for blessings 03:55:38 INFO - Successfully installed blessings 03:55:38 INFO - Cleaning up... 03:55:38 INFO - Return code: 0 03:55:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:38 INFO - Reading from file tmpfile_stdout 03:55:38 INFO - Current package versions: 03:55:38 INFO - argparse == 1.2.1 03:55:38 INFO - blessings == 1.6 03:55:38 INFO - blobuploader == 1.2.4 03:55:38 INFO - docopt == 0.6.1 03:55:38 INFO - functools32 == 3.2.3-2 03:55:38 INFO - jsonschema == 2.5.1 03:55:38 INFO - manifestparser == 1.1 03:55:38 INFO - mozInstall == 1.12 03:55:38 INFO - mozcrash == 1.0 03:55:38 INFO - mozdebug == 0.1 03:55:38 INFO - mozdevice == 0.51 03:55:38 INFO - mozfile == 1.2 03:55:38 INFO - mozhttpd == 0.7 03:55:38 INFO - mozinfo == 0.9 03:55:38 INFO - mozleak == 0.1 03:55:38 INFO - mozlog == 3.4 03:55:38 INFO - moznetwork == 0.27 03:55:38 INFO - mozprocess == 0.25 03:55:38 INFO - mozprofile == 0.28 03:55:38 INFO - mozrunner == 6.13 03:55:38 INFO - mozscreenshot == 0.1 03:55:38 INFO - mozsystemmonitor == 0.3 03:55:38 INFO - moztest == 0.8 03:55:38 INFO - mozversion == 1.4 03:55:38 INFO - psutil == 3.1.1 03:55:38 INFO - requests == 1.2.3 03:55:38 INFO - wsgiref == 0.1.2 03:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:38 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:38 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 03:55:38 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 03:55:38 INFO - Using env: {'DISPLAY': ':0', 03:55:38 INFO - 'HOME': '/home/cltbld', 03:55:38 INFO - 'LANG': 'en_US.UTF-8', 03:55:38 INFO - 'LANGUAGE': 'en_US:en', 03:55:38 INFO - 'LOGNAME': 'cltbld', 03:55:38 INFO - 'MAIL': '/var/mail/cltbld', 03:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:38 INFO - 'MOZ_NO_REMOTE': '1', 03:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:38 INFO - 'NO_EM_RESTART': '1', 03:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:38 INFO - 'PWD': '/builds/slave/test', 03:55:38 INFO - 'SHELL': '/bin/bash', 03:55:38 INFO - 'SHLVL': '1', 03:55:38 INFO - 'TERM': 'linux', 03:55:38 INFO - 'TMOUT': '86400', 03:55:38 INFO - 'USER': 'cltbld', 03:55:38 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:38 INFO - '_': '/tools/buildbot/bin/python'} 03:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 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)) 03:55:38 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:40 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:55:40 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)) 03:55:40 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)) 03:55:40 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)) 03:55:40 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)) 03:55:40 INFO - Installing collected packages: marionette-driver 03:55:40 INFO - Running setup.py install for marionette-driver 03:55:40 INFO - Successfully installed marionette-driver 03:55:40 INFO - Cleaning up... 03:55:40 INFO - Return code: 0 03:55:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:55:40 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')]} 03:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:40 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')]} 03:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:40 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 0x16b63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a33ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', '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 03:55:40 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 03:55:40 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 03:55:40 INFO - Using env: {'DISPLAY': ':0', 03:55:40 INFO - 'HOME': '/home/cltbld', 03:55:40 INFO - 'LANG': 'en_US.UTF-8', 03:55:40 INFO - 'LANGUAGE': 'en_US:en', 03:55:40 INFO - 'LOGNAME': 'cltbld', 03:55:40 INFO - 'MAIL': '/var/mail/cltbld', 03:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:40 INFO - 'MOZ_NO_REMOTE': '1', 03:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:40 INFO - 'NO_EM_RESTART': '1', 03:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:40 INFO - 'PWD': '/builds/slave/test', 03:55:40 INFO - 'SHELL': '/bin/bash', 03:55:40 INFO - 'SHLVL': '1', 03:55:40 INFO - 'TERM': 'linux', 03:55:40 INFO - 'TMOUT': '86400', 03:55:40 INFO - 'USER': 'cltbld', 03:55:40 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:40 INFO - '_': '/tools/buildbot/bin/python'} 03:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:55:40 INFO - Cleaning up... 03:55:40 INFO - Return code: 0 03:55:40 INFO - Running post-action listener: _resource_record_post_action 03:55:40 INFO - Running post-action listener: _start_resource_monitoring 03:55:40 INFO - Starting resource monitoring. 03:55:40 INFO - [mozharness: 2017-05-30 10:55:40.561294Z] Finished create-virtualenv step (success) 03:55:40 INFO - [mozharness: 2017-05-30 10:55:40.561792Z] Running install step. 03:55:40 INFO - Running pre-action listener: _resource_record_pre_action 03:55:40 INFO - Running main action method: install 03:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:40 INFO - Reading from file tmpfile_stdout 03:55:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:40 INFO - Reading from file tmpfile_stdout 03:55:40 INFO - Output received: 03:55:40 INFO - Usage: mozinstall [options] installer 03:55:40 INFO - Options: 03:55:40 INFO - -h, --help show this help message and exit 03:55:40 INFO - -d DEST, --destination=DEST 03:55:40 INFO - Directory to install application into. [default: 03:55:40 INFO - "/builds/slave/test"] 03:55:40 INFO - --app=APP Application being installed. [default: firefox] 03:55:40 INFO - mkdir: /builds/slave/test/build/application 03:55:40 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'] 03:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:55:57 INFO - Reading from file tmpfile_stdout 03:55:57 INFO - Output received: 03:55:57 INFO - /builds/slave/test/build/application/firefox/firefox 03:55:57 INFO - Running post-action listener: _resource_record_post_action 03:55:57 INFO - [mozharness: 2017-05-30 10:55:57.648923Z] Finished install step (success) 03:55:57 INFO - [mozharness: 2017-05-30 10:55:57.649202Z] Running setup-mitmproxy step. 03:55:57 INFO - Running pre-action listener: _resource_record_pre_action 03:55:57 INFO - Running main action method: setup_mitmproxy 03:55:57 INFO - Skipping: mitmproxy is not required 03:55:57 INFO - Running post-action listener: _resource_record_post_action 03:55:57 INFO - [mozharness: 2017-05-30 10:55:57.650394Z] Finished setup-mitmproxy step (success) 03:55:57 INFO - [mozharness: 2017-05-30 10:55:57.650615Z] Running run-tests step. 03:55:57 INFO - Running pre-action listener: _resource_record_pre_action 03:55:57 INFO - Running main action method: run_tests 03:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:55:57 INFO - Python 2.7.3 03:55:57 INFO - Return code: 0 03:55:57 INFO - grabbing minidump binary from tooltool 03:55:57 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')]} 03:55:57 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 0x1a30e40>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:55:57 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 03:55:57 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 03:55:57 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 03:55:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:55:57 INFO - Return code: 0 03:55:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:55:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:55:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:55:57 INFO - ENV: RUST_BACKTRACE is now 1 03:55:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:55:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 03:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 03:55:57 INFO - Using env: {'DISPLAY': ':0', 03:55:57 INFO - 'HOME': '/home/cltbld', 03:55:57 INFO - 'LANG': 'en_US.UTF-8', 03:55:57 INFO - 'LANGUAGE': 'en_US:en', 03:55:57 INFO - 'LOGNAME': 'cltbld', 03:55:57 INFO - 'MAIL': '/var/mail/cltbld', 03:55:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:57 INFO - 'MOZ_NO_REMOTE': '1', 03:55:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:57 INFO - 'NO_EM_RESTART': '1', 03:55:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:57 INFO - 'PWD': '/builds/slave/test', 03:55:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:57 INFO - 'RUST_BACKTRACE': '1', 03:55:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:55:57 INFO - 'SHELL': '/bin/bash', 03:55:57 INFO - 'SHLVL': '1', 03:55:57 INFO - 'TERM': 'linux', 03:55:57 INFO - 'TMOUT': '86400', 03:55:57 INFO - 'USER': 'cltbld', 03:55:57 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453', 03:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:57 INFO - '_': '/tools/buildbot/bin/python'} 03:55:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 03:55:57 INFO - mozversion application_buildid: 20170530100155 03:55:57 INFO - mozversion application_changeset: 286f71223256cbb3a769432fd860f563c4886e81 03:55:57 INFO - mozversion application_display_name: Nightly 03:55:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:55:57 INFO - mozversion application_name: Firefox 03:55:57 INFO - mozversion application_remotingname: firefox 03:55:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:55:57 INFO - mozversion application_vendor: Mozilla 03:55:57 INFO - mozversion application_version: 55.0a1 03:55:57 INFO - mozversion platform_buildid: 20170530100155 03:55:57 INFO - mozversion platform_changeset: 286f71223256cbb3a769432fd860f563c4886e81 03:55:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:55:57 INFO - mozversion platform_version: 55.0a1 03:55:57 INFO - using testdate: 1496141757 03:55:57 INFO - actual date: 1496141757 03:55:57 INFO - starting webserver on 'localhost:46217' 03:55:57 INFO - SUITE-START | Running 2 tests 03:55:57 INFO - TEST-START | dromaeo_css 03:55:57 INFO - operating with platform_type : linux_ 03:55:57 INFO - Initialising browser for dromaeo_css test... 03:55:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46217/getInfo.html -profile /tmp/tmpRGfZvB/profile 03:55:57 INFO - TEST-INFO | started process 16148 (/builds/slave/test/build/application/firefox/firefox http://localhost:46217/getInfo.html) 03:56:32 INFO - TEST-INFO | 16148: killed by SIGTERM 03:56:32 INFO - Browser initialized. 03:56:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:32 INFO - TEST-INFO | started process 16348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRGfZvB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:44 INFO - PID 16348 | RSS: Main: 180174848 03:56:44 INFO - PID 16348 | 03:59:44 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46217/tests/dromaeo/cssquery-ext.html) 03:59:46 INFO - PID 16348 | RSS: Main: 176197632 03:59:46 INFO - PID 16348 | 04:02:47 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-ext.html (next: http://localhost:46217/tests/dromaeo/cssquery-jquery.html) 04:02:48 INFO - PID 16348 | RSS: Main: 183406592 04:02:48 INFO - PID 16348 | 04:05:49 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46217/tests/dromaeo/cssquery-mootools.html) 04:05:50 INFO - PID 16348 | RSS: Main: 179863552 04:05:50 INFO - PID 16348 | 04:08:52 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46217/tests/dromaeo/cssquery-prototype.html) 04:08:52 INFO - PID 16348 | RSS: Main: 183435264 04:08:52 INFO - PID 16348 | 04:11:55 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46217/tests/dromaeo/cssquery-yui.html) 04:11:56 INFO - PID 16348 | RSS: Main: 183721984 04:11:56 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | Cycle 1(1): loaded http://localhost:46217/tests/dromaeo/cssquery-yui.html (next: http://localhost:46217/tests/dromaeo/cssquery-dojo.html) 04:14:57 INFO - PID 16348 | RSS: Main: 181551104 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | __start_tp_report 04:14:57 INFO - PID 16348 | _x_x_mozilla_page_load 04:14:57 INFO - PID 16348 | _x_x_mozilla_page_load_details 04:14:57 INFO - PID 16348 | |i|pagename|runs| 04:14:57 INFO - PID 16348 | |0;dojo.html;3167.255694911696;3247.2368993286573;3258.9837050814745;3271.6401195868452;3358.244395011123;5766.221560089387;5820.447057529534;5833.708314584264;5872.412758724136;5877.735501902414;5749.425057494249;5775.2203452533895;5814.970925145369;5858;5939.4654481096695;5032.5470707636305;5112.872178195556;5187.559057480109;5200.609954253446;5230.633855630107;5228.712420816853;5278.683279003253;5288.2067689846635;5313.548348390392;5321.255024296602;5047.49525047496;5090.745462726849;5168.948310516885;5253.8949221015555;5292.417834038252;5220.738963051832;5221.921671174935;5222.216667499867;5238.947610523884;5277;5199.818006369759;5209.296744939423;5210.983858147662;5226.503482169188;5254.238135470336;5689.288838895138;5728.885422291531;5795.1886735857015;5835.883282334329;5882.205902203234;6308.873822523524;6324.430801227912;6334.936650633481;6342.429181373653;6378.202724659418;6372.5857819242065;6381.904271435932;6432.292447830735;6432.935670643327;6434.613923164578;5787.160861675034;5849.853753656107;5943.375945525744;5955.225820643289;5958.13607026983;6454.677266136674;6529.314421985718;6548.410643042149;6555.4427873631275;6557.114789503451;6044.093385992136;6077.6353418795015;6085.452309292096;6145.033589251397;6185.84535386619;6268.937310626835;6279.215098112736;6287.779927702509;6297.653629050446;6301.023341382093;6073.423024812636;6114.723190878623;6144.477719393813;6235.314115447297;6257.405546473078;6247.156633854372;6257.937420625826;6259.624422534663;6305.117283580303;6333;4759.785809638574;4785.353977213102;4786.425628924481;4788.3056956741075;4813.326134341195;4177.101967799655;4188.539260681323;4192.8532501362915;4200.075983283673;4236.533981262059;5870.647761134345;5872.970635146797;5889.411058894162;5908.704564771744;5979.4618484336615;6268.529860260499;6275;6277.121203031579;6288.52836037299;6302.936970630327;5893.595579803275;5906.3207731110615;5909.852253693692;5923.940760592339;5962.612430192024;5273.5781137509675;5302.1781623848365;5309.3894202166475;5320.920186197132;5337.653052551649;6601.73593056282;6661.866762664719;6663.500237482208;6679.499037572299;6689.130413046273;6312.842178945563;6328.46208072319;6329.8734025320155;6339.207599050119;6340.365963403623;6457.289698133108;6552.8361790955605;6610.10763546915;6630.801075967729;6631.237407697983;6126.670355029888;6198.2871969722255;6246.250449946036;6274.937250627435;6282.874342513215;6100.206973093469;6108.953500577356;6112.701056011389;6161.753529858935;6225.782097626561;6083.969580152071;6119.41115851624;6129.419919118862;6172.444479996821;6220.440160385587;6206.565540412308;6211.068339748893;6215.223097112861;6226.097215903759;6237.563370564017;6091.177691011834;6102.792231004566;6124.89972046314;6145.463634091477;6238.064290356483;6114.206128133634;6160.353162917829;6181.629102253879;6205.596636218631;6211.254649442096;6035.486983606443;6046.697665116639;6052.213212282375;6052.686702642322;6084.361142080018 04:14:57 INFO - PID 16348 | |1;ext.html;665.1486097794824;710.950233483656;723.3959643697514;1134.4101067444929;1143.8627364716235;37726;38013.239735205345;38109.42835857461;38194.61805381949;38215;39037.21925561487;39459.67294415253;39469.40795888057;39477;39629.40555891664;7090.29097090292;7133.607651579161;7229.313215244543;7254.310840470147;7265.164506081789;7226.710931562731;7282.854342913165;7287.781366558986;7288.963555182243;7292.4530660200435;7251.854962900738;7304.598247096407;7313.744018959337;7335.449841261927;7347.595882226476;7244.166920804122;7310.378617817492;7321.3410793028615;7325.963370183168;7333.926660733405;6888.483363747739;6929.272426395206;6930.584164950119;6938.757143499954;6943.270956549591;36746.08134796625;36865.07837304062;36985;36986.44520332197;37154.81422592897;3497.090756403328;3514.0512061743443;3514.9648503514895;3524.665156810099;3530.770499917523;28889.422211555862;29111.85444072787;29149.854250728822;29225.269368265963;29244.268893277625;3532.3994920863256;3560.946585801215;3564.465330200465;3570.357335679577;3572.732045096628;195960;197732;198591;205647;210328;45849.312260316125;46074.30888536674;46143.538564614595;46184.3072353915;46354.76822615933;48548.514514854396;48655.51344486581;48728;55617.887642246926;56228.718856406274;15395.384184632489;15530;15590.298436570381;15591.532254032398;15614.84385156134;12424.254544727346;12593.055520835791;12594.055445841415;12601.684957875943;12602.684932876751;14839.92580037093;14915.776263356058;14946.608542633345;14988.850111498745;15096.39614415411;5907.763689452459;5999.670018148957;6016.398360163948;6090.863205449197;6178.443940045418;1030.8093002794508;1076.7954088723118;1091.4160923905672;1116.1684545014016;1117.9273347232404;26066.34834129162;26317.34206644849;26474.735252647613;26616.866915665298;26796;1170.373849990251;1180.167981572989;1180.988190118105;1197.1978774221293;1197.9332907756173;13548.661283467794;13761.724765504634;13926.651833704238;14018.719625607635;14089.2250926198;267774;269513;269632;270576;271092;52136;52721.73639131856;52921.2061819073;52958.47041529613;52982.47017529853;1432.7707566789263;1471.433498103238;1513.1148278257342;1520.6198450387403;1528.2129703202859;23967.400814979068;25457.87271063633;30220.395592088476;30453.847730761205;31443.213919652193;52450.21324680209;52993.7350313246;53092.73453632707;53178.73410632922;53267.73366133145;221367;224524;224556;224570;224871;35336.46995295124;35711.28577428489;36162.638373615926;36236.27527449383;36902.63097368992;43257.56742432535;43493.3475997854;44720.32919506145;44764;44874.775626121664;32462.675373245966;32985.83507082545;33058.17354566155;33316.50075746549;33462;33129;33382.16544586405;33474.66525334813;34189.65810341964;34222.14444638904;37221.25557488781;37598;37790.244195115396;38177.61822381741;38256;31351.529727053658;31385.37229255448;31631.20921976969;31806;32208.19479513031;23712.28863134109;25992;26350.4729905397;26523.033422606215;26857.194284171506 04:14:57 INFO - PID 16348 | |2;jquery.html;435.03856477185417;437.44663001303377;451.1653441133902;462.0827657100655;465.94874563798;20024;20516.692249616248;20683.689744653842;21715.565688686216;21763.129474821028;22498.30224104183;23357.2992810216;23473.413164670892;23520.88239558804;23677.88161059192;5385.973070134643;5605.775768969236;5611.915821262684;5614.101743721006;5623.887522249553;5427.43011983742;5525.944740552603;5548.389677135512;5578.553715702755;5579.832605021856;5529.723513824313;5530.944690553103;5543.750531226085;5544.556435485151;5570.554355651559;5359.839204823842;5528.695921724324;5558;5569.164625306236;5604.943950560483;5117.104506711311;5125.589952803767;5126.820561280338;5128.71792051437;5130.486951304877;25326.240212793644;25640.358991025372;25767.098151564605;26049.218523444328;26234.606480902803;2168.1435832846096;2215.4018415028013;2216.4015715756655;2216.556688662274;2232.5758105959817;17103.31586736529;17133.314667413288;17162.399316024002;17264.654706905916;17456.91271543647;2251.358362866575;2299.563083014222;2305.3314538783734;2305.5504176685554;2307.411610039446;102101.4894925528;102417.48791255995;102538.48730756299;104372;105289;12374.566890158801;12649.367531623566;12862;12930;13107.541236056883;17649.55876103082;17815;17902.373416930346;17967.73048404275;18025;8650.1349865013;8854.734357969142;8992.640294388151;9037.186653201112;9040.321975851837;8075.515469071757;8076.192380761877;8169.223923727236;8350.415470916978;8407.663693452194;7913.802154946173;8176.877346839802;8196.508209507449;8204.671813127408;8236.50580965144;2190.8466407351652;2218.0240694094546;2219.467327841339;2229.4092065602626;2263.8641681498834;979.3976704326788;1019.9745006374751;1055.0820785916303;1080.206048554312;1082.8484012238293;20334.796652033587;21153.68269475959;21174.364769056952;21306.680399794015;21318.893405532872;1050.4117694091333;1053.2785042246087;1056.2606175676904;1058.4539403263004;1081.5079138991898;11100.389478578756;11512.963833255048;11561.190716649753;11646.475908584134;11711.88288117125;552338;555971;557885;562922;572702;100738;101086;102689.48655256825;104408;105981;1156.259993604094;1161.2451906260999;1178.634623266773;1179.628417048627;1186.9703257418635;17055.7441638378;17494.387696430564;17862.19620117072;18169.273229070688;18442.723359149357;47461;47851.28223076726;48058.51941480541;48748.75625621849;49121.26318105303;58788.412115878295;61002.69498652478;62545.37454625578;62603.6869815648;63096.68451657712;9818.754531136494;9829.361091529314;9932.553035113582;10065.69802905914;10128.797424051625;13831;14026.368813403216;14136.717265654836;14143.575692729235;14717.190554519604;12094.45574949147;12305.138640295094;12369.62891113268;12520.373981301082;12700.428480718574;11743.236689615147;11975.580854670045;12141.575044873387;12284.692882677648;12326.876731232573;12335.50657973707;12437.253764774143;12532.686682832637;12740.108192426442;12893.226406415644;9618.182454491167;9726.659566915125;9913.504324783587;10027.799444011225;10179.643712470028;12014.939925300318;12129.332886690963;12281.44733487013;12301.876981230072;12349.19730217569 04:14:57 INFO - PID 16348 | |3;mootools.html;1381.3024422666551;1434.9210793406364;1445.5735558010385;1445.8554144585544;1447.0811034992782;11590.304581725091;11900.285982841036;11989.940050299747;12058.999999999989;12267.754644907096;11863.347515886622;12091.879081209185;12121.515139394436;12123.878761212385;12154.574589889357;2311.191083120911;2352.047420794581;2355.1639168095335;2369.5853225685523;2375.3705268103968;2266.2068276103314;2293.5068960173558;2302.5510025545027;2321.779430954057;2324.2794733632545;2278.1684685089904;2289.3246492284734;2299.057386471547;2300.8619482831;2302.1712183613886;2163.53484000939;2170.153640080362;2193.396815875639;2197.7252843394576;2200.515886504966;1908.7900330963582;1967.8228959393723;2186.8469207155504;2196.769339219375;2196.7803219678062;11657.125715571367;11741.882581174164;11742.236754611009;11745.177837551375;11757.823632645517;6229.314775374705;6405.071264666643;6431.453326467209;6433.228012638513;6453;3624.746267761258;3724.1062145085257;3797.886063418102;3811.6188381161937;3812.1994381179984;1277.9744405111846;1280.2254635945305;1311.2198242045968;1332.420397127243;1342.6374878782772;16417.83582164175;16491.752623710654;16560.254788534545;16598.336066557204;16620.50138495835;5400.594955378362;5416.485433883775;5462.699551524624;5556;5564.693941833238;13177.27524986135;13349.66625834362;13357.465701371837;13360.39878205483;13399.263040532669;6273.686315684289;6366.840828979312;6369.0446433034485;6396.84007899797;6403.519736019817;5879.206307148565;5911.615744976562;5937.792177273861;5958.910616340759;6021.036634138517;4195.706300558993;4238.830446782094;4250.3199488081755;4253.936190957138;4276.807543660543;1171.9003884669728;1176.9176157669053;1181.9953039916174;1185.2947496239724;1205.6865215043977;865.0441262405078;876.6624849433014;889.9332550058772;894.7584152278848;921.6313474610209;6654.70053847578;6671.132752742113;6691.631960242136;6743.629100399525;6763.12079429671;629.7166275176097;635.7806556737918;636.1030946365602;641.4964253061324;647.5273050673035;4160.9375859362135;4190.727602705814;4754.334393184957;4848.515148485194;4888.120138375127;14276.21480818565;15348.846511534965;15371.000884942443;15384.077025365368;15392.153431561372;14684.26578671062;15307.770383444256;15318.463853765064;15450.9227453862;15466.458673946583;9218.170364667078;9291.21024712907;9300.813983720423;9337.71986840396;9380.530973451436;7145.4998150128995;7402.9629851850395;7566.583837888969;7660;7746.845063098819;14134.50529231472;14211.857881421054;14228.217448040457;14283.71432571322;14506.564803055926;14411.135331880121;14494.497680223752;14537;14649.216648836687;14863.1825249608;9930.155936745168;10245.077942985166;10248.846267305848;10248.846267305848;10283.07452329294;11206.646604213207;11404.600838970597;11450.484728187419;11495.597654082067;11524.366159861289;9525.380850244712;9616.95191524038;9898.703038908845;10124.84812727795;10165;9411.764705882408;9418.199453046567;9433.245340372616;9497.952510237405;9630.662926797528;8250.968628921384;8289.461185022954;8342.499450032774;8372.497650141011;8392.034915984495;6658.467322614082;6708.865822683421;6746.561473504206;6916.688749006407;6956.860862782817;6628.933710663025;6785.185777706707;6796.218434879855;6985.091938048021;7033.683484243324 04:14:57 INFO - PID 16348 | |4;prototype.html;422.14726252969;424.1516966067864;427.30349530265664;428.28467515948915;431.34004972392233;5982.312034116078;6086.178365920599;6098.603590766603;6157.907631385533;6158.19943407357;5885.382034886339;6040.728167232474;6050.183225264588;6054.788082417116;6098.908516372247;4717.150912835688;4840.394950631171;4843.273508973647;4849.7817598207985;4869.756512174395;4844.612431005511;4847.345608342882;4863.975680121594;4865.245886887538;4889.193283108283;4814.807407703687;4818.084563932859;4818.927716084244;4827.0104628551235;4840.709557426548;4713.175194340994;4787;4826.131296366652;4844.733539655317;4852.2479015752615;4375.846845360429;4380.60574548289;4386.881345256971;4419.801108950105;4438.090191510732;5812.186293918855;5818.272715910512;5829.88340233193;5898.970505147447;5929;5637.548996080303;5713.057345538023;5717.771289148429;5762.942370576283;5763.193152958589;6455.451286640594;6464.191976003;6475.417212450855;6482.611043337415;6489.1888513935755;4830;4891.266310053485;4902.950970490321;4920.335754673145;4965.652404331699;6556.93443065568;6718.395344419026;6776.356246156656;6787.898181527281;6800.149981252343;4871.926921096187;4885.706857588556;4910.705357678479;4916.8770780730765;4917.286993385939;4938.456769755324;4976.42771081323;4980.452150263468;5057.140286151363;5181.611379146504;5676.545876329884;5688.857778555569;5730.426957304237;5742.7415766290615;5765.942340576625;6397.296297407282;6446.226452825691;6492.675366231764;6497.252815926135;6514;1771.1852547828144;1799.1543974332044;1813.6010077782867;1813.9727904081449;1815.3283285184566;1247.644421339932;1265.2977597433512;1313.902891085935;1316.1510825517487;1332.4936524120965;6157;6163.722632481549;6176.413240742122;6185.072239164161;6186.412290832363;6573.8634943642555;6597.60414375139;6613.966930165415;6616.338366163345;6682.131322927989;6113.633182009094;6171.47542458896;6178.351273116258;6190.566660333733;6201.317855035943;3484.3728128936527;3489.3370259650587;3500.4749287607065;3503;3516.648335166463;6803.48973826965;6909.75815846453;6946.7221311148;6954.4436445084275;6958.965205174043;6766.9699090272725;6798.592084474947;6813.727450902007;6826.552590941543;6828.795136145924;6545.738170473128;6847.760328388483;6848.897266541006;6929.93070069313;6935.930640693629;6608.7356505739235;6614.412540990032;6638.20341559016;6640.900386494303;6643.269240383651;6268.498520118288;6474.320196379313;6497.978440025411;6529.575577587441;6564.704588293634;6947.965260173667;6961.965190174017;6970.651467426507;6981.581105133709;7000.709666456757;4521.163584736834;4659.743714095622;4680.859574212779;4690.92963605553;4707.952920470751;6630;6645.202575690948;6654.633995130314;6663.533552651268;6679.599224046573;6340.907500524723;6432.421082102634;6435.774747883802;6448.580842245239;6501.674916254263;6410.423061924449;6417.326180750954;6423.325550817097;6438.8390290243115;6454.451371633464;6290.6334575016035;6419.775307864203;6430.421262086435;6445.838854028687;6455.4512866406885;6421.871562568629;6457.935420645734;6463.030545418225;6474.838129046811;6477.935220647922;6315.4947604192475;6335.619862808247;6337.366263373626;6346.1432706585865;6356.872862542631 04:14:57 INFO - PID 16348 | |5;yui.html;851.701904333483;874.4447275979755;875.4484674654967;879.8240351929612;892.4957399069525;17012.14939253037;17434.38979635713;17486.300547978066;19395;20950.057247423865;18534;19246.615067698673;19369.418917432464;19395.12721927513;19415.12631931563;986.8618393424927;1018.231235417259;1023.0383439566821;1026.7741096958694;1031.8349064149738;975.4927437732375;1007.325092188232;1009.4599389326712;1009.7778488732467;1016.8779746430439;1057.2070946789909;1060.0883240413239;1060.787842431513;1061.517009760561;1063.6117816996818;1053.2627160987302;1059.5549869055014;1060.9946950265276;1062.6440142552176;1063.7340664833791;769.0195001373238;777.4713195027379;777.6928113395234;778.7702627724835;778.8325510015317;18450.723239151288;18759.81240187608;18775.812241877542;18919.43241702751;19027.42917712457;18919;18980.525486862938;19076.71384929227;19460.318888838963;19469.707954380694;14987.175705336202;15026.774598381033;15137.697246055128;15189.392424303014;15200.847991520053;3214.5338925855854;3326.96673033269;3327.617324007722;3328;3335.6497567755523;110979.44510277477;112046.43976780064;113148;113572.43213783961;116519.99999999916;14930.10419374841;14990.325435355435;15046;15170.393184272727;15195.468158614396;27628.58557121645;27751;27946.86026569895;28283.858580706965;28299.43401131966;7803.219678032265;8123.268905798388;8261.710840120688;8319.126491718403;8346.123657015925;3965.1276719121747;4054.553999060101;4080.959190408117;4083.0608959938786;4093.1404405074672;4326.82692692295;4382.715123517025;4424.137293227854;4424.845130420485;4577.198990176706;852.3266619370752;855.7347222360963;863.3697400897255;867.6442658509981;868.3270465389373;677.4648028057877;709.3190537084457;712.4336152758569;713.2190251674408;720.3516834848679;12321.507139714311;12892.613221603367;12898.548550800677;13078.411471483807;13192.538261160813;665.1519312876025;671.8992151177265;675.2100042949761;690.4510913823523;700.4116542104656;4858.198397264482;4994.150994330972;5007.39911210657;5052.722100284446;5180.093483640348;109376.45311773391;110261;110451.53678485019;111118.44440777905;116122;94092;99611.50194249128;100537.49731251443;102136;103830;88333;88427.55786221028;88842.55578722066;89006;90256;11202.719932001764;11778.58774942907;11879.643610691694;11900.642980710592;12018.519259229883;37165;37209;37288;37835.81082094682;38942;48118.51881481281;48735.512644873095;48857.755711221216;49595.50404496053;50212.24681629852;15636.140012298978;15842.52472425829;16316;16465;16602.418915337905;17877.553061173054;20203.79796202078;20729.378118656463;21201.575968480236;21291.467713306673;16903.408380706616;17206.827931720523;17956.55108622295;18319.35882244115;18437.631247375244;16740.665186696442;16758.916205418896;16918.154092295583;17013.744793827856;17179.742303865703;17210.225539850486;17478.388256410966;18698.43904682862;18946.621067578846;19103.235870565022;13252.403641835948;13500.32498375097;13586.524471643841;13800.309984500534;13889.930550347184;14462.493812716926;14499.710005800036;14547.927260363631;14560.49038283655;14710.338034788247 04:14:57 INFO - PID 16348 | __end_tp_report 04:14:57 INFO - PID 16348 | __start_cc_report 04:14:57 INFO - PID 16348 | _x_x_mozilla_cycle_collect,339 04:14:57 INFO - PID 16348 | __end_cc_report 04:14:57 INFO - PID 16348 | __startTimestamp1496142897890__endTimestamp 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | ------- Summary: start ------- 04:14:57 INFO - PID 16348 | Number of tests: 6 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#0] dojo.html Cycles:165 Average:5813.90 Median:6083.97 stddev:715.03 (11.8%) stddev-sans-first:686.41 04:14:57 INFO - PID 16348 | Values: 3167.3 3247.2 3259.0 3271.6 3358.2 5766.2 5820.4 5833.7 5872.4 5877.7 5749.4 5775.2 5815.0 5858.0 5939.5 5032.5 5112.9 5187.6 5200.6 5230.6 5228.7 5278.7 5288.2 5313.5 5321.3 5047.5 5090.7 5168.9 5253.9 5292.4 5220.7 5221.9 5222.2 5238.9 5277.0 5199.8 5209.3 5211.0 5226.5 5254.2 5689.3 5728.9 5795.2 5835.9 5882.2 6308.9 6324.4 6334.9 6342.4 6378.2 6372.6 6381.9 6432.3 6432.9 6434.6 5787.2 5849.9 5943.4 5955.2 5958.1 6454.7 6529.3 6548.4 6555.4 6557.1 6044.1 6077.6 6085.5 6145.0 6185.8 6268.9 6279.2 6287.8 6297.7 6301.0 6073.4 6114.7 6144.5 6235.3 6257.4 6247.2 6257.9 6259.6 6305.1 6333.0 4759.8 4785.4 4786.4 4788.3 4813.3 4177.1 4188.5 4192.9 4200.1 4236.5 5870.6 5873.0 5889.4 5908.7 5979.5 6268.5 6275.0 6277.1 6288.5 6302.9 5893.6 5906.3 5909.9 5923.9 5962.6 5273.6 5302.2 5309.4 5320.9 5337.7 6601.7 6661.9 6663.5 6679.5 6689.1 6312.8 6328.5 6329.9 6339.2 6340.4 6457.3 6552.8 6610.1 6630.8 6631.2 6126.7 6198.3 6246.3 6274.9 6282.9 6100.2 6109.0 6112.7 6161.8 6225.8 6084.0 6119.4 6129.4 6172.4 6220.4 6206.6 6211.1 6215.2 6226.1 6237.6 6091.2 6102.8 6124.9 6145.5 6238.1 6114.2 6160.4 6181.6 6205.6 6211.3 6035.5 6046.7 6052.2 6052.7 6084.4 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#1] ext.html Cycles:180 Average:40282.48 Median:3527.72 stddev:60730.76 (1721.5%) stddev-sans-first:60828.28 04:14:57 INFO - PID 16348 | Values: 665.1 711.0 723.4 1134.4 1143.9 37726.0 38013.2 38109.4 38194.6 38215.0 39037.2 39459.7 39469.4 39477.0 39629.4 7090.3 7133.6 7229.3 7254.3 7265.2 7226.7 7282.9 7287.8 7289.0 7292.5 7251.9 7304.6 7313.7 7335.4 7347.6 7244.2 7310.4 7321.3 7326.0 7333.9 6888.5 6929.3 6930.6 6938.8 6943.3 36746.1 36865.1 36985.0 36986.4 37154.8 3497.1 3514.1 3515.0 3524.7 3530.8 28889.4 29111.9 29149.9 29225.3 29244.3 3532.4 3560.9 3564.5 3570.4 3572.7 195960.0 197732.0 198591.0 205647.0 210328.0 45849.3 46074.3 46143.5 46184.3 46354.8 48548.5 48655.5 48728.0 55617.9 56228.7 15395.4 15530.0 15590.3 15591.5 15614.8 12424.3 12593.1 12594.1 12601.7 12602.7 14839.9 14915.8 14946.6 14988.9 15096.4 5907.8 5999.7 6016.4 6090.9 6178.4 1030.8 1076.8 1091.4 1116.2 1117.9 26066.3 26317.3 26474.7 26616.9 26796.0 1170.4 1180.2 1181.0 1197.2 1197.9 13548.7 13761.7 13926.7 14018.7 14089.2 267774.0 269513.0 269632.0 270576.0 271092.0 52136.0 52721.7 52921.2 52958.5 52982.5 1432.8 1471.4 1513.1 1520.6 1528.2 23967.4 25457.9 30220.4 30453.8 31443.2 52450.2 52993.7 53092.7 53178.7 53267.7 221367.0 224524.0 224556.0 224570.0 224871.0 35336.5 35711.3 36162.6 36236.3 36902.6 43257.6 43493.3 44720.3 44764.0 44874.8 32462.7 32985.8 33058.2 33316.5 33462.0 33129.0 33382.2 33474.7 34189.7 34222.1 37221.3 37598.0 37790.2 38177.6 38256.0 31351.5 31385.4 31631.2 31806.0 32208.2 23712.3 25992.0 26350.5 26523.0 26857.2 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#2] jquery.html Cycles:180 Average:33088.40 Median:2215.90 stddev:92568.51 (4177.5%) stddev-sans-first:92795.72 04:14:57 INFO - PID 16348 | Values: 435.0 437.4 451.2 462.1 465.9 20024.0 20516.7 20683.7 21715.6 21763.1 22498.3 23357.3 23473.4 23520.9 23677.9 5386.0 5605.8 5611.9 5614.1 5623.9 5427.4 5525.9 5548.4 5578.6 5579.8 5529.7 5530.9 5543.8 5544.6 5570.6 5359.8 5528.7 5558.0 5569.2 5604.9 5117.1 5125.6 5126.8 5128.7 5130.5 25326.2 25640.4 25767.1 26049.2 26234.6 2168.1 2215.4 2216.4 2216.6 2232.6 17103.3 17133.3 17162.4 17264.7 17456.9 2251.4 2299.6 2305.3 2305.6 2307.4 102101.5 102417.5 102538.5 104372.0 105289.0 12374.6 12649.4 12862.0 12930.0 13107.5 17649.6 17815.0 17902.4 17967.7 18025.0 8650.1 8854.7 8992.6 9037.2 9040.3 8075.5 8076.2 8169.2 8350.4 8407.7 7913.8 8176.9 8196.5 8204.7 8236.5 2190.8 2218.0 2219.5 2229.4 2263.9 979.4 1020.0 1055.1 1080.2 1082.8 20334.8 21153.7 21174.4 21306.7 21318.9 1050.4 1053.3 1056.3 1058.5 1081.5 11100.4 11513.0 11561.2 11646.5 11711.9 552338.0 555971.0 557885.0 562922.0 572702.0 100738.0 101086.0 102689.5 104408.0 105981.0 1156.3 1161.2 1178.6 1179.6 1187.0 17055.7 17494.4 17862.2 18169.3 18442.7 47461.0 47851.3 48058.5 48748.8 49121.3 58788.4 61002.7 62545.4 62603.7 63096.7 9818.8 9829.4 9932.6 10065.7 10128.8 13831.0 14026.4 14136.7 14143.6 14717.2 12094.5 12305.1 12369.6 12520.4 12700.4 11743.2 11975.6 12141.6 12284.7 12326.9 12335.5 12437.3 12532.7 12740.1 12893.2 9618.2 9726.7 9913.5 10027.8 10179.6 12014.9 12129.3 12281.4 12301.9 12349.2 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#3] mootools.html Cycles:180 Average:7354.12 Median:2323.03 stddev:4765.03 (205.1%) stddev-sans-first:4757.26 04:14:57 INFO - PID 16348 | Values: 1381.3 1434.9 1445.6 1445.9 1447.1 11590.3 11900.3 11989.9 12059.0 12267.8 11863.3 12091.9 12121.5 12123.9 12154.6 2311.2 2352.0 2355.2 2369.6 2375.4 2266.2 2293.5 2302.6 2321.8 2324.3 2278.2 2289.3 2299.1 2300.9 2302.2 2163.5 2170.2 2193.4 2197.7 2200.5 1908.8 1967.8 2186.8 2196.8 2196.8 11657.1 11741.9 11742.2 11745.2 11757.8 6229.3 6405.1 6431.5 6433.2 6453.0 3624.7 3724.1 3797.9 3811.6 3812.2 1278.0 1280.2 1311.2 1332.4 1342.6 16417.8 16491.8 16560.3 16598.3 16620.5 5400.6 5416.5 5462.7 5556.0 5564.7 13177.3 13349.7 13357.5 13360.4 13399.3 6273.7 6366.8 6369.0 6396.8 6403.5 5879.2 5911.6 5937.8 5958.9 6021.0 4195.7 4238.8 4250.3 4253.9 4276.8 1171.9 1176.9 1182.0 1185.3 1205.7 865.0 876.7 889.9 894.8 921.6 6654.7 6671.1 6691.6 6743.6 6763.1 629.7 635.8 636.1 641.5 647.5 4160.9 4190.7 4754.3 4848.5 4888.1 14276.2 15348.8 15371.0 15384.1 15392.2 14684.3 15307.8 15318.5 15450.9 15466.5 9218.2 9291.2 9300.8 9337.7 9380.5 7145.5 7403.0 7566.6 7660.0 7746.8 14134.5 14211.9 14228.2 14283.7 14506.6 14411.1 14494.5 14537.0 14649.2 14863.2 9930.2 10245.1 10248.8 10248.8 10283.1 11206.6 11404.6 11450.5 11495.6 11524.4 9525.4 9617.0 9898.7 10124.8 10165.0 9411.8 9418.2 9433.2 9498.0 9630.7 8251.0 8289.5 8342.5 8372.5 8392.0 6658.5 6708.9 6746.6 6916.7 6956.9 6628.9 6785.2 6796.2 6985.1 7033.7 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#4] prototype.html Cycles:180 Average:5489.03 Median:6158.05 stddev:1564.34 (25.4%) stddev-sans-first:1521.80 04:14:57 INFO - PID 16348 | Values: 422.1 424.2 427.3 428.3 431.3 5982.3 6086.2 6098.6 6157.9 6158.2 5885.4 6040.7 6050.2 6054.8 6098.9 4717.2 4840.4 4843.3 4849.8 4869.8 4844.6 4847.3 4864.0 4865.2 4889.2 4814.8 4818.1 4818.9 4827.0 4840.7 4713.2 4787.0 4826.1 4844.7 4852.2 4375.8 4380.6 4386.9 4419.8 4438.1 5812.2 5818.3 5829.9 5899.0 5929.0 5637.5 5713.1 5717.8 5762.9 5763.2 6455.5 6464.2 6475.4 6482.6 6489.2 4830.0 4891.3 4903.0 4920.3 4965.7 6556.9 6718.4 6776.4 6787.9 6800.1 4871.9 4885.7 4910.7 4916.9 4917.3 4938.5 4976.4 4980.5 5057.1 5181.6 5676.5 5688.9 5730.4 5742.7 5765.9 6397.3 6446.2 6492.7 6497.3 6514.0 1771.2 1799.2 1813.6 1814.0 1815.3 1247.6 1265.3 1313.9 1316.2 1332.5 6157.0 6163.7 6176.4 6185.1 6186.4 6573.9 6597.6 6614.0 6616.3 6682.1 6113.6 6171.5 6178.4 6190.6 6201.3 3484.4 3489.3 3500.5 3503.0 3516.6 6803.5 6909.8 6946.7 6954.4 6959.0 6767.0 6798.6 6813.7 6826.6 6828.8 6545.7 6847.8 6848.9 6929.9 6935.9 6608.7 6614.4 6638.2 6640.9 6643.3 6268.5 6474.3 6498.0 6529.6 6564.7 6948.0 6962.0 6970.7 6981.6 7000.7 4521.2 4659.7 4680.9 4690.9 4708.0 6630.0 6645.2 6654.6 6663.5 6679.6 6340.9 6432.4 6435.8 6448.6 6501.7 6410.4 6417.3 6423.3 6438.8 6454.5 6290.6 6419.8 6430.4 6445.8 6455.5 6421.9 6457.9 6463.0 6474.8 6477.9 6315.5 6335.6 6337.4 6346.1 6356.9 04:14:57 INFO - PID 16348 | 04:14:57 INFO - PID 16348 | [#5] yui.html Cycles:180 Average:22486.67 Median:19003.98 stddev:30796.91 (162.1%) stddev-sans-first:30840.46 04:14:57 INFO - PID 16348 | Values: 851.7 874.4 875.4 879.8 892.5 17012.1 17434.4 17486.3 19395.0 20950.1 18534.0 19246.6 19369.4 19395.1 19415.1 986.9 1018.2 1023.0 1026.8 1031.8 975.5 1007.3 1009.5 1009.8 1016.9 1057.2 1060.1 1060.8 1061.5 1063.6 1053.3 1059.6 1061.0 1062.6 1063.7 769.0 777.5 777.7 778.8 778.8 18450.7 18759.8 18775.8 18919.4 19027.4 18919.0 18980.5 19076.7 19460.3 19469.7 14987.2 15026.8 15137.7 15189.4 15200.8 3214.5 3327.0 3327.6 3328.0 3335.6 110979.4 112046.4 113148.0 113572.4 116520.0 14930.1 14990.3 15046.0 15170.4 15195.5 27628.6 27751.0 27946.9 28283.9 28299.4 7803.2 8123.3 8261.7 8319.1 8346.1 3965.1 4054.6 4081.0 4083.1 4093.1 4326.8 4382.7 4424.1 4424.8 4577.2 852.3 855.7 863.4 867.6 868.3 677.5 709.3 712.4 713.2 720.4 12321.5 12892.6 12898.5 13078.4 13192.5 665.2 671.9 675.2 690.5 700.4 4858.2 4994.2 5007.4 5052.7 5180.1 109376.5 110261.0 110451.5 111118.4 116122.0 94092.0 99611.5 100537.5 102136.0 103830.0 88333.0 88427.6 88842.6 89006.0 90256.0 11202.7 11778.6 11879.6 11900.6 12018.5 37165.0 37209.0 37288.0 37835.8 38942.0 48118.5 48735.5 48857.8 49595.5 50212.2 15636.1 15842.5 16316.0 16465.0 16602.4 17877.6 20203.8 20729.4 21201.6 21291.5 16903.4 17206.8 17956.6 18319.4 18437.6 16740.7 16758.9 16918.2 17013.7 17179.7 17210.2 17478.4 18698.4 18946.6 19103.2 13252.4 13500.3 13586.5 13800.3 13889.9 14462.5 14499.7 14547.9 14560.5 14710.3 04:14:57 INFO - PID 16348 | -------- Summary: end -------- 04:14:57 INFO - PID 16348 | 04:14:58 INFO - TEST-INFO | 16348: exit 0 04:14:58 INFO - TEST-OK | dromaeo_css | took 1140745ms 04:14:58 INFO - TEST-START | kraken 04:14:58 INFO - operating with platform_type : linux_ 04:14:58 INFO - Initialising browser for kraken test... 04:14:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46217/getInfo.html -profile /tmp/tmpKwCDaW/profile 04:14:58 INFO - TEST-INFO | started process 16750 (/builds/slave/test/build/application/firefox/firefox http://localhost:46217/getInfo.html) 04:15:33 INFO - TEST-INFO | 16750: killed by SIGTERM 04:15:33 INFO - Browser initialized. 04:15:33 INFO - Running cycle 1/1 for kraken test... 04:15:33 INFO - TEST-INFO | started process 16950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKwCDaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:45 INFO - PID 16950 | RSS: Main: 180465664 04:15:45 INFO - PID 16950 | 04:15:47 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46217/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:48 INFO - PID 16950 | RSS: Main: 184733696 04:15:48 INFO - PID 16950 | 04:15:50 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46217/tests/kraken/driver.html?testName=audio-dft) 04:15:51 INFO - PID 16950 | RSS: Main: 182751232 04:15:51 INFO - PID 16950 | 04:15:54 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46217/tests/kraken/driver.html?testName=audio-fft) 04:15:55 INFO - PID 16950 | RSS: Main: 179159040 04:15:55 INFO - PID 16950 | 04:15:57 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46217/tests/kraken/driver.html?testName=audio-oscillator) 04:15:57 INFO - PID 16950 | RSS: Main: 180252672 04:15:57 INFO - PID 16950 | 04:15:59 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:00 INFO - PID 16950 | RSS: Main: 179761152 04:16:00 INFO - PID 16950 | 04:16:03 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46217/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:04 INFO - PID 16950 | RSS: Main: 180936704 04:16:04 INFO - PID 16950 | 04:16:07 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46217/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:08 INFO - PID 16950 | RSS: Main: 182239232 04:16:08 INFO - PID 16950 | 04:16:10 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46217/tests/kraken/driver.html?testName=json-parse-financial) 04:16:11 INFO - PID 16950 | RSS: Main: 182026240 04:16:11 INFO - PID 16950 | 04:16:13 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:13 INFO - PID 16950 | RSS: Main: 181219328 04:16:13 INFO - PID 16950 | 04:16:15 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:16 INFO - PID 16950 | RSS: Main: 180895744 04:16:16 INFO - PID 16950 | 04:16:18 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:18 INFO - PID 16950 | RSS: Main: 181047296 04:16:18 INFO - PID 16950 | 04:16:21 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:22 INFO - PID 16950 | RSS: Main: 180666368 04:16:22 INFO - PID 16950 | 04:16:25 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:25 INFO - PID 16950 | RSS: Main: 180645888 04:16:25 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:46217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46217/tests/kraken/driver.html?testName=ai-astar) 04:16:27 INFO - PID 16950 | RSS: Main: 182239232 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | __start_tp_report 04:16:27 INFO - PID 16950 | _x_x_mozilla_page_load 04:16:27 INFO - PID 16950 | _x_x_mozilla_page_load_details 04:16:27 INFO - PID 16950 | |i|pagename|runs| 04:16:27 INFO - PID 16950 | |0;ai-astar;102;111;111;109;110;109;110;109;109;109 04:16:27 INFO - PID 16950 | |1;audio-beat-detection;156;119;123;176;119;119;118;119;138;123 04:16:27 INFO - PID 16950 | |2;audio-dft;162;164;164;163;163;164;166;169;169;162 04:16:27 INFO - PID 16950 | |3;audio-fft;74;73;73;91;72;73;72;87;90;73 04:16:27 INFO - PID 16950 | |4;audio-oscillator;82;82;100;82;81;81;97;82;81;105 04:16:27 INFO - PID 16950 | |5;imaging-gaussian-blur;113;114;113;114;113;113;113;114;114;113 04:16:27 INFO - PID 16950 | |6;imaging-darkroom;147;148;147;148;149;148;147;148;149;149 04:16:27 INFO - PID 16950 | |7;imaging-desaturate;94;102;94;95;95;95;94;95;95;94 04:16:27 INFO - PID 16950 | |8;json-parse-financial;48;46;50;48;47;47;48;49;48;51 04:16:27 INFO - PID 16950 | |9;json-stringify-tinderbox;55;55;56;56;55;56;55;56;56;55 04:16:27 INFO - PID 16950 | |10;stanford-crypto-aes;83;83;83;83;83;84;85;93;129;91 04:16:27 INFO - PID 16950 | |11;stanford-crypto-ccm;125;128;132;128;123;132;128;133;147;127 04:16:27 INFO - PID 16950 | |12;stanford-crypto-pbkdf2;182;183;178;188;182;180;181;191;180;175 04:16:27 INFO - PID 16950 | |13;stanford-crypto-sha256-iterative;67;63;63;65;64;64;64;65;62;65 04:16:27 INFO - PID 16950 | __end_tp_report 04:16:27 INFO - PID 16950 | __start_cc_report 04:16:27 INFO - PID 16950 | _x_x_mozilla_cycle_collect,901 04:16:27 INFO - PID 16950 | __end_cc_report 04:16:27 INFO - PID 16950 | __startTimestamp1496142987654__endTimestamp 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | ------- Summary: start ------- 04:16:27 INFO - PID 16950 | Number of tests: 14 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:2.56 (2.3%) stddev-sans-first:0.87 04:16:27 INFO - PID 16950 | Values: 102.0 111.0 111.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:123.00 stddev:19.92 (16.2%) stddev-sans-first:18.97 04:16:27 INFO - PID 16950 | Values: 156.0 119.0 123.0 176.0 119.0 119.0 118.0 119.0 138.0 123.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.57 04:16:27 INFO - PID 16950 | Values: 162.0 164.0 164.0 163.0 163.0 164.0 166.0 169.0 169.0 162.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#3] audio-fft Cycles:10 Average:77.80 Median:73.50 stddev:8.04 (10.9%) stddev-sans-first:8.41 04:16:27 INFO - PID 16950 | Values: 74.0 73.0 73.0 91.0 72.0 73.0 72.0 87.0 90.0 73.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.00 stddev:9.43 (11.5%) stddev-sans-first:9.80 04:16:27 INFO - PID 16950 | Values: 82.0 82.0 100.0 82.0 81.0 81.0 97.0 82.0 81.0 105.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:16:27 INFO - PID 16950 | Values: 113.0 114.0 113.0 114.0 113.0 113.0 113.0 114.0 114.0 113.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 04:16:27 INFO - PID 16950 | Values: 147.0 148.0 147.0 148.0 149.0 148.0 147.0 148.0 149.0 149.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:2.41 (2.5%) stddev-sans-first:2.51 04:16:27 INFO - PID 16950 | Values: 94.0 102.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.00 stddev:1.48 (3.1%) stddev-sans-first:1.56 04:16:27 INFO - PID 16950 | Values: 48.0 46.0 50.0 48.0 47.0 47.0 48.0 49.0 48.0 51.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:16:27 INFO - PID 16950 | Values: 55.0 55.0 56.0 56.0 55.0 56.0 55.0 56.0 56.0 55.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:83.50 stddev:14.28 (17.1%) stddev-sans-first:14.94 04:16:27 INFO - PID 16950 | Values: 83.0 83.0 83.0 83.0 83.0 84.0 85.0 93.0 129.0 91.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:130.00 stddev:6.67 (5.1%) stddev-sans-first:6.79 04:16:27 INFO - PID 16950 | Values: 125.0 128.0 132.0 128.0 123.0 132.0 128.0 133.0 147.0 127.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:182.00 stddev:4.62 (2.5%) stddev-sans-first:4.90 04:16:27 INFO - PID 16950 | Values: 182.0 183.0 178.0 188.0 182.0 180.0 181.0 191.0 180.0 175.0 04:16:27 INFO - PID 16950 | 04:16:27 INFO - PID 16950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.40 (2.2%) stddev-sans-first:1.05 04:16:27 INFO - PID 16950 | Values: 67.0 63.0 63.0 65.0 64.0 64.0 64.0 65.0 62.0 65.0 04:16:27 INFO - PID 16950 | -------- Summary: end -------- 04:16:27 INFO - PID 16950 | 04:16:28 INFO - TEST-INFO | 16950: exit 0 04:16:28 INFO - TEST-OK | kraken | took 90079ms 04:16:28 INFO - SUITE-END | took 1230s 04:16:28 INFO - Completed test suite (00:20:30) 04:16:28 INFO - javascript benchmark 04:16:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7904.451770703757, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.255694911696, 3247.2368993286573, 3258.9837050814745, 3271.6401195868452, 3358.244395011123, 5766.221560089387, 5820.447057529534, 5833.708314584264, 5872.412758724136, 5877.735501902414, 5749.425057494249, 5775.2203452533895, 5814.970925145369, 5858.0, 5939.4654481096695, 5032.5470707636305, 5112.872178195556, 5187.559057480109, 5200.609954253446, 5230.633855630107, 5228.712420816853, 5278.683279003253, 5288.2067689846635, 5313.548348390392, 5321.255024296602, 5047.49525047496, 5090.745462726849, 5168.948310516885, 5253.8949221015555, 5292.417834038252, 5220.738963051832, 5221.921671174935, 5222.216667499867, 5238.947610523884, 5277.0, 5199.818006369759, 5209.296744939423, 5210.983858147662, 5226.503482169188, 5254.238135470336, 5689.288838895138, 5728.885422291531, 5795.1886735857015, 5835.883282334329, 5882.205902203234, 6308.873822523524, 6324.430801227912, 6334.936650633481, 6342.429181373653, 6378.202724659418, 6372.5857819242065, 6381.904271435932, 6432.292447830735, 6432.935670643327, 6434.613923164578, 5787.160861675034, 5849.853753656107, 5943.375945525744, 5955.225820643289, 5958.13607026983, 6454.677266136674, 6529.314421985718, 6548.410643042149, 6555.4427873631275, 6557.114789503451, 6044.093385992136, 6077.6353418795015, 6085.452309292096, 6145.033589251397, 6185.84535386619, 6268.937310626835, 6279.215098112736, 6287.779927702509, 6297.653629050446, 6301.023341382093, 6073.423024812636, 6114.723190878623, 6144.477719393813, 6235.314115447297, 6257.405546473078, 6247.156633854372, 6257.937420625826, 6259.624422534663, 6305.117283580303, 6333.0, 4759.785809638574, 4785.353977213102, 4786.425628924481, 4788.3056956741075, 4813.326134341195, 4177.101967799655, 4188.539260681323, 4192.8532501362915, 4200.075983283673, 4236.533981262059, 5870.647761134345, 5872.970635146797, 5889.411058894162, 5908.704564771744, 5979.4618484336615, 6268.529860260499, 6275.0, 6277.121203031579, 6288.52836037299, 6302.936970630327, 5893.595579803275, 5906.3207731110615, 5909.852253693692, 5923.940760592339, 5962.612430192024, 5273.5781137509675, 5302.1781623848365, 5309.3894202166475, 5320.920186197132, 5337.653052551649, 6601.73593056282, 6661.866762664719, 6663.500237482208, 6679.499037572299, 6689.130413046273, 6312.842178945563, 6328.46208072319, 6329.8734025320155, 6339.207599050119, 6340.365963403623, 6457.289698133108, 6552.8361790955605, 6610.10763546915, 6630.801075967729, 6631.237407697983, 6126.670355029888, 6198.2871969722255, 6246.250449946036, 6274.937250627435, 6282.874342513215, 6100.206973093469, 6108.953500577356, 6112.701056011389, 6161.753529858935, 6225.782097626561, 6083.969580152071, 6119.41115851624, 6129.419919118862, 6172.444479996821, 6220.440160385587, 6206.565540412308, 6211.068339748893, 6215.223097112861, 6226.097215903759, 6237.563370564017, 6091.177691011834, 6102.792231004566, 6124.89972046314, 6145.463634091477, 6238.064290356483, 6114.206128133634, 6160.353162917829, 6181.629102253879, 6205.596636218631, 6211.254649442096, 6035.486983606443, 6046.697665116639, 6052.213212282375, 6052.686702642322, 6084.361142080018], "value": 5761.437580385721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.1486097794824, 710.950233483656, 723.3959643697514, 1134.4101067444929, 1143.8627364716235, 37726.0, 38013.239735205345, 38109.42835857461, 38194.61805381949, 38215.0, 39037.21925561487, 39459.67294415253, 39469.40795888057, 39477.0, 39629.40555891664, 7090.29097090292, 7133.607651579161, 7229.313215244543, 7254.310840470147, 7265.164506081789, 7226.710931562731, 7282.854342913165, 7287.781366558986, 7288.963555182243, 7292.4530660200435, 7251.854962900738, 7304.598247096407, 7313.744018959337, 7335.449841261927, 7347.595882226476, 7244.166920804122, 7310.378617817492, 7321.3410793028615, 7325.963370183168, 7333.926660733405, 6888.483363747739, 6929.272426395206, 6930.584164950119, 6938.757143499954, 6943.270956549591, 36746.08134796625, 36865.07837304062, 36985.0, 36986.44520332197, 37154.81422592897, 3497.090756403328, 3514.0512061743443, 3514.9648503514895, 3524.665156810099, 3530.770499917523, 28889.422211555862, 29111.85444072787, 29149.854250728822, 29225.269368265963, 29244.268893277625, 3532.3994920863256, 3560.946585801215, 3564.465330200465, 3570.357335679577, 3572.732045096628, 195960.0, 197732.0, 198591.0, 205647.0, 210328.0, 45849.312260316125, 46074.30888536674, 46143.538564614595, 46184.3072353915, 46354.76822615933, 48548.514514854396, 48655.51344486581, 48728.0, 55617.887642246926, 56228.718856406274, 15395.384184632489, 15530.0, 15590.298436570381, 15591.532254032398, 15614.84385156134, 12424.254544727346, 12593.055520835791, 12594.055445841415, 12601.684957875943, 12602.684932876751, 14839.92580037093, 14915.776263356058, 14946.608542633345, 14988.850111498745, 15096.39614415411, 5907.763689452459, 5999.670018148957, 6016.398360163948, 6090.863205449197, 6178.443940045418, 1030.8093002794508, 1076.7954088723118, 1091.4160923905672, 1116.1684545014016, 1117.9273347232404, 26066.34834129162, 26317.34206644849, 26474.735252647613, 26616.866915665298, 26796.0, 1170.373849990251, 1180.167981572989, 1180.988190118105, 1197.1978774221293, 1197.9332907756173, 13548.661283467794, 13761.724765504634, 13926.651833704238, 14018.719625607635, 14089.2250926198, 267774.0, 269513.0, 269632.0, 270576.0, 271092.0, 52136.0, 52721.73639131856, 52921.2061819073, 52958.47041529613, 52982.47017529853, 1432.7707566789263, 1471.433498103238, 1513.1148278257342, 1520.6198450387403, 1528.2129703202859, 23967.400814979068, 25457.87271063633, 30220.395592088476, 30453.847730761205, 31443.213919652193, 52450.21324680209, 52993.7350313246, 53092.73453632707, 53178.73410632922, 53267.73366133145, 221367.0, 224524.0, 224556.0, 224570.0, 224871.0, 35336.46995295124, 35711.28577428489, 36162.638373615926, 36236.27527449383, 36902.63097368992, 43257.56742432535, 43493.3475997854, 44720.32919506145, 44764.0, 44874.775626121664, 32462.675373245966, 32985.83507082545, 33058.17354566155, 33316.50075746549, 33462.0, 33129.0, 33382.16544586405, 33474.66525334813, 34189.65810341964, 34222.14444638904, 37221.25557488781, 37598.0, 37790.244195115396, 38177.61822381741, 38256.0, 31351.529727053658, 31385.37229255448, 31631.20921976969, 31806.0, 32208.19479513031, 23712.28863134109, 25992.0, 26350.4729905397, 26523.033422606215, 26857.194284171506], "value": 17481.13087673336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.03856477185417, 437.44663001303377, 451.1653441133902, 462.0827657100655, 465.94874563798, 20024.0, 20516.692249616248, 20683.689744653842, 21715.565688686216, 21763.129474821028, 22498.30224104183, 23357.2992810216, 23473.413164670892, 23520.88239558804, 23677.88161059192, 5385.973070134643, 5605.775768969236, 5611.915821262684, 5614.101743721006, 5623.887522249553, 5427.43011983742, 5525.944740552603, 5548.389677135512, 5578.553715702755, 5579.832605021856, 5529.723513824313, 5530.944690553103, 5543.750531226085, 5544.556435485151, 5570.554355651559, 5359.839204823842, 5528.695921724324, 5558.0, 5569.164625306236, 5604.943950560483, 5117.104506711311, 5125.589952803767, 5126.820561280338, 5128.71792051437, 5130.486951304877, 25326.240212793644, 25640.358991025372, 25767.098151564605, 26049.218523444328, 26234.606480902803, 2168.1435832846096, 2215.4018415028013, 2216.4015715756655, 2216.556688662274, 2232.5758105959817, 17103.31586736529, 17133.314667413288, 17162.399316024002, 17264.654706905916, 17456.91271543647, 2251.358362866575, 2299.563083014222, 2305.3314538783734, 2305.5504176685554, 2307.411610039446, 102101.4894925528, 102417.48791255995, 102538.48730756299, 104372.0, 105289.0, 12374.566890158801, 12649.367531623566, 12862.0, 12930.0, 13107.541236056883, 17649.55876103082, 17815.0, 17902.373416930346, 17967.73048404275, 18025.0, 8650.1349865013, 8854.734357969142, 8992.640294388151, 9037.186653201112, 9040.321975851837, 8075.515469071757, 8076.192380761877, 8169.223923727236, 8350.415470916978, 8407.663693452194, 7913.802154946173, 8176.877346839802, 8196.508209507449, 8204.671813127408, 8236.50580965144, 2190.8466407351652, 2218.0240694094546, 2219.467327841339, 2229.4092065602626, 2263.8641681498834, 979.3976704326788, 1019.9745006374751, 1055.0820785916303, 1080.206048554312, 1082.8484012238293, 20334.796652033587, 21153.68269475959, 21174.364769056952, 21306.680399794015, 21318.893405532872, 1050.4117694091333, 1053.2785042246087, 1056.2606175676904, 1058.4539403263004, 1081.5079138991898, 11100.389478578756, 11512.963833255048, 11561.190716649753, 11646.475908584134, 11711.88288117125, 552338.0, 555971.0, 557885.0, 562922.0, 572702.0, 100738.0, 101086.0, 102689.48655256825, 104408.0, 105981.0, 1156.259993604094, 1161.2451906260999, 1178.634623266773, 1179.628417048627, 1186.9703257418635, 17055.7441638378, 17494.387696430564, 17862.19620117072, 18169.273229070688, 18442.723359149357, 47461.0, 47851.28223076726, 48058.51941480541, 48748.75625621849, 49121.26318105303, 58788.412115878295, 61002.69498652478, 62545.37454625578, 62603.6869815648, 63096.68451657712, 9818.754531136494, 9829.361091529314, 9932.553035113582, 10065.69802905914, 10128.797424051625, 13831.0, 14026.368813403216, 14136.717265654836, 14143.575692729235, 14717.190554519604, 12094.45574949147, 12305.138640295094, 12369.62891113268, 12520.373981301082, 12700.428480718574, 11743.236689615147, 11975.580854670045, 12141.575044873387, 12284.692882677648, 12326.876731232573, 12335.50657973707, 12437.253764774143, 12532.686682832637, 12740.108192426442, 12893.226406415644, 9618.182454491167, 9726.659566915125, 9913.504324783587, 10027.799444011225, 10179.643712470028, 12014.939925300318, 12129.332886690963, 12281.44733487013, 12301.876981230072, 12349.19730217569], "value": 10237.64767179494, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.3024422666551, 1434.9210793406364, 1445.5735558010385, 1445.8554144585544, 1447.0811034992782, 11590.304581725091, 11900.285982841036, 11989.940050299747, 12058.999999999989, 12267.754644907096, 11863.347515886622, 12091.879081209185, 12121.515139394436, 12123.878761212385, 12154.574589889357, 2311.191083120911, 2352.047420794581, 2355.1639168095335, 2369.5853225685523, 2375.3705268103968, 2266.2068276103314, 2293.5068960173558, 2302.5510025545027, 2321.779430954057, 2324.2794733632545, 2278.1684685089904, 2289.3246492284734, 2299.057386471547, 2300.8619482831, 2302.1712183613886, 2163.53484000939, 2170.153640080362, 2193.396815875639, 2197.7252843394576, 2200.515886504966, 1908.7900330963582, 1967.8228959393723, 2186.8469207155504, 2196.769339219375, 2196.7803219678062, 11657.125715571367, 11741.882581174164, 11742.236754611009, 11745.177837551375, 11757.823632645517, 6229.314775374705, 6405.071264666643, 6431.453326467209, 6433.228012638513, 6453.0, 3624.746267761258, 3724.1062145085257, 3797.886063418102, 3811.6188381161937, 3812.1994381179984, 1277.9744405111846, 1280.2254635945305, 1311.2198242045968, 1332.420397127243, 1342.6374878782772, 16417.83582164175, 16491.752623710654, 16560.254788534545, 16598.336066557204, 16620.50138495835, 5400.594955378362, 5416.485433883775, 5462.699551524624, 5556.0, 5564.693941833238, 13177.27524986135, 13349.66625834362, 13357.465701371837, 13360.39878205483, 13399.263040532669, 6273.686315684289, 6366.840828979312, 6369.0446433034485, 6396.84007899797, 6403.519736019817, 5879.206307148565, 5911.615744976562, 5937.792177273861, 5958.910616340759, 6021.036634138517, 4195.706300558993, 4238.830446782094, 4250.3199488081755, 4253.936190957138, 4276.807543660543, 1171.9003884669728, 1176.9176157669053, 1181.9953039916174, 1185.2947496239724, 1205.6865215043977, 865.0441262405078, 876.6624849433014, 889.9332550058772, 894.7584152278848, 921.6313474610209, 6654.70053847578, 6671.132752742113, 6691.631960242136, 6743.629100399525, 6763.12079429671, 629.7166275176097, 635.7806556737918, 636.1030946365602, 641.4964253061324, 647.5273050673035, 4160.9375859362135, 4190.727602705814, 4754.334393184957, 4848.515148485194, 4888.120138375127, 14276.21480818565, 15348.846511534965, 15371.000884942443, 15384.077025365368, 15392.153431561372, 14684.26578671062, 15307.770383444256, 15318.463853765064, 15450.9227453862, 15466.458673946583, 9218.170364667078, 9291.21024712907, 9300.813983720423, 9337.71986840396, 9380.530973451436, 7145.4998150128995, 7402.9629851850395, 7566.583837888969, 7660.0, 7746.845063098819, 14134.50529231472, 14211.857881421054, 14228.217448040457, 14283.71432571322, 14506.564803055926, 14411.135331880121, 14494.497680223752, 14537.0, 14649.216648836687, 14863.1825249608, 9930.155936745168, 10245.077942985166, 10248.846267305848, 10248.846267305848, 10283.07452329294, 11206.646604213207, 11404.600838970597, 11450.484728187419, 11495.597654082067, 11524.366159861289, 9525.380850244712, 9616.95191524038, 9898.703038908845, 10124.84812727795, 10165.0, 9411.764705882408, 9418.199453046567, 9433.245340372616, 9497.952510237405, 9630.662926797528, 8250.968628921384, 8289.461185022954, 8342.499450032774, 8372.497650141011, 8392.034915984495, 6658.467322614082, 6708.865822683421, 6746.561473504206, 6916.688749006407, 6956.860862782817, 6628.933710663025, 6785.185777706707, 6796.218434879855, 6985.091938048021, 7033.683484243324], "value": 5408.047108623362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.14726252969, 424.1516966067864, 427.30349530265664, 428.28467515948915, 431.34004972392233, 5982.312034116078, 6086.178365920599, 6098.603590766603, 6157.907631385533, 6158.19943407357, 5885.382034886339, 6040.728167232474, 6050.183225264588, 6054.788082417116, 6098.908516372247, 4717.150912835688, 4840.394950631171, 4843.273508973647, 4849.7817598207985, 4869.756512174395, 4844.612431005511, 4847.345608342882, 4863.975680121594, 4865.245886887538, 4889.193283108283, 4814.807407703687, 4818.084563932859, 4818.927716084244, 4827.0104628551235, 4840.709557426548, 4713.175194340994, 4787.0, 4826.131296366652, 4844.733539655317, 4852.2479015752615, 4375.846845360429, 4380.60574548289, 4386.881345256971, 4419.801108950105, 4438.090191510732, 5812.186293918855, 5818.272715910512, 5829.88340233193, 5898.970505147447, 5929.0, 5637.548996080303, 5713.057345538023, 5717.771289148429, 5762.942370576283, 5763.193152958589, 6455.451286640594, 6464.191976003, 6475.417212450855, 6482.611043337415, 6489.1888513935755, 4830.0, 4891.266310053485, 4902.950970490321, 4920.335754673145, 4965.652404331699, 6556.93443065568, 6718.395344419026, 6776.356246156656, 6787.898181527281, 6800.149981252343, 4871.926921096187, 4885.706857588556, 4910.705357678479, 4916.8770780730765, 4917.286993385939, 4938.456769755324, 4976.42771081323, 4980.452150263468, 5057.140286151363, 5181.611379146504, 5676.545876329884, 5688.857778555569, 5730.426957304237, 5742.7415766290615, 5765.942340576625, 6397.296297407282, 6446.226452825691, 6492.675366231764, 6497.252815926135, 6514.0, 1771.1852547828144, 1799.1543974332044, 1813.6010077782867, 1813.9727904081449, 1815.3283285184566, 1247.644421339932, 1265.2977597433512, 1313.902891085935, 1316.1510825517487, 1332.4936524120965, 6157.0, 6163.722632481549, 6176.413240742122, 6185.072239164161, 6186.412290832363, 6573.8634943642555, 6597.60414375139, 6613.966930165415, 6616.338366163345, 6682.131322927989, 6113.633182009094, 6171.47542458896, 6178.351273116258, 6190.566660333733, 6201.317855035943, 3484.3728128936527, 3489.3370259650587, 3500.4749287607065, 3503.0, 3516.648335166463, 6803.48973826965, 6909.75815846453, 6946.7221311148, 6954.4436445084275, 6958.965205174043, 6766.9699090272725, 6798.592084474947, 6813.727450902007, 6826.552590941543, 6828.795136145924, 6545.738170473128, 6847.760328388483, 6848.897266541006, 6929.93070069313, 6935.930640693629, 6608.7356505739235, 6614.412540990032, 6638.20341559016, 6640.900386494303, 6643.269240383651, 6268.498520118288, 6474.320196379313, 6497.978440025411, 6529.575577587441, 6564.704588293634, 6947.965260173667, 6961.965190174017, 6970.651467426507, 6981.581105133709, 7000.709666456757, 4521.163584736834, 4659.743714095622, 4680.859574212779, 4690.92963605553, 4707.952920470751, 6630.0, 6645.202575690948, 6654.633995130314, 6663.533552651268, 6679.599224046573, 6340.907500524723, 6432.421082102634, 6435.774747883802, 6448.580842245239, 6501.674916254263, 6410.423061924449, 6417.326180750954, 6423.325550817097, 6438.8390290243115, 6454.451371633464, 6290.6334575016035, 6419.775307864203, 6430.421262086435, 6445.838854028687, 6455.4512866406885, 6421.871562568629, 6457.935420645734, 6463.030545418225, 6474.838129046811, 6477.935220647922, 6315.4947604192475, 6335.619862808247, 6337.366263373626, 6346.1432706585865, 6356.872862542631], "value": 5015.471886391721, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.701904333483, 874.4447275979755, 875.4484674654967, 879.8240351929612, 892.4957399069525, 17012.14939253037, 17434.38979635713, 17486.300547978066, 19395.0, 20950.057247423865, 18534.0, 19246.615067698673, 19369.418917432464, 19395.12721927513, 19415.12631931563, 986.8618393424927, 1018.231235417259, 1023.0383439566821, 1026.7741096958694, 1031.8349064149738, 975.4927437732375, 1007.325092188232, 1009.4599389326712, 1009.7778488732467, 1016.8779746430439, 1057.2070946789909, 1060.0883240413239, 1060.787842431513, 1061.517009760561, 1063.6117816996818, 1053.2627160987302, 1059.5549869055014, 1060.9946950265276, 1062.6440142552176, 1063.7340664833791, 769.0195001373238, 777.4713195027379, 777.6928113395234, 778.7702627724835, 778.8325510015317, 18450.723239151288, 18759.81240187608, 18775.812241877542, 18919.43241702751, 19027.42917712457, 18919.0, 18980.525486862938, 19076.71384929227, 19460.318888838963, 19469.707954380694, 14987.175705336202, 15026.774598381033, 15137.697246055128, 15189.392424303014, 15200.847991520053, 3214.5338925855854, 3326.96673033269, 3327.617324007722, 3328.0, 3335.6497567755523, 110979.44510277477, 112046.43976780064, 113148.0, 113572.43213783961, 116519.99999999916, 14930.10419374841, 14990.325435355435, 15046.0, 15170.393184272727, 15195.468158614396, 27628.58557121645, 27751.0, 27946.86026569895, 28283.858580706965, 28299.43401131966, 7803.219678032265, 8123.268905798388, 8261.710840120688, 8319.126491718403, 8346.123657015925, 3965.1276719121747, 4054.553999060101, 4080.959190408117, 4083.0608959938786, 4093.1404405074672, 4326.82692692295, 4382.715123517025, 4424.137293227854, 4424.845130420485, 4577.198990176706, 852.3266619370752, 855.7347222360963, 863.3697400897255, 867.6442658509981, 868.3270465389373, 677.4648028057877, 709.3190537084457, 712.4336152758569, 713.2190251674408, 720.3516834848679, 12321.507139714311, 12892.613221603367, 12898.548550800677, 13078.411471483807, 13192.538261160813, 665.1519312876025, 671.8992151177265, 675.2100042949761, 690.4510913823523, 700.4116542104656, 4858.198397264482, 4994.150994330972, 5007.39911210657, 5052.722100284446, 5180.093483640348, 109376.45311773391, 110261.0, 110451.53678485019, 111118.44440777905, 116122.0, 94092.0, 99611.50194249128, 100537.49731251443, 102136.0, 103830.0, 88333.0, 88427.55786221028, 88842.55578722066, 89006.0, 90256.0, 11202.719932001764, 11778.58774942907, 11879.643610691694, 11900.642980710592, 12018.519259229883, 37165.0, 37209.0, 37288.0, 37835.81082094682, 38942.0, 48118.51881481281, 48735.512644873095, 48857.755711221216, 49595.50404496053, 50212.24681629852, 15636.140012298978, 15842.52472425829, 16316.0, 16465.0, 16602.418915337905, 17877.553061173054, 20203.79796202078, 20729.378118656463, 21201.575968480236, 21291.467713306673, 16903.408380706616, 17206.827931720523, 17956.55108622295, 18319.35882244115, 18437.631247375244, 16740.665186696442, 16758.916205418896, 16918.154092295583, 17013.744793827856, 17179.742303865703, 17210.225539850486, 17478.388256410966, 18698.43904682862, 18946.621067578846, 19103.235870565022, 13252.403641835948, 13500.32498375097, 13586.524471643841, 13800.309984500534, 13889.930550347184, 14462.493812716926, 14499.710005800036, 14547.927260363631, 14560.49038283655, 14710.338034788247], "value": 8720.633135127531, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 123.0, 176.0, 119.0, 119.0, 118.0, 119.0, 138.0, 123.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 163.0, 163.0, 164.0, 166.0, 169.0, 169.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 91.0, 72.0, 73.0, 72.0, 87.0, 90.0, 73.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 100.0, 82.0, 81.0, 81.0, 97.0, 82.0, 81.0, 105.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 50.0, 48.0, 47.0, 47.0, 48.0, 49.0, 48.0, 51.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 85.0, 93.0, 129.0, 91.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 132.0, 128.0, 123.0, 132.0, 128.0, 133.0, 147.0, 127.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 178.0, 188.0, 182.0, 180.0, 181.0, 191.0, 180.0, 175.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 62.0, 65.0], "value": 64.2, "unit": "score"}]}]} 04:16:28 INFO - Return code: 0 04:16:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:16:28 INFO - # TBPL SUCCESS # 04:16:28 INFO - Running post-action listener: _resource_record_post_action 04:16:28 INFO - [mozharness: 2017-05-30 11:16:28.951933Z] Finished run-tests step (success) 04:16:28 INFO - Running post-run listener: _resource_record_post_run 04:16:29 INFO - Total resource usage - Wall time: 1248s; CPU: 13.0%; Read bytes: 8192; Write bytes: 421752832; Read time: 24; Write time: 229628 04:16:29 INFO - TinderboxPrint: CPU usage
12.6% 04:16:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 04:16:29 INFO - TinderboxPrint: I/O write bytes / time
421,752,832 / 229,628 04:16:29 INFO - TinderboxPrint: CPU idle
8,705.9 (87.4%) 04:16:29 INFO - TinderboxPrint: CPU user
1,202.8 (12.1%) 04:16:29 INFO - TinderboxPrint: Swap in / out
0 / 0 04:16:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103190528; Read time: 0; Write time: 86812 04:16:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:16:29 INFO - run-tests - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317804544; Read time: 12; Write time: 142808 04:16:29 INFO - Running post-run listener: _upload_blobber_files 04:16:29 INFO - Blob upload gear active. 04:16:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:29 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 04:16:29 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:16:29 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:16:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:30 INFO - (blobuploader) - INFO - Done attempting. 04:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:39 INFO - (blobuploader) - INFO - Done attempting. 04:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:16:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:40 INFO - (blobuploader) - INFO - Done attempting. 04:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:41 INFO - (blobuploader) - INFO - Done attempting. 04:16:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:41 INFO - Return code: 0 04:16:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a3c27035ea76e64e1d4c96f55b5a2ef5d01abc9b6c4eda27c7593007953d08c93d8fc69e92e130b9bc264fba2da1bd1621a2e76b714c02d23a1629fe22e5263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ef8a47b9ba68dcbb55058d3c2756d900c7d39c069e6b05630e21d09af39a350cd52eb5916fa2d221704830cc0fa9f6c503ca1a01385226a70672152eaeff1f2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49df6b5176c1f7aec3815782c41b5e509842eafd1bb5dd716e7dfb96756e27032d1909b5ab94183b1490ca7a572d943d31afd6c98acd98436707e99594bac039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4897d6fc373845ebc8c8ccc3aaaef15261aac5cecacee3eab04ca4192b36ed43c113e8e0963794732f3ad459eb8a0c0400945ada47d7b2ba316c306c509e1e92"} 04:16:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:41 INFO - Contents: 04:16:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a3c27035ea76e64e1d4c96f55b5a2ef5d01abc9b6c4eda27c7593007953d08c93d8fc69e92e130b9bc264fba2da1bd1621a2e76b714c02d23a1629fe22e5263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ef8a47b9ba68dcbb55058d3c2756d900c7d39c069e6b05630e21d09af39a350cd52eb5916fa2d221704830cc0fa9f6c503ca1a01385226a70672152eaeff1f2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49df6b5176c1f7aec3815782c41b5e509842eafd1bb5dd716e7dfb96756e27032d1909b5ab94183b1490ca7a572d943d31afd6c98acd98436707e99594bac039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4897d6fc373845ebc8c8ccc3aaaef15261aac5cecacee3eab04ca4192b36ed43c113e8e0963794732f3ad459eb8a0c0400945ada47d7b2ba316c306c509e1e92"} 04:16:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:41 INFO - Copying logs to upload dir... 04:16:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.210693 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2017-05-30 04:16:41.417935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 04:16:41.422277) ========= 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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 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-Non-PGO/sha512/2a3c27035ea76e64e1d4c96f55b5a2ef5d01abc9b6c4eda27c7593007953d08c93d8fc69e92e130b9bc264fba2da1bd1621a2e76b714c02d23a1629fe22e5263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ef8a47b9ba68dcbb55058d3c2756d900c7d39c069e6b05630e21d09af39a350cd52eb5916fa2d221704830cc0fa9f6c503ca1a01385226a70672152eaeff1f2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49df6b5176c1f7aec3815782c41b5e509842eafd1bb5dd716e7dfb96756e27032d1909b5ab94183b1490ca7a572d943d31afd6c98acd98436707e99594bac039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4897d6fc373845ebc8c8ccc3aaaef15261aac5cecacee3eab04ca4192b36ed43c113e8e0963794732f3ad459eb8a0c0400945ada47d7b2ba316c306c509e1e92"} build_url:https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/KJMV0DeVRp-9cI_dTrOG-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a3c27035ea76e64e1d4c96f55b5a2ef5d01abc9b6c4eda27c7593007953d08c93d8fc69e92e130b9bc264fba2da1bd1621a2e76b714c02d23a1629fe22e5263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ef8a47b9ba68dcbb55058d3c2756d900c7d39c069e6b05630e21d09af39a350cd52eb5916fa2d221704830cc0fa9f6c503ca1a01385226a70672152eaeff1f2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49df6b5176c1f7aec3815782c41b5e509842eafd1bb5dd716e7dfb96756e27032d1909b5ab94183b1490ca7a572d943d31afd6c98acd98436707e99594bac039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4897d6fc373845ebc8c8ccc3aaaef15261aac5cecacee3eab04ca4192b36ed43c113e8e0963794732f3ad459eb8a0c0400945ada47d7b2ba316c306c509e1e92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 04:16:41.449372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 04:16:41.449687) ========= 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=20e20d796406ba5117c4a6f1000001ba-1496141621.806506-2093150453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 04:16:41.531778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 04:16:41.535134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 04:16:41.535452) ========= ========= Total master_lag: 0.56 =========