builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1497663056.9 results: success (0) revision: bb8eab3c3ac4147848c4c85d628ba72029978665 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:56.904767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:56.905284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:56.905571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:56.959250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:56.959580) ========= 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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-16 18:30:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.9M=0s 2017-06-16 18:30:57 (50.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199461 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:57.194325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:57.194664) ========= 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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019812 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:57.251805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:57.252132) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb8eab3c3ac4147848c4c85d628ba72029978665 --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 bb8eab3c3ac4147848c4c85d628ba72029978665 --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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-16 18:30:57,406 truncating revision to first 12 chars 2017-06-16 18:30:57,406 Setting DEBUG logging. 2017-06-16 18:30:57,406 attempt 1/10 2017-06-16 18:30:57,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb8eab3c3ac4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-16 18:30:57,877 unpacking tar archive at: mozilla-central-bb8eab3c3ac4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:58.043248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:58.043571) ========= script_repo_revision: bb8eab3c3ac4147848c4c85d628ba72029978665 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:58.043988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:58.044249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-16 18:30:58.053981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-06-16 18:30:58.054249) ========= /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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:58 INFO - MultiFileLogger online at 20170616 18:30:58 in /builds/slave/test 18:30:58 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 18:30:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:58 INFO - {'append_to_log': False, 18:30:58 INFO - 'base_work_dir': '/builds/slave/test', 18:30:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:30:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:58 INFO - 'branch': 'Firefox-Non-PGO', 18:30:58 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:58 INFO - 'config_files': ('talos/linux_config.py',), 18:30:58 INFO - 'default_actions': ('clobber', 18:30:58 INFO - 'read-buildbot-config', 18:30:58 INFO - 'download-and-extract', 18:30:58 INFO - 'populate-webroot', 18:30:58 INFO - 'create-virtualenv', 18:30:58 INFO - 'install', 18:30:58 INFO - 'setup-mitmproxy', 18:30:58 INFO - 'run-tests'), 18:30:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:58 INFO - 'download_minidump_stackwalk': True, 18:30:58 INFO - 'download_symbols': 'ondemand', 18:30:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:58 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:58 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:58 INFO - 'gecko_profile': False, 18:30:58 INFO - 'gecko_profile_interval': 0, 18:30:58 INFO - 'installer_path': 'installer.exe', 18:30:58 INFO - 'log_level': 'info', 18:30:58 INFO - 'log_name': 'talos', 18:30:58 INFO - 'log_to_console': True, 18:30:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:58 INFO - 'opt_config_files': (), 18:30:58 INFO - 'pip_index': False, 18:30:58 INFO - 'suite': 'dromaeojs-e10s', 18:30:58 INFO - 'system_bits': '32', 18:30:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:58 INFO - 'title': 'talos-linux64-ix-085', 18:30:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:58 INFO - 'use_talos_json': True, 18:30:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:58 INFO - 'work_dir': 'build'} 18:30:58 INFO - [mozharness: 2017-06-17 01:30:58.406720Z] Running clobber step. 18:30:58 INFO - Running pre-action listener: _resource_record_pre_action 18:30:58 INFO - Running main action method: clobber 18:30:58 INFO - rmtree: /builds/slave/test/build 18:30:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:59 INFO - Running post-action listener: _resource_record_post_action 18:30:59 INFO - [mozharness: 2017-06-17 01:30:59.392904Z] Finished clobber step (success) 18:30:59 INFO - [mozharness: 2017-06-17 01:30:59.393005Z] Running read-buildbot-config step. 18:30:59 INFO - Running pre-action listener: _resource_record_pre_action 18:30:59 INFO - Running main action method: read_buildbot_config 18:30:59 INFO - Using buildbot properties: 18:30:59 INFO - { 18:30:59 INFO - "project": "", 18:30:59 INFO - "product": "firefox", 18:30:59 INFO - "who": "kwierso@gmail.com", 18:30:59 INFO - "installer_path": "public/build/target.tar.bz2", 18:30:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:30:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:30:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:30:59 INFO - "stage_platform": "linux64", 18:30:59 INFO - "basedir": "/builds/slave/test", 18:30:59 INFO - "buildnumber": 672, 18:30:59 INFO - "platform": "ubuntu64_hw", 18:30:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:30:59 INFO - "slavebuilddir": "test", 18:30:59 INFO - "taskId": "KxaHcZ2MQ3GUaPspXsGWLg", 18:30:59 INFO - "branch": "mozilla-central", 18:30:59 INFO - "script_repo_revision": "production", 18:30:59 INFO - "revision": "bb8eab3c3ac4147848c4c85d628ba72029978665", 18:30:59 INFO - "slavename": "talos-linux64-ix-085", 18:30:59 INFO - "repo_path": "mozilla-central" 18:30:59 INFO - } 18:30:59 INFO - Finding installer, test and symbols from parent task. 18:30:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxaHcZ2MQ3GUaPspXsGWLg'}, attempt #1 18:30:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxaHcZ2MQ3GUaPspXsGWLg'}, attempt #1 18:31:00 INFO - Task dependencies: IY1VAlt1QuqUoQKcLP3klQ 18:31:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ'}, attempt #1 18:31:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 18:31:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/test_packages.json 18:31:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.crashreporter-symbols.zip 18:31:00 INFO - Running post-action listener: _resource_record_post_action 18:31:00 INFO - [mozharness: 2017-06-17 01:31:00.738083Z] Finished read-buildbot-config step (success) 18:31:00 INFO - [mozharness: 2017-06-17 01:31:00.738303Z] Running download-and-extract step. 18:31:00 INFO - Running pre-action listener: _resource_record_pre_action 18:31:00 INFO - Running main action method: download_and_extract 18:31:00 INFO - mkdir: /builds/slave/test/build/tests 18:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:00 INFO - trying https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.test_packages.json 18:31:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:31:01 INFO - Downloaded 989 bytes. 18:31:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:31:01 INFO - Using the following test package requirements: 18:31:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:31:01 INFO - u'common': [u'target.common.tests.zip'], 18:31:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:31:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:31:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:31:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:31:01 INFO - u'mozbase': [u'target.common.tests.zip'], 18:31:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:31:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:31:01 INFO - u'web-platform': [u'target.common.tests.zip', 18:31:01 INFO - u'target.web-platform.tests.tar.gz'], 18:31:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:31:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:31:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip 18:31:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:31:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip into memory 18:31:05 INFO - Content-Length response header: 67979291 18:31:05 INFO - Bytes received: 67979291 18:31:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:31:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip 18:31:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:31:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.common.tests.zip into memory 18:31:17 INFO - Content-Length response header: 67979291 18:31:17 INFO - Bytes received: 67979291 18:31:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.talos.tests.zip 18:31:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:31:29 INFO - Fetch https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.talos.tests.zip into memory 18:31:30 INFO - Content-Length response header: 14454970 18:31:30 INFO - Bytes received: 14454970 18:31: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')]} 18:31:30 INFO - trying https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 18:31:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:31:32 INFO - Downloaded 59425519 bytes. 18:31:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 18:31:32 INFO - mkdir: /builds/slave/test/properties 18:31:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:32 INFO - Contents: 18:31:32 INFO - build_url:https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 18:31:32 INFO - Running post-action listener: _resource_record_post_action 18:31:32 INFO - Running post-action listener: set_extra_try_arguments 18:31:32 INFO - [mozharness: 2017-06-17 01:31:32.089015Z] Finished download-and-extract step (success) 18:31:32 INFO - [mozharness: 2017-06-17 01:31:32.089111Z] Running populate-webroot step. 18:31:32 INFO - Running pre-action listener: _resource_record_pre_action 18:31:32 INFO - Running main action method: populate_webroot 18:31:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:32 INFO - '--tppagecycles', 18:31:32 INFO - '7'], 18:31:32 INFO - 'tests': ['tsvgm']}}, 18:31:32 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['damp', 'tps']}, 18:31:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'tests': ['damp', 'tps']}, 18:31:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['dromaeo_dom']}, 18:31:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:31:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:31:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:31:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['a11yr', 18:31:32 INFO - 'ts_paint', 18:31:32 INFO - 'tpaint', 18:31:32 INFO - 'sessionrestore', 18:31:32 INFO - 'sessionrestore_no_auto_restore', 18:31:32 INFO - 'tabpaint']}, 18:31:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:31:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:31:32 INFO - 'bloom_basic_ref']}, 18:31:32 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:31:32 INFO - 'talos_options': ['--mitmproxy', 18:31:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:31:32 INFO - '--firstNonBlankPaint'], 18:31:32 INFO - 'tests': ['quantum_pageload_google', 18:31:32 INFO - 'quantum_pageload_youtube', 18:31:32 INFO - 'quantum_pageload_amazon', 18:31:32 INFO - 'quantum_pageload_facebook']}, 18:31:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['tsvgx', 18:31:32 INFO - 'tsvgr_opacity', 18:31:32 INFO - 'tart', 18:31:32 INFO - 'tscrollx', 18:31:32 INFO - 'cart', 18:31:32 INFO - 'tsvg_static']}, 18:31:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:32 INFO - 'tsvgr_opacity', 18:31:32 INFO - 'tart', 18:31:32 INFO - 'tscrollx', 18:31:32 INFO - 'cart', 18:31:32 INFO - 'tsvg_static']}, 18:31:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'talos_options': ['--disable-e10s'], 18:31:32 INFO - 'tests': ['tp5o']}, 18:31:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'talos_options': ['--disable-e10s', 18:31:32 INFO - '--xperf_path', 18:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:32 INFO - 'tests': ['tp5n']}, 18:31:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:32 INFO - 'talos_options': ['--xperf_path', 18:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:32 INFO - 'tests': ['tp5n']}}, 18:31:32 INFO - 'talos.zip': {'path': '', 18:31:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:32 INFO - Running post-action listener: _resource_record_post_action 18:31:32 INFO - [mozharness: 2017-06-17 01:31:32.104307Z] Finished populate-webroot step (success) 18:31:32 INFO - [mozharness: 2017-06-17 01:31:32.104407Z] Running create-virtualenv step. 18:31:32 INFO - Running pre-action listener: _resource_record_pre_action 18:31:32 INFO - Running main action method: create_virtualenv 18:31:32 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:31:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:31:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:32 INFO - Using real prefix '/usr' 18:31:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:32 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:34 INFO - Installing pip.................done. 18:31:34 INFO - Return code: 0 18:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:35 INFO - Reading from file tmpfile_stdout 18:31:35 INFO - Output received: 18:31:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:31:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31: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')]} 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:35 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 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:35 INFO - Using env: {'DISPLAY': ':0', 18:31:35 INFO - 'HOME': '/home/cltbld', 18:31:35 INFO - 'LANG': 'en_US.UTF-8', 18:31:35 INFO - 'LANGUAGE': 'en_US:en', 18:31:35 INFO - 'LOGNAME': 'cltbld', 18:31:35 INFO - 'MAIL': '/var/mail/cltbld', 18:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:35 INFO - 'MOZ_NO_REMOTE': '1', 18:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:35 INFO - 'NO_EM_RESTART': '1', 18:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:35 INFO - 'PWD': '/builds/slave/test', 18:31:35 INFO - 'SHELL': '/bin/bash', 18:31:35 INFO - 'SHLVL': '1', 18:31:35 INFO - 'TERM': 'linux', 18:31:35 INFO - 'TMOUT': '86400', 18:31:35 INFO - 'USER': 'cltbld', 18:31:35 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:35 INFO - '_': '/tools/buildbot/bin/python'} 18:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:31:35 INFO - Cleaning up... 18:31:35 INFO - Return code: 0 18:31:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31: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')]} 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:35 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 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:35 INFO - Using env: {'DISPLAY': ':0', 18:31:35 INFO - 'HOME': '/home/cltbld', 18:31:35 INFO - 'LANG': 'en_US.UTF-8', 18:31:35 INFO - 'LANGUAGE': 'en_US:en', 18:31:35 INFO - 'LOGNAME': 'cltbld', 18:31:35 INFO - 'MAIL': '/var/mail/cltbld', 18:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:35 INFO - 'MOZ_NO_REMOTE': '1', 18:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:35 INFO - 'NO_EM_RESTART': '1', 18:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:35 INFO - 'PWD': '/builds/slave/test', 18:31:35 INFO - 'SHELL': '/bin/bash', 18:31:35 INFO - 'SHLVL': '1', 18:31:35 INFO - 'TERM': 'linux', 18:31:35 INFO - 'TMOUT': '86400', 18:31:35 INFO - 'USER': 'cltbld', 18:31:35 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:35 INFO - '_': '/tools/buildbot/bin/python'} 18:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:35 INFO - Downloading/unpacking psutil>=3.1.1 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:36 INFO - Installing collected packages: psutil 18:31:36 INFO - Running setup.py install for psutil 18:31:36 INFO - building 'psutil._psutil_linux' extension 18:31:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:31:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:31:37 INFO - building 'psutil._psutil_posix' extension 18:31:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:31:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:38 INFO - Successfully installed psutil 18:31:38 INFO - Cleaning up... 18:31:38 INFO - Return code: 0 18:31:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31: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')]} 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:31:38 INFO - Using env: {'DISPLAY': ':0', 18:31:38 INFO - 'HOME': '/home/cltbld', 18:31:38 INFO - 'LANG': 'en_US.UTF-8', 18:31:38 INFO - 'LANGUAGE': 'en_US:en', 18:31:38 INFO - 'LOGNAME': 'cltbld', 18:31:38 INFO - 'MAIL': '/var/mail/cltbld', 18:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:38 INFO - 'MOZ_NO_REMOTE': '1', 18:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:38 INFO - 'NO_EM_RESTART': '1', 18:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:38 INFO - 'PWD': '/builds/slave/test', 18:31:38 INFO - 'SHELL': '/bin/bash', 18:31:38 INFO - 'SHLVL': '1', 18:31:38 INFO - 'TERM': 'linux', 18:31:38 INFO - 'TMOUT': '86400', 18:31:38 INFO - 'USER': 'cltbld', 18:31:38 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:38 INFO - '_': '/tools/buildbot/bin/python'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31: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 18:31: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 18:31: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 18:31: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 18:31:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:39 INFO - Installing collected packages: mozsystemmonitor 18:31:39 INFO - Running setup.py install for mozsystemmonitor 18:31:39 INFO - Successfully installed mozsystemmonitor 18:31:39 INFO - Cleaning up... 18:31:39 INFO - Return code: 0 18:31:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:31:39 INFO - Using env: {'DISPLAY': ':0', 18:31:39 INFO - 'HOME': '/home/cltbld', 18:31:39 INFO - 'LANG': 'en_US.UTF-8', 18:31:39 INFO - 'LANGUAGE': 'en_US:en', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MAIL': '/var/mail/cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SHLVL': '1', 18:31:39 INFO - 'TERM': 'linux', 18:31:39 INFO - 'TMOUT': '86400', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - '_': '/tools/buildbot/bin/python'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:41 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:41 INFO - warning: no files found matching '*.txt' 18:31:41 INFO - no previously-included directories found matching 'build' 18:31:41 INFO - no previously-included directories found matching 'dist' 18:31:41 INFO - no previously-included directories found matching '.git*' 18:31:41 INFO - Installing collected packages: jsonschema, functools32 18:31:41 INFO - Running setup.py install for functools32 18:31:41 INFO - warning: no files found matching '*.txt' 18:31:41 INFO - no previously-included directories found matching 'build' 18:31:41 INFO - no previously-included directories found matching 'dist' 18:31:41 INFO - no previously-included directories found matching '.git*' 18:31:41 INFO - Successfully installed jsonschema functools32 18:31:41 INFO - Cleaning up... 18:31:41 INFO - Return code: 0 18:31:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:31:41 INFO - Using env: {'DISPLAY': ':0', 18:31:41 INFO - 'HOME': '/home/cltbld', 18:31:41 INFO - 'LANG': 'en_US.UTF-8', 18:31:41 INFO - 'LANGUAGE': 'en_US:en', 18:31:41 INFO - 'LOGNAME': 'cltbld', 18:31:41 INFO - 'MAIL': '/var/mail/cltbld', 18:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:41 INFO - 'MOZ_NO_REMOTE': '1', 18:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:41 INFO - 'NO_EM_RESTART': '1', 18:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:41 INFO - 'PWD': '/builds/slave/test', 18:31:41 INFO - 'SHELL': '/bin/bash', 18:31:41 INFO - 'SHLVL': '1', 18:31:41 INFO - 'TERM': 'linux', 18:31:41 INFO - 'TMOUT': '86400', 18:31:41 INFO - 'USER': 'cltbld', 18:31:41 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:41 INFO - '_': '/tools/buildbot/bin/python'} 18:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:41 INFO - Cleaning up... 18:31:41 INFO - Return code: 0 18:31:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:31:41 INFO - Using env: {'DISPLAY': ':0', 18:31:41 INFO - 'HOME': '/home/cltbld', 18:31:41 INFO - 'LANG': 'en_US.UTF-8', 18:31:41 INFO - 'LANGUAGE': 'en_US:en', 18:31:41 INFO - 'LOGNAME': 'cltbld', 18:31:41 INFO - 'MAIL': '/var/mail/cltbld', 18:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:41 INFO - 'MOZ_NO_REMOTE': '1', 18:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:41 INFO - 'NO_EM_RESTART': '1', 18:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:41 INFO - 'PWD': '/builds/slave/test', 18:31:41 INFO - 'SHELL': '/bin/bash', 18:31:41 INFO - 'SHLVL': '1', 18:31:41 INFO - 'TERM': 'linux', 18:31:41 INFO - 'TMOUT': '86400', 18:31:41 INFO - 'USER': 'cltbld', 18:31:41 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:41 INFO - '_': '/tools/buildbot/bin/python'} 18:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:41 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:42 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:43 INFO - Downloading docopt-0.6.1.tar.gz 18:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:43 INFO - Running setup.py install for blobuploader 18:31:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:43 INFO - Running setup.py install for requests 18:31:43 INFO - Running setup.py install for docopt 18:31:44 INFO - Successfully installed blobuploader requests docopt 18:31:44 INFO - Cleaning up... 18:31:44 INFO - Return code: 0 18:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:44 INFO - Using env: {'DISPLAY': ':0', 18:31:44 INFO - 'HOME': '/home/cltbld', 18:31:44 INFO - 'LANG': 'en_US.UTF-8', 18:31:44 INFO - 'LANGUAGE': 'en_US:en', 18:31:44 INFO - 'LOGNAME': 'cltbld', 18:31:44 INFO - 'MAIL': '/var/mail/cltbld', 18:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:44 INFO - 'MOZ_NO_REMOTE': '1', 18:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:44 INFO - 'NO_EM_RESTART': '1', 18:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:44 INFO - 'PWD': '/builds/slave/test', 18:31:44 INFO - 'SHELL': '/bin/bash', 18:31:44 INFO - 'SHLVL': '1', 18:31:44 INFO - 'TERM': 'linux', 18:31:44 INFO - 'TMOUT': '86400', 18:31:44 INFO - 'USER': 'cltbld', 18:31:44 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:44 INFO - '_': '/tools/buildbot/bin/python'} 18:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:44 INFO - Running setup.py (path:/tmp/pip-hVLri5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:44 INFO - Running setup.py (path:/tmp/pip-qHObRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:44 INFO - Running setup.py (path:/tmp/pip-OjPMFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:44 INFO - Running setup.py (path:/tmp/pip-a4fwbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:44 INFO - Running setup.py (path:/tmp/pip-aMQlCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:44 INFO - Running setup.py (path:/tmp/pip-5b_mSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:44 INFO - Running setup.py (path:/tmp/pip-wufcT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:44 INFO - Running setup.py (path:/tmp/pip-zSGJHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:44 INFO - Running setup.py (path:/tmp/pip-0xAGJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:44 INFO - Running setup.py (path:/tmp/pip-GBaVx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:45 INFO - Running setup.py (path:/tmp/pip-Z8DXVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:45 INFO - Running setup.py (path:/tmp/pip-zyhguj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:45 INFO - Running setup.py (path:/tmp/pip-m2kcSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:45 INFO - Running setup.py (path:/tmp/pip-LaGSC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:45 INFO - Running setup.py (path:/tmp/pip-kI46Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:45 INFO - Running setup.py (path:/tmp/pip-QC44yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:45 INFO - Running setup.py (path:/tmp/pip-78X7UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:45 INFO - Running setup.py install for manifestparser 18:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:45 INFO - Running setup.py install for mozcrash 18:31:45 INFO - Running setup.py install for mozdebug 18:31:45 INFO - Running setup.py install for mozdevice 18:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:45 INFO - Running setup.py install for mozfile 18:31:46 INFO - Running setup.py install for mozhttpd 18:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozinfo 18:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozInstall 18:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozleak 18:31:46 INFO - Running setup.py install for mozlog 18:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for moznetwork 18:31:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozprocess 18:31:46 INFO - Running setup.py install for mozprofile 18:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozrunner 18:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Running setup.py install for mozscreenshot 18:31:47 INFO - Running setup.py install for moztest 18:31:47 INFO - Running setup.py install for mozversion 18:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:47 INFO - Cleaning up... 18:31:47 INFO - Return code: 0 18:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:47 INFO - Using env: {'DISPLAY': ':0', 18:31:47 INFO - 'HOME': '/home/cltbld', 18:31:47 INFO - 'LANG': 'en_US.UTF-8', 18:31:47 INFO - 'LANGUAGE': 'en_US:en', 18:31:47 INFO - 'LOGNAME': 'cltbld', 18:31:47 INFO - 'MAIL': '/var/mail/cltbld', 18:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:47 INFO - 'MOZ_NO_REMOTE': '1', 18:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:47 INFO - 'NO_EM_RESTART': '1', 18:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:47 INFO - 'PWD': '/builds/slave/test', 18:31:47 INFO - 'SHELL': '/bin/bash', 18:31:47 INFO - 'SHLVL': '1', 18:31:47 INFO - 'TERM': 'linux', 18:31:47 INFO - 'TMOUT': '86400', 18:31:47 INFO - 'USER': 'cltbld', 18:31:47 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:47 INFO - '_': '/tools/buildbot/bin/python'} 18:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:47 INFO - Running setup.py (path:/tmp/pip-DB9WS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:47 INFO - Running setup.py (path:/tmp/pip-NWgPys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:47 INFO - Running setup.py (path:/tmp/pip-t6ekcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:47 INFO - Running setup.py (path:/tmp/pip-Fbd2Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:47 INFO - Running setup.py (path:/tmp/pip-GAPnrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:47 INFO - Running setup.py (path:/tmp/pip-FqWuxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:47 INFO - Running setup.py (path:/tmp/pip-7fvMyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:48 INFO - Running setup.py (path:/tmp/pip-9r3gvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:48 INFO - Running setup.py (path:/tmp/pip-JK49_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:48 INFO - Running setup.py (path:/tmp/pip-6DUCsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:48 INFO - Running setup.py (path:/tmp/pip-0shlFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:48 INFO - Running setup.py (path:/tmp/pip-JpzGV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:48 INFO - Running setup.py (path:/tmp/pip-o2FSoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:48 INFO - Running setup.py (path:/tmp/pip-4Ap2P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:48 INFO - Running setup.py (path:/tmp/pip-zENeor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:48 INFO - Running setup.py (path:/tmp/pip-iSrQjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:48 INFO - Running setup.py (path:/tmp/pip-2CykL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:31:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:49 INFO - Downloading blessings-1.6.tar.gz 18:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:49 INFO - Installing collected packages: blessings 18:31:49 INFO - Running setup.py install for blessings 18:31:50 INFO - Successfully installed blessings 18:31:50 INFO - Cleaning up... 18:31:50 INFO - Return code: 0 18:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:50 INFO - Reading from file tmpfile_stdout 18:31:50 INFO - Current package versions: 18:31:50 INFO - argparse == 1.2.1 18:31:50 INFO - blessings == 1.6 18:31:50 INFO - blobuploader == 1.2.4 18:31:50 INFO - docopt == 0.6.1 18:31:50 INFO - functools32 == 3.2.3-2 18:31:50 INFO - jsonschema == 2.5.1 18:31:50 INFO - manifestparser == 1.1 18:31:50 INFO - mozInstall == 1.13 18:31:50 INFO - mozcrash == 1.0 18:31:50 INFO - mozdebug == 0.1 18:31:50 INFO - mozdevice == 0.51 18:31:50 INFO - mozfile == 1.2 18:31:50 INFO - mozhttpd == 0.7 18:31:50 INFO - mozinfo == 0.10 18:31:50 INFO - mozleak == 0.1 18:31:50 INFO - mozlog == 3.4 18:31:50 INFO - moznetwork == 0.27 18:31:50 INFO - mozprocess == 0.25 18:31:50 INFO - mozprofile == 0.28 18:31:50 INFO - mozrunner == 6.13 18:31:50 INFO - mozscreenshot == 0.1 18:31:50 INFO - mozsystemmonitor == 0.3 18:31:50 INFO - moztest == 0.8 18:31:50 INFO - mozversion == 1.4 18:31:50 INFO - psutil == 3.1.1 18:31:50 INFO - requests == 1.2.3 18:31:50 INFO - wsgiref == 0.1.2 18:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:50 INFO - Using env: {'DISPLAY': ':0', 18:31:50 INFO - 'HOME': '/home/cltbld', 18:31:50 INFO - 'LANG': 'en_US.UTF-8', 18:31:50 INFO - 'LANGUAGE': 'en_US:en', 18:31:50 INFO - 'LOGNAME': 'cltbld', 18:31:50 INFO - 'MAIL': '/var/mail/cltbld', 18:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:50 INFO - 'MOZ_NO_REMOTE': '1', 18:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:50 INFO - 'NO_EM_RESTART': '1', 18:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:50 INFO - 'PWD': '/builds/slave/test', 18:31:50 INFO - 'SHELL': '/bin/bash', 18:31:50 INFO - 'SHLVL': '1', 18:31:50 INFO - 'TERM': 'linux', 18:31:50 INFO - 'TMOUT': '86400', 18:31:50 INFO - 'USER': 'cltbld', 18:31:50 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:50 INFO - '_': '/tools/buildbot/bin/python'} 18:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:31:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:31:51 INFO - Installing collected packages: marionette-driver 18:31:51 INFO - Running setup.py install for marionette-driver 18:31:51 INFO - Successfully installed marionette-driver 18:31:51 INFO - Cleaning up... 18:31:51 INFO - Return code: 0 18:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:51 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 0xafa3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe789a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, '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': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:31:51 INFO - Using env: {'DISPLAY': ':0', 18:31:51 INFO - 'HOME': '/home/cltbld', 18:31:51 INFO - 'LANG': 'en_US.UTF-8', 18:31:51 INFO - 'LANGUAGE': 'en_US:en', 18:31:51 INFO - 'LOGNAME': 'cltbld', 18:31:51 INFO - 'MAIL': '/var/mail/cltbld', 18:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:51 INFO - 'MOZ_NO_REMOTE': '1', 18:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:51 INFO - 'NO_EM_RESTART': '1', 18:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:51 INFO - 'PWD': '/builds/slave/test', 18:31:51 INFO - 'SHELL': '/bin/bash', 18:31:51 INFO - 'SHLVL': '1', 18:31:51 INFO - 'TERM': 'linux', 18:31:51 INFO - 'TMOUT': '86400', 18:31:51 INFO - 'USER': 'cltbld', 18:31:51 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:51 INFO - '_': '/tools/buildbot/bin/python'} 18:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:52 INFO - Cleaning up... 18:31:52 INFO - Return code: 0 18:31:52 INFO - Running post-action listener: _resource_record_post_action 18:31:52 INFO - Running post-action listener: _start_resource_monitoring 18:31:52 INFO - Starting resource monitoring. 18:31:52 INFO - [mozharness: 2017-06-17 01:31:52.132312Z] Finished create-virtualenv step (success) 18:31:52 INFO - [mozharness: 2017-06-17 01:31:52.133244Z] Running install step. 18:31:52 INFO - Running pre-action listener: _resource_record_pre_action 18:31:52 INFO - Running main action method: install 18:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:52 INFO - Reading from file tmpfile_stdout 18:31:52 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:52 INFO - Reading from file tmpfile_stdout 18:31:52 INFO - Output received: 18:31:52 INFO - Usage: mozinstall [options] installer 18:31:52 INFO - Options: 18:31:52 INFO - -h, --help show this help message and exit 18:31:52 INFO - -d DEST, --destination=DEST 18:31:52 INFO - Directory to install application into. [default: 18:31:52 INFO - "/builds/slave/test"] 18:31:52 INFO - --app=APP Application being installed. [default: firefox] 18:31:52 INFO - mkdir: /builds/slave/test/build/application 18:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:32:09 INFO - Reading from file tmpfile_stdout 18:32:09 INFO - Output received: 18:32:09 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:09 INFO - Running post-action listener: _resource_record_post_action 18:32:09 INFO - [mozharness: 2017-06-17 01:32:09.989252Z] Finished install step (success) 18:32:09 INFO - [mozharness: 2017-06-17 01:32:09.989361Z] Running setup-mitmproxy step. 18:32:09 INFO - Running pre-action listener: _resource_record_pre_action 18:32:09 INFO - Running main action method: setup_mitmproxy 18:32:09 INFO - Skipping: mitmproxy is not required 18:32:09 INFO - Running post-action listener: _resource_record_post_action 18:32:09 INFO - [mozharness: 2017-06-17 01:32:09.990314Z] Finished setup-mitmproxy step (success) 18:32:09 INFO - [mozharness: 2017-06-17 01:32:09.990551Z] Running run-tests step. 18:32:09 INFO - Running pre-action listener: _resource_record_pre_action 18:32:09 INFO - Running main action method: run_tests 18:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:09 INFO - Python 2.7.3 18:32:09 INFO - Return code: 0 18:32:09 INFO - grabbing minidump binary from tooltool 18:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:09 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 0xe76140>, '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 0xe76a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe76ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:32:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:32:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:32:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:10 INFO - Return code: 0 18:32:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:10 INFO - ENV: RUST_BACKTRACE is now 1 18:32:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:10 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/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:32:10 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/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:32:10 INFO - Using env: {'DISPLAY': ':0', 18:32:10 INFO - 'HOME': '/home/cltbld', 18:32:10 INFO - 'LANG': 'en_US.UTF-8', 18:32:10 INFO - 'LANGUAGE': 'en_US:en', 18:32:10 INFO - 'LOGNAME': 'cltbld', 18:32:10 INFO - 'MAIL': '/var/mail/cltbld', 18:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:10 INFO - 'MOZ_NO_REMOTE': '1', 18:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:10 INFO - 'NO_EM_RESTART': '1', 18:32:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:10 INFO - 'PWD': '/builds/slave/test', 18:32:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:10 INFO - 'RUST_BACKTRACE': '1', 18:32:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:32:10 INFO - 'SHELL': '/bin/bash', 18:32:10 INFO - 'SHLVL': '1', 18:32:10 INFO - 'TERM': 'linux', 18:32:10 INFO - 'TMOUT': '86400', 18:32:10 INFO - 'USER': 'cltbld', 18:32:10 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1497662697.614789-41851528', 18:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:10 INFO - '_': '/tools/buildbot/bin/python'} 18:32:10 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/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:32:10 INFO - mozversion application_buildid: 20170617005906 18:32:10 INFO - mozversion application_changeset: bb8eab3c3ac4147848c4c85d628ba72029978665 18:32:10 INFO - mozversion application_display_name: Nightly 18:32:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:10 INFO - mozversion application_name: Firefox 18:32:10 INFO - mozversion application_remotingname: firefox 18:32:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:32:10 INFO - mozversion application_vendor: Mozilla 18:32:10 INFO - mozversion application_version: 56.0a1 18:32:10 INFO - mozversion platform_buildid: 20170617005906 18:32:10 INFO - mozversion platform_changeset: bb8eab3c3ac4147848c4c85d628ba72029978665 18:32:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:32:10 INFO - mozversion platform_version: 56.0a1 18:32:10 INFO - using testdate: 1497663130 18:32:10 INFO - actual date: 1497663130 18:32:10 INFO - starting webserver on 'localhost:45251' 18:32:10 INFO - SUITE-START | Running 2 tests 18:32:10 INFO - TEST-START | dromaeo_css 18:32:10 INFO - operating with platform_type : linux_ 18:32:10 INFO - Initialising browser for dromaeo_css test... 18:32:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45251/getInfo.html -profile /tmp/tmpk4xzrW/profile 18:32:10 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox http://localhost:45251/getInfo.html) 18:32:20 INFO - TEST-INFO | 3327: exit 0 18:32:20 INFO - Browser initialized. 18:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:20 INFO - TEST-INFO | started process 3538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk4xzrW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:31 INFO - PID 3538 | RSS: Main: 175472640 18:32:31 INFO - PID 3538 | 18:35:35 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45251/tests/dromaeo/cssquery-ext.html) 18:35:37 INFO - PID 3538 | RSS: Main: 183152640 18:35:37 INFO - PID 3538 | 18:38:38 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-ext.html (next: http://localhost:45251/tests/dromaeo/cssquery-jquery.html) 18:38:39 INFO - PID 3538 | RSS: Main: 178577408 18:38:39 INFO - PID 3538 | 18:41:41 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45251/tests/dromaeo/cssquery-mootools.html) 18:41:41 INFO - PID 3538 | RSS: Main: 183123968 18:41:41 INFO - PID 3538 | 18:44:43 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45251/tests/dromaeo/cssquery-prototype.html) 18:44:44 INFO - PID 3538 | RSS: Main: 180625408 18:44:44 INFO - PID 3538 | 18:47:46 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45251/tests/dromaeo/cssquery-yui.html) 18:47:47 INFO - PID 3538 | RSS: Main: 182366208 18:47:47 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | Cycle 1(1): loaded http://localhost:45251/tests/dromaeo/cssquery-yui.html (next: http://localhost:45251/tests/dromaeo/cssquery-dojo.html) 18:50:49 INFO - PID 3538 | RSS: Main: 179064832 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | __start_tp_report 18:50:49 INFO - PID 3538 | _x_x_mozilla_page_load 18:50:49 INFO - PID 3538 | _x_x_mozilla_page_load_details 18:50:49 INFO - PID 3538 | |i|pagename|runs| 18:50:49 INFO - PID 3538 | |0;dojo.html;3063.5251536011924;3130.968690313097;3137.498000319948;3141.387429451258;3156.6054243219605;6053.909191362122;6069.757209711612;6096.390360963901;6122.081687746835;6137.631742095472;5910.822675319737;6078.331383547807;6086.147939288492;6112.297085835119;6141.692915354237;5625.831225063254;5651.180578816079;5680.943190568083;5697.401772813857;5722.141678748179;5595.384507704129;5704.058830293017;5708.1437784332265;5713.885722285552;5726.685032323241;5496.0931446311315;5582.720863956786;5602.551795856321;5611.971940140274;5653.689047102408;5483.424240454735;5517.668939863621;5548.5838562108;5575.470330318613;5613.550915926716;5615.466530679579;5671.943280567183;5677.971610141923;5688.374278829326;5735.1970724098655;6090.847728806815;6105.908411373833;6145.9692701536205;6170.475509581691;6174.44430001302;6456.741730330781;6552.180977377828;6689.163854518185;6701.865962680719;6702.4302934250645;6491.9350806492275;6527.706253218616;6538.967305163444;6583.473322134218;6590.736370545173;6089.512838972872;6136.386361363828;6143.631382117087;6151.876962460726;6172.598781079216;6703.195616525951;6707.865842683119;6743;6758.459323254128;6806.863862722717;6205.131281620576;6317.178766760292;6319.620822750558;6324.08300796382;6337.556371053982;6472.482201423874;6536.215654121441;6605.669716514155;6666.866662666719;6682.532222744361;6645.1361323027695;6650.068990341356;6665;6671.766488172891;6682.465402767767;6450.322716114834;6538.542302038812;6546.672666366758;6678.766243181465;6697.531172817953;5250.894982100336;5260.631755777059;5263.894722105613;5292.814751483679;5320.068987927175;4567;4603.447586289667;4655.11552804966;4665.066986602693;4738.549837765407;5758.798442054508;5813.79651712188;5841.036229022164;5844.590878638454;5852;6685.826048776625;6752.93247067523;6757.290484499155;6759.628220447923;6783.525153239325;5567.66594004361;5656.2929633795775;5702.572307076985;5844.26946631671;5849.064149736107;5738.799142030009;5772.826815195551;5817.447342502455;5879.941200588025;5916.467517923407;6339.270983836917;6433;6434.549581529248;6439.484841212786;6467.967660161669;6704.564203326768;6710.060591517289;6717;6730.932690673227;6738.59568425896;6126.059675755388;6284.465820405134;6394.808155755335;6429.099926010269;6430.742770289136;6333.20834895638;6422.518311126591;6423.100765892872;6424.550281480439;6546.345365463606;6684.398404143651;6761.053452516553;6782.898256526058;6783.660816959231;6802.387785099365;6526.575772574767;6538.117354157318;6545.018247262758;6548.607083575001;6554.934450655433;6489.805305840832;6536.8365790855605;6542.672866356758;6562.048502966947;6564.868702625825;6180.320164781961;6246.531510136667;6256.311805701278;6328.778492752732;6453.096566480603;6523.902141467976;6575.967120164369;6580.473562114924;6591.34086591337;6599.175103112111;6377.17096777416;6378.48972082223;6400.711967961546;6403.551751377358;6405.679716014274 18:50:49 INFO - PID 3538 | |1;ext.html;816.6855760532193;829.4525613095358;861.6381119929629;884.7964968057347;887.4763889305309;38306.616933830686;39480.80259598705;39549;39618.8019059905;39649.20701585967;36120;36187.457188142136;36505.634943650555;36564.634353656525;36576;6855.4858385621155;6974.51178417511;6981.266966968471;6990.860182796341;7020.543664661806;6882.518223724342;6983.9650801746175;6987.68555415005;7005.82485437863;7029.578225306473;6893.896591551131;6958.860822783541;6977.546459480143;6981.511294209407;7725;7817.8827317590285;7834.804129896741;7856.921430785676;7899.210078992112;7915.4063445241545;7649.923500764977;7749.263819937097;7791.9870416846015;7811.33603643691;7817.765467035998;37908;38139.618603813884;38147;38176.80911595452;38248.42627360592;3446.327966046622;3451.7756345837693;3457.4640930655787;3466.0988143082727;3480.773749706261;29497.41005179906;29516.557251641243;29723.108306750833;29734;29897.402051959056;3735.1595890924596;3797.1836055247977;3800.2969450651717;3818.293615681108;3882.5535063467782;189528;189899;190167;191641;192023;48657;49141.75429122832;49331;49352;49430.50569494331;50622.74688626533;50797.74601127044;51105;51281;51384;14343.211123388313;14442.205678687564;14533.128012319296;14555.708885822225;14562.344694488773;11761.764764704658;11789.705257368634;11819.290842549475;11833.763324733458;11857.644270671894;14154.575362739135;14179.220142892034;14182.14907105577;14265;14364.497242596668;5479;5593.07714227148;5620.5503559715125;5685.431456854281;5735.082386818172;967.8693376394237;982.7444864335181;988.6963375335451;1017.7150397888603;1023.9078482936422;22073.889630551745;23090.251360863127;23231.419214519436;23268.88365558195;23733.406664833517;1061.2995423020923;1064.1167830700654;1091.2143256855052;1106.5463160104318;1107.1530279336314;12653.683657908627;12956.157849739737;12976.091673582947;13031.761982611637;13051.608451746462;212983;213631;222092;224020;225015;52338.73830630822;52388.214176787376;52808.207876881876;52852;52901.47098529043;1437.1879887863533;1438.611574874778;1464.2312785787333;1468.801711768919;1474.8967572269837;21446;23248.83755812169;23483.17808876681;23518.176863810368;23835;37381.62618373781;37662.81168594249;37695;37702.434463483616;37723.24553508969;196962;198166;198813;199797;199803;30201.848990755785;30407.695923040486;30492.695073048984;30498.23754406069;34551.82724086363;38611.42082868703;40477.595224047385;41310.79344603378;41840.58159418367;42927.785361072994;29298.267543311587;30315.484225789063;30765;31152.221194469414;32226.35547289088;30076.5488517668;30078.69921300759;30563.694363056085;31618.367632647678;31794.523082153322;34167.82916085404;36615.63384366122;36724.08189795277;37585.4362184562;38324.42513362246;27192.320191995357;29079.85460072686;30255.848720756254;30480.695193047784;30566.84716576403;23437.531249375257;25436.618450723625;25661.615075773505;25834.35414114662;26169.73830261673 18:50:49 INFO - PID 3538 | |2;jquery.html;551.9641223320486;559.2897020783605;563.7660370946057;577.4773829684135;599.6132494541021;21786.34640960772;22820.087196512162;22873.885630571865;22901.198458053972;22909.541809163806;24251.636225456634;24806.75193248067;26086.608700869503;26124.738752612517;26408.471830563376;6238.999999999989;6257.687115644222;6372.968135159318;6381.968090159566;6382.808515744512;6335.461485773715;6360.777372791953;6370.331115232903;6416.13382193405;6425.261094974091;5948.167256584082;6225.221847269091;6344.2386913570435;6374.266959299694;6454.838629034265;6387.457066149383;6454.160959075337;6468.191476065515;6482.67586620667;6486.3513648635235;6038.33578306386;6038.63768173911;6043.2748070231855;6043.848903777397;6048.818535443944;27593.58609620857;28714.856425717946;29031.70968290311;29198.708012920022;29317.26706832325;1919.395390452003;1962.3229985654925;1972.2998335590803;1976.6540855350256;1977.5945931084236;17530.47408577745;17909.7313540297;17932.55168620782;17997.910010449996;18049.187786549635;2322.6399908014287;2334.9066037358657;2367.573836709392;2408.638704194367;2425.1390756281617;121109.39445302806;123932;124475;124817;125181.37409312987;13252.885571890598;14063.507777227747;14578.781318280235;14605.92697036508;14694.706105878036;22335.888320558617;22497.88751056267;22509.774902250767;22556.436089097577;22584;8720.8691869622;8960.910390896008;8972.19250267479;9159.496227707406;9277.443353398683;7864.331531819745;7931.920680793233;7999.400044996649;8085.878711819328;8106.47307924983;8673.6530538779;8772.605232764541;8845.646174153091;9068;9195.862062069074;2538.3548106964213;2544.402065514603;2589.9223023309332;2783.3320003199087;2892.0889919675233;961.4615815143402;979.299800642544;985.081369881847;1011.4335971855784;1017;18835.434936951915;19110.044497775056;19321.710174347398;19725.605487890163;19892.10485528155;973.7176218896441;988.9208863290919;1004.7437903334603;1017.1201910347644;1027.0653705128448;10556.841647375295;10811.459427028618;10977.28647637901;11007.724806879893;11040.558377664964;454921;477556;480010;483819;488957;105325.47337263265;105478.47260763648;106861;111321;113519.43240283911;1180.2092597959388;1222.6515443098851;1224.0758227538329;1229.4283158331418;1237.7338872142532;19306;19474.415767526996;20205;21202.257920972694;21854.344369668936;51691.483085168664;52247.47752522426;54270.72864635652;54956.17565736597;57508.42491575031;66615;66715;67310;68060;68812.3118768826;12527.498900043896;12687.873121269038;12917.677058073623;12990.935045325092;13029.283389413673;15823.841761582236;18787.90606046961;18827.529311767314;18898.905505472383;19061.523461913563;14451.638709032359;14505.274736262934;14852.331645076214;14894.106353618818;15659;13339;13402;14269.500567480089;14411.92794036065;14667.413303467742;15956.521304360887;15966.28151733198;16155.515334539983;16168.595785105466;16223.351065957702;12709.110362274921;12776.36118194068;12793.744125117259;12834;12981.675458113623;15275.694486110438;15285.6178595536;15884.761728574313;15891.364345426517;15926.761098583298 18:50:49 INFO - PID 3538 | |3;mootools.html;1283.5379263465152;1336.886364659004;1347.7304539092183;1361.897857660675;1370.9520166794157;12998.54505092322;13506.729865402685;13609.931950340235;13670;13754.931225343871;13474.461021559126;13879.583612491617;13895.374708138133;13948.372323245452;13978.650533736662;2320.9187678431217;2341.7072865891764;2352.188494969233;2369.92890213293;2374.8456350337174;2229.15292188968;2314.8032417244553;2346.378209774411;2347.58917189492;2350;2047.3243829536218;2067.059487932994;2081.2507497301035;2176.227439259056;2211.3808133722505;2106.968395474069;2131.296672098204;2143.6355819510723;2143.8284937205062;2144;2176.216562037665;2225.643896976476;2231.5871563760593;2236.1726161320416;2236.563870045342;12881.162724422977;13316.933415332958;13325.800112998313;13345.199288042748;13374.933125334408;7187.245339239357;7516.135644400854;7517.436192285546;7523.473356865022;7525.247475252486;4138.255114079465;4184.309588917825;4244.384564238168;4274.166537525184;4316.072044510445;1492.656688961534;1578.968420631581;1591.108978971768;1597.8162511311232;1609.0265389439455;20770.06534705942;20925.26761563338;20936.895315523478;20942.79057209439;20957;5863.237779088691;6024.728887200086;6179.62922224668;6214.844628884314;6237.407446292595;14511.201883896276;14935.477258295907;14939.178345190901;14973.326200321011;15006.249687515581;6958.199807022156;7167.319104685151;7199.1361036675935;7217.603031833194;7239.855202895913;6520.315366886503;6628.867422651617;6671.933280667228;6754.121964144728;6770.898436523456;4390.385346051556;4497.123061003073;4575.611073058761;4577.427821522309;4614.492405835355;1390.986090139106;1435.181946290625;1442.9422823087168;1460.291758497128;1463.8755705764916;849.961751721174;862.5600943518725;871.1810897756089;875.470340444035;897.7935074932672;7894.881576776353;8148.714794982147;8306.958465207636;8313.210245026712;8624.827503449897;969.1519920069939;989.7030890732751;1015.7308313296983;1019.3170575714289;1042.468341146021;4787.688800227974;4831.202851529529;5452.6183167177915;5571.850384045734;5664.716764161858;17406.39077632277;17555.21001554933;17787.377441789475;17823.73264401035;17825.7326140108;17448;18365.449036528924;18420.907895460707;18497.907510462363;18530.629387412446;9971.252156088321;10069.848952265722;10130.138938190335;10143.594256229815;10207.489625518843;7082.822929426806;7806.258405451473;8075.838483230185;8369.85494514269;8541.231289184003;13996.720065598834;14111.858881411465;15519.301631426839;16251.431199907947;16394.262258198647;15200;15531.378744850079;16148.1925903702;16352.509424717278;16563.171841407642;10106.595736170471;10926.781464370828;11129.998300153025;11185.496652650487;11212.383318917538;11805.409729513318;11935.76128477443;12104.757904841677;12134.393280336124;12199.390030498262;9553.808923821623;9768.755781105529;9985.850212246676;10015.24885633595;10069.748256293651;9389.201917837061;9520.619175232912;9872.457014863965;10150.898491014996;10373.377597344184;8180.631871565913;8204.466709663853;8223.465474744122;8236;8298.419110662197;6444.613323200623;6643.667816609247;6712.93287067123;6960.443164546723;7096.503244773023;6808.38724514796;6913.51605387618;7074;7128.750493732695;7251.637418129178 18:50:49 INFO - PID 3538 | |4;prototype.html;490.1104495340954;497.4577710295778;512.9256257842616;514.5420575687638;522.0837430309806;6263.624182549044;6325.841853953653;6328.905066424001;6348.143000694905;6362.204724409449;6017.217761690985;6141.785037523688;6163.551565382131;6218.595791273564;6265.780697675582;5025.999999999991;5061.974690126563;5071.956825904446;5075.289459475676;5133.589312854962;5019.347484826967;5035.169197082477;5035.320231768719;5116.769745361467;5127.128388174001;4967.875803104916;4978.676386034915;5001;5002.774875130628;5025.623078269126;4780.760961951906;4942.728149951751;4952.207646776516;4960.900781984376;4971.875703107415;4429.15845989261;4492.303692927601;4504.617107545862;4518.051209246062;4521.932171017437;5975.133605627203;6014.7594096236535;6060.696965151725;6070.332263451061;6140.109684095781;5689.345725241567;5696.401877802812;5711.571632127566;5742.770289188469;5762.855928601818;6493.545451818374;6565.967170164118;6583.80248592543;6592.241892182413;6622.8344291393105;4888.455869494624;4901.103622620026;4905.3623029006;4908.656394052417;4915.066137433876;6877.5983370642825;6932.480063995221;6986.580805151707;6999;7003.894941575881;5083.8983220335385;5086.491350864884;5095.847124586268;5101.158308879068;5101.438841727407;5095.617828662791;5114.846554603293;5138.2806407103035;5152.613553983466;5181.870453238699;5745.942540574624;5747.770089196469;5751.482366587027;5756.539476841843;5776.537876969833;6641.771272314637;6682.164729408824;6690.264070952191;6690.632015239111;6692;1740.9651806963789;1762.753214549964;1771.6456708658063;1779.661864245789;1786;1200.783858905388;1221.8350522679502;1247.9812802807965;1258.314218750783;1260.6470188347278;5625.268715067015;5703.17303990919;5770.88458230833;5868.2664666916635;5904.645721256738;6711.664416779142;6749.42629876466;6793.966030169818;6799.858044715898;6825.419839313615;5594.776208951678;5768.653880767168;5828.591998560145;5832.891750567379;5836.854078648068;3515.191505953645;3598.7300952428673;3599.8580844397543;3602.7658202217294;3611.8916432507067;6483.902741458882;6487.935120648827;6520.445762110179;6523.8695226095215;6550.312217217219;6880.827979300458;6891.483138764513;6908.205556360982;6915.239323674392;6947.409470194989;6509.641969691617;6515.869682606416;6522.706478208492;6524;6526.869462610816;6739.59562426256;6743.7302507901095;6758.459323254227;6783.321667833177;6810.727570897108;6630.171228596426;6699.39214588505;6703.731850725916;6717;6737.957225664562;6506.154199953976;6535.183102112236;6548.672566371758;6551.181102362205;6573.967130164318;4916.287138364845;4955.925661115014;4958.157113290677;4963.280324352876;5001.449840517613;6764.1060503059225;6777.6272305023695;6784.388010615849;6807.455403567604;6808.9659551701925;6188.4739797117745;6556.180842237884;6574.934250657623;6586.8353291168105;6601;6419.523509592726;6580.242287998001;6612.305707900601;6625.852719958174;6636.800895973129;6538.607683539003;6546.345365463416;6551.4103730664465;6552.27924928248;6587.242467116152;6360.840978975562;6637.900431493628;6658.934570468702;6660.167479065117;6663.5002374821115;6116.8776624468155;6291.087792270187;6298.811035668938;6384.3934826191435;6416.454601358937 18:50:49 INFO - PID 3538 | |5;yui.html;777.6150805351349;789.2383849585149;811.6063709101085;852.6035393542002;866.9349798765093;17185.48443546694;17719.202635881386;17726.113694315263;17749.46751597451;17871.55321116973;17567.73648395275;18159.364422245224;18839.905800471013;19110.904445477754;19147.808521914776;1034.2036631793515;1046.7435478307825;1047.3611097230682;1048.7273308939693;1049.4018409506584;1050.9054185123337;1058.62418841311;1059.4332032362688;1064.340109132339;1064.6593090211136;1031.3090229546222;1106.8616422947132;1110.6334909479892;1119.7816425796973;1121.159130652011;1062.5271754069443;1069.0805906920043;1073.044989958937;1082.6589624268408;1085.1210519479248;785.6700185921926;788.6608758233957;790.4980337485681;797.9002624671916;798.9680412783482;16998.3200671973;17155.313787448486;17158.571035724082;17199.914000430043;18011.639767204713;17447.21487533064;17692.823071769373;17715.46853594381;17959.461216163407;18019.27922883083;15687.607809804733;15703;15746.842531574766;15788.131652759093;15823.525294241192;3494.9825250873837;3545.7517973741847;3571.7321200910037;3584.17563960288;3627.891163265106;93874.53062734642;96285.51857240668;98504;99400;100442.99999999927;12793;12971.41628626714;12973.286469244282;12977.221366718028;12980.480780768852;26491.337716557242;28283.292917676812;28331.29171770681;28381.716182837907;28598.14205573836;8239.052508961426;8261.297789687944;8395.496270223806;8397.95801020991;8525.062243153248;3985.123272879962;4000.739951903117;4012.3580227163516;4024.054347228399;4033.3546632538655;4811;4854.514548545188;4923.08922849274;4935.481774413706;4941.827036053793;869.4479005831216;915.514777168102;916.862470629411;918.0360621347559;918.4626993208914;515.7362571313607;642.2453617000007;664.8603793203384;675.9019942108465;695.2873304862455;10530.736731581772;11125.388103654215;11393.658190254306;11667.416629168507;11716.17986740937;634.3783092569308;653.1443808610735;659.8779225843139;669.8158006548239;677.8034370032734;4826.734529600905;5027.245913113063;5112.003159383885;5171.4311425743135;5245.160774276097;91602;92305.5384723072;92643;96545.5172724146;96906.51546742363;78953.60523197347;80737;82644.58677706574;85029.57485212658;85856.57071714726;70507.2949270511;71253.2874671257;71652.64173679202;72603.27396725965;74460.62769686116;9567.44202033896;9760.170385517311;9842.901570984199;9961.800763984824;10050.8492372613;30725.385492290476;31154.844225778725;31620.841895790374;31930.20174495656;33525.48558858144;39223.80388098041;41366.9658258546;42249.78875105605;42288.365674514294;42308.36537452002;15024.17367044823;15127.697446051237;15156.696866062837;15241.771373429629;15541.37834486653;16481.423150189687;17114.14429278556;17129.828701713323;17133;17259;13920.234387108807;14085.507007254697;14216.502422415166;14224.431022758974;14378.137311761328;13479.595612131652;13758.380872860946;14074.339953737053;14125.646858828612;14429.78355324692;13192.340382981005;13308.201507909556;13328;13440.798388024383;15514;12018.399080045789;12436.564720234748;13284.136531125447;13711.177329360271;14352.682677059769;11902.226355286879;11984.64046078619;12235.75528489443;12381.380930953235;12515.624531264077 18:50:49 INFO - PID 3538 | __end_tp_report 18:50:49 INFO - PID 3538 | __start_cc_report 18:50:49 INFO - PID 3538 | _x_x_mozilla_cycle_collect,371 18:50:49 INFO - PID 3538 | __end_cc_report 18:50:49 INFO - PID 3538 | __startTimestamp1497664249349__endTimestamp 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | ------- Summary: start ------- 18:50:49 INFO - PID 3538 | Number of tests: 6 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#0] dojo.html Cycles:165 Average:6086.29 Median:6319.62 stddev:721.84 (11.4%) stddev-sans-first:684.00 18:50:49 INFO - PID 3538 | Values: 3063.5 3131.0 3137.5 3141.4 3156.6 6053.9 6069.8 6096.4 6122.1 6137.6 5910.8 6078.3 6086.1 6112.3 6141.7 5625.8 5651.2 5680.9 5697.4 5722.1 5595.4 5704.1 5708.1 5713.9 5726.7 5496.1 5582.7 5602.6 5612.0 5653.7 5483.4 5517.7 5548.6 5575.5 5613.6 5615.5 5671.9 5678.0 5688.4 5735.2 6090.8 6105.9 6146.0 6170.5 6174.4 6456.7 6552.2 6689.2 6701.9 6702.4 6491.9 6527.7 6539.0 6583.5 6590.7 6089.5 6136.4 6143.6 6151.9 6172.6 6703.2 6707.9 6743.0 6758.5 6806.9 6205.1 6317.2 6319.6 6324.1 6337.6 6472.5 6536.2 6605.7 6666.9 6682.5 6645.1 6650.1 6665.0 6671.8 6682.5 6450.3 6538.5 6546.7 6678.8 6697.5 5250.9 5260.6 5263.9 5292.8 5320.1 4567.0 4603.4 4655.1 4665.1 4738.5 5758.8 5813.8 5841.0 5844.6 5852.0 6685.8 6752.9 6757.3 6759.6 6783.5 5567.7 5656.3 5702.6 5844.3 5849.1 5738.8 5772.8 5817.4 5879.9 5916.5 6339.3 6433.0 6434.5 6439.5 6468.0 6704.6 6710.1 6717.0 6730.9 6738.6 6126.1 6284.5 6394.8 6429.1 6430.7 6333.2 6422.5 6423.1 6424.6 6546.3 6684.4 6761.1 6782.9 6783.7 6802.4 6526.6 6538.1 6545.0 6548.6 6554.9 6489.8 6536.8 6542.7 6562.0 6564.9 6180.3 6246.5 6256.3 6328.8 6453.1 6523.9 6576.0 6580.5 6591.3 6599.2 6377.2 6378.5 6400.7 6403.6 6405.7 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#1] ext.html Cycles:180 Average:36719.14 Median:3461.78 stddev:52715.56 (1522.8%) stddev-sans-first:52794.51 18:50:49 INFO - PID 3538 | Values: 816.7 829.5 861.6 884.8 887.5 38306.6 39480.8 39549.0 39618.8 39649.2 36120.0 36187.5 36505.6 36564.6 36576.0 6855.5 6974.5 6981.3 6990.9 7020.5 6882.5 6984.0 6987.7 7005.8 7029.6 6893.9 6958.9 6977.5 6981.5 7725.0 7817.9 7834.8 7856.9 7899.2 7915.4 7649.9 7749.3 7792.0 7811.3 7817.8 37908.0 38139.6 38147.0 38176.8 38248.4 3446.3 3451.8 3457.5 3466.1 3480.8 29497.4 29516.6 29723.1 29734.0 29897.4 3735.2 3797.2 3800.3 3818.3 3882.6 189528.0 189899.0 190167.0 191641.0 192023.0 48657.0 49141.8 49331.0 49352.0 49430.5 50622.7 50797.7 51105.0 51281.0 51384.0 14343.2 14442.2 14533.1 14555.7 14562.3 11761.8 11789.7 11819.3 11833.8 11857.6 14154.6 14179.2 14182.1 14265.0 14364.5 5479.0 5593.1 5620.6 5685.4 5735.1 967.9 982.7 988.7 1017.7 1023.9 22073.9 23090.3 23231.4 23268.9 23733.4 1061.3 1064.1 1091.2 1106.5 1107.2 12653.7 12956.2 12976.1 13031.8 13051.6 212983.0 213631.0 222092.0 224020.0 225015.0 52338.7 52388.2 52808.2 52852.0 52901.5 1437.2 1438.6 1464.2 1468.8 1474.9 21446.0 23248.8 23483.2 23518.2 23835.0 37381.6 37662.8 37695.0 37702.4 37723.2 196962.0 198166.0 198813.0 199797.0 199803.0 30201.8 30407.7 30492.7 30498.2 34551.8 38611.4 40477.6 41310.8 41840.6 42927.8 29298.3 30315.5 30765.0 31152.2 32226.4 30076.5 30078.7 30563.7 31618.4 31794.5 34167.8 36615.6 36724.1 37585.4 38324.4 27192.3 29079.9 30255.8 30480.7 30566.8 23437.5 25436.6 25661.6 25834.4 26169.7 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#2] jquery.html Cycles:180 Average:32947.18 Median:22702.04 stddev:80019.74 (352.5%) stddev-sans-first:80207.25 18:50:49 INFO - PID 3538 | Values: 552.0 559.3 563.8 577.5 599.6 21786.3 22820.1 22873.9 22901.2 22909.5 24251.6 24806.8 26086.6 26124.7 26408.5 6239.0 6257.7 6373.0 6382.0 6382.8 6335.5 6360.8 6370.3 6416.1 6425.3 5948.2 6225.2 6344.2 6374.3 6454.8 6387.5 6454.2 6468.2 6482.7 6486.4 6038.3 6038.6 6043.3 6043.8 6048.8 27593.6 28714.9 29031.7 29198.7 29317.3 1919.4 1962.3 1972.3 1976.7 1977.6 17530.5 17909.7 17932.6 17997.9 18049.2 2322.6 2334.9 2367.6 2408.6 2425.1 121109.4 123932.0 124475.0 124817.0 125181.4 13252.9 14063.5 14578.8 14605.9 14694.7 22335.9 22497.9 22509.8 22556.4 22584.0 8720.9 8960.9 8972.2 9159.5 9277.4 7864.3 7931.9 7999.4 8085.9 8106.5 8673.7 8772.6 8845.6 9068.0 9195.9 2538.4 2544.4 2589.9 2783.3 2892.1 961.5 979.3 985.1 1011.4 1017.0 18835.4 19110.0 19321.7 19725.6 19892.1 973.7 988.9 1004.7 1017.1 1027.1 10556.8 10811.5 10977.3 11007.7 11040.6 454921.0 477556.0 480010.0 483819.0 488957.0 105325.5 105478.5 106861.0 111321.0 113519.4 1180.2 1222.7 1224.1 1229.4 1237.7 19306.0 19474.4 20205.0 21202.3 21854.3 51691.5 52247.5 54270.7 54956.2 57508.4 66615.0 66715.0 67310.0 68060.0 68812.3 12527.5 12687.9 12917.7 12990.9 13029.3 15823.8 18787.9 18827.5 18898.9 19061.5 14451.6 14505.3 14852.3 14894.1 15659.0 13339.0 13402.0 14269.5 14411.9 14667.4 15956.5 15966.3 16155.5 16168.6 16223.4 12709.1 12776.4 12793.7 12834.0 12981.7 15275.7 15285.6 15884.8 15891.4 15926.8 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#3] mootools.html Cycles:180 Average:8148.86 Median:2193.80 stddev:5533.81 (252.2%) stddev-sans-first:5525.29 18:50:49 INFO - PID 3538 | Values: 1283.5 1336.9 1347.7 1361.9 1371.0 12998.5 13506.7 13609.9 13670.0 13754.9 13474.5 13879.6 13895.4 13948.4 13978.7 2320.9 2341.7 2352.2 2369.9 2374.8 2229.2 2314.8 2346.4 2347.6 2350.0 2047.3 2067.1 2081.3 2176.2 2211.4 2107.0 2131.3 2143.6 2143.8 2144.0 2176.2 2225.6 2231.6 2236.2 2236.6 12881.2 13316.9 13325.8 13345.2 13374.9 7187.2 7516.1 7517.4 7523.5 7525.2 4138.3 4184.3 4244.4 4274.2 4316.1 1492.7 1579.0 1591.1 1597.8 1609.0 20770.1 20925.3 20936.9 20942.8 20957.0 5863.2 6024.7 6179.6 6214.8 6237.4 14511.2 14935.5 14939.2 14973.3 15006.2 6958.2 7167.3 7199.1 7217.6 7239.9 6520.3 6628.9 6671.9 6754.1 6770.9 4390.4 4497.1 4575.6 4577.4 4614.5 1391.0 1435.2 1442.9 1460.3 1463.9 850.0 862.6 871.2 875.5 897.8 7894.9 8148.7 8307.0 8313.2 8624.8 969.2 989.7 1015.7 1019.3 1042.5 4787.7 4831.2 5452.6 5571.9 5664.7 17406.4 17555.2 17787.4 17823.7 17825.7 17448.0 18365.4 18420.9 18497.9 18530.6 9971.3 10069.8 10130.1 10143.6 10207.5 7082.8 7806.3 8075.8 8369.9 8541.2 13996.7 14111.9 15519.3 16251.4 16394.3 15200.0 15531.4 16148.2 16352.5 16563.2 10106.6 10926.8 11130.0 11185.5 11212.4 11805.4 11935.8 12104.8 12134.4 12199.4 9553.8 9768.8 9985.9 10015.2 10069.7 9389.2 9520.6 9872.5 10150.9 10373.4 8180.6 8204.5 8223.5 8236.0 8298.4 6444.6 6643.7 6712.9 6960.4 7096.5 6808.4 6913.5 7074.0 7128.8 7251.6 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#4] prototype.html Cycles:180 Average:5543.33 Median:6128.49 stddev:1555.18 (25.4%) stddev-sans-first:1512.59 18:50:49 INFO - PID 3538 | Values: 490.1 497.5 512.9 514.5 522.1 6263.6 6325.8 6328.9 6348.1 6362.2 6017.2 6141.8 6163.6 6218.6 6265.8 5026.0 5062.0 5072.0 5075.3 5133.6 5019.3 5035.2 5035.3 5116.8 5127.1 4967.9 4978.7 5001.0 5002.8 5025.6 4780.8 4942.7 4952.2 4960.9 4971.9 4429.2 4492.3 4504.6 4518.1 4521.9 5975.1 6014.8 6060.7 6070.3 6140.1 5689.3 5696.4 5711.6 5742.8 5762.9 6493.5 6566.0 6583.8 6592.2 6622.8 4888.5 4901.1 4905.4 4908.7 4915.1 6877.6 6932.5 6986.6 6999.0 7003.9 5083.9 5086.5 5095.8 5101.2 5101.4 5095.6 5114.8 5138.3 5152.6 5181.9 5745.9 5747.8 5751.5 5756.5 5776.5 6641.8 6682.2 6690.3 6690.6 6692.0 1741.0 1762.8 1771.6 1779.7 1786.0 1200.8 1221.8 1248.0 1258.3 1260.6 5625.3 5703.2 5770.9 5868.3 5904.6 6711.7 6749.4 6794.0 6799.9 6825.4 5594.8 5768.7 5828.6 5832.9 5836.9 3515.2 3598.7 3599.9 3602.8 3611.9 6483.9 6487.9 6520.4 6523.9 6550.3 6880.8 6891.5 6908.2 6915.2 6947.4 6509.6 6515.9 6522.7 6524.0 6526.9 6739.6 6743.7 6758.5 6783.3 6810.7 6630.2 6699.4 6703.7 6717.0 6738.0 6506.2 6535.2 6548.7 6551.2 6574.0 4916.3 4955.9 4958.2 4963.3 5001.4 6764.1 6777.6 6784.4 6807.5 6809.0 6188.5 6556.2 6574.9 6586.8 6601.0 6419.5 6580.2 6612.3 6625.9 6636.8 6538.6 6546.3 6551.4 6552.3 6587.2 6360.8 6637.9 6658.9 6660.2 6663.5 6116.9 6291.1 6298.8 6384.4 6416.5 18:50:49 INFO - PID 3538 | 18:50:49 INFO - PID 3538 | [#5] yui.html Cycles:180 Average:19509.52 Median:19129.36 stddev:25753.62 (134.6%) stddev-sans-first:25787.45 18:50:49 INFO - PID 3538 | Values: 777.6 789.2 811.6 852.6 866.9 17185.5 17719.2 17726.1 17749.5 17871.6 17567.7 18159.4 18839.9 19110.9 19147.8 1034.2 1046.7 1047.4 1048.7 1049.4 1050.9 1058.6 1059.4 1064.3 1064.7 1031.3 1106.9 1110.6 1119.8 1121.2 1062.5 1069.1 1073.0 1082.7 1085.1 785.7 788.7 790.5 797.9 799.0 16998.3 17155.3 17158.6 17199.9 18011.6 17447.2 17692.8 17715.5 17959.5 18019.3 15687.6 15703.0 15746.8 15788.1 15823.5 3495.0 3545.8 3571.7 3584.2 3627.9 93874.5 96285.5 98504.0 99400.0 100443.0 12793.0 12971.4 12973.3 12977.2 12980.5 26491.3 28283.3 28331.3 28381.7 28598.1 8239.1 8261.3 8395.5 8398.0 8525.1 3985.1 4000.7 4012.4 4024.1 4033.4 4811.0 4854.5 4923.1 4935.5 4941.8 869.4 915.5 916.9 918.0 918.5 515.7 642.2 664.9 675.9 695.3 10530.7 11125.4 11393.7 11667.4 11716.2 634.4 653.1 659.9 669.8 677.8 4826.7 5027.2 5112.0 5171.4 5245.2 91602.0 92305.5 92643.0 96545.5 96906.5 78953.6 80737.0 82644.6 85029.6 85856.6 70507.3 71253.3 71652.6 72603.3 74460.6 9567.4 9760.2 9842.9 9961.8 10050.8 30725.4 31154.8 31620.8 31930.2 33525.5 39223.8 41367.0 42249.8 42288.4 42308.4 15024.2 15127.7 15156.7 15241.8 15541.4 16481.4 17114.1 17129.8 17133.0 17259.0 13920.2 14085.5 14216.5 14224.4 14378.1 13479.6 13758.4 14074.3 14125.6 14429.8 13192.3 13308.2 13328.0 13440.8 15514.0 12018.4 12436.6 13284.1 13711.2 14352.7 11902.2 11984.6 12235.8 12381.4 12515.6 18:50:49 INFO - PID 3538 | -------- Summary: end -------- 18:50:49 INFO - PID 3538 | 18:50:50 INFO - TEST-INFO | 3538: exit 0 18:50:50 INFO - TEST-OK | dromaeo_css | took 1119328ms 18:50:50 INFO - TEST-START | kraken 18:50:50 INFO - operating with platform_type : linux_ 18:50:50 INFO - Initialising browser for kraken test... 18:50:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45251/getInfo.html -profile /tmp/tmpYfLVPp/profile 18:50:50 INFO - TEST-INFO | started process 3929 (/builds/slave/test/build/application/firefox/firefox http://localhost:45251/getInfo.html) 18:50:56 INFO - TEST-INFO | 3929: exit 0 18:50:56 INFO - Browser initialized. 18:50:56 INFO - Running cycle 1/1 for kraken test... 18:50:56 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfLVPp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:08 INFO - PID 4142 | RSS: Main: 175325184 18:51:08 INFO - PID 4142 | 18:51:10 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45251/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:11 INFO - PID 4142 | RSS: Main: 178778112 18:51:11 INFO - PID 4142 | 18:51:14 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45251/tests/kraken/driver.html?testName=audio-dft) 18:51:15 INFO - PID 4142 | RSS: Main: 179023872 18:51:15 INFO - PID 4142 | 18:51:18 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45251/tests/kraken/driver.html?testName=audio-fft) 18:51:18 INFO - PID 4142 | RSS: Main: 175992832 18:51:18 INFO - PID 4142 | 18:51:20 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45251/tests/kraken/driver.html?testName=audio-oscillator) 18:51:21 INFO - PID 4142 | RSS: Main: 176934912 18:51:21 INFO - PID 4142 | 18:51:23 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:24 INFO - PID 4142 | RSS: Main: 176939008 18:51:24 INFO - PID 4142 | 18:51:27 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45251/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:27 INFO - PID 4142 | RSS: Main: 180940800 18:51:27 INFO - PID 4142 | 18:51:31 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45251/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:31 INFO - PID 4142 | RSS: Main: 182165504 18:51:31 INFO - PID 4142 | 18:51:34 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45251/tests/kraken/driver.html?testName=json-parse-financial) 18:51:35 INFO - PID 4142 | RSS: Main: 181047296 18:51:35 INFO - PID 4142 | 18:51:36 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:37 INFO - PID 4142 | RSS: Main: 180379648 18:51:37 INFO - PID 4142 | 18:51:39 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:39 INFO - PID 4142 | RSS: Main: 180928512 18:51:39 INFO - PID 4142 | 18:51:41 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:42 INFO - PID 4142 | RSS: Main: 180113408 18:51:42 INFO - PID 4142 | 18:51:45 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:46 INFO - PID 4142 | RSS: Main: 180109312 18:51:46 INFO - PID 4142 | 18:51:49 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:49 INFO - PID 4142 | RSS: Main: 180539392 18:51:49 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:45251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45251/tests/kraken/driver.html?testName=ai-astar) 18:51:51 INFO - PID 4142 | RSS: Main: 182255616 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | __start_tp_report 18:51:51 INFO - PID 4142 | _x_x_mozilla_page_load 18:51:51 INFO - PID 4142 | _x_x_mozilla_page_load_details 18:51:51 INFO - PID 4142 | |i|pagename|runs| 18:51:51 INFO - PID 4142 | |0;ai-astar;101;109;110;107;112;114;108;108;109;109 18:51:51 INFO - PID 4142 | |1;audio-beat-detection;152;122;142;180;127;154;152;122;177;123 18:51:51 INFO - PID 4142 | |2;audio-dft;164;167;165;162;162;178;165;170;171;166 18:51:51 INFO - PID 4142 | |3;audio-fft;77;74;74;175;76;74;75;75;97;75 18:51:51 INFO - PID 4142 | |4;audio-oscillator;81;82;138;82;82;83;125;82;82;142 18:51:51 INFO - PID 4142 | |5;imaging-gaussian-blur;114;115;114;117;117;114;114;115;114;115 18:51:51 INFO - PID 4142 | |6;imaging-darkroom;150;151;150;150;153;150;151;153;151;149 18:51:51 INFO - PID 4142 | |7;imaging-desaturate;94;101;95;98;95;94;101;94;94;94 18:51:51 INFO - PID 4142 | |8;json-parse-financial;56;60;54;55;57;58;54;56;54;55 18:51:51 INFO - PID 4142 | |9;json-stringify-tinderbox;54;55;55;55;55;55;56;55;55;57 18:51:51 INFO - PID 4142 | |10;stanford-crypto-aes;80;78;77;78;78;86;79;78;77;79 18:51:51 INFO - PID 4142 | |11;stanford-crypto-ccm;141;136;135;132;143;135;143;136;128;155 18:51:51 INFO - PID 4142 | |12;stanford-crypto-pbkdf2;198;178;193;187;198;202;193;206;196;202 18:51:51 INFO - PID 4142 | |13;stanford-crypto-sha256-iterative;72;71;72;71;71;75;71;70;69;68 18:51:51 INFO - PID 4142 | __end_tp_report 18:51:51 INFO - PID 4142 | __start_cc_report 18:51:51 INFO - PID 4142 | _x_x_mozilla_cycle_collect,975 18:51:51 INFO - PID 4142 | __end_cc_report 18:51:51 INFO - PID 4142 | __startTimestamp1497664311823__endTimestamp 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | ------- Summary: start ------- 18:51:51 INFO - PID 4142 | Number of tests: 14 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:3.40 (3.1%) stddev-sans-first:2.19 18:51:51 INFO - PID 4142 | Values: 101.0 109.0 110.0 107.0 112.0 114.0 108.0 108.0 109.0 109.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:21.87 (14.4%) stddev-sans-first:23.05 18:51:51 INFO - PID 4142 | Values: 152.0 122.0 142.0 180.0 127.0 154.0 152.0 122.0 177.0 123.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:4.88 (2.9%) stddev-sans-first:5.05 18:51:51 INFO - PID 4142 | Values: 164.0 167.0 165.0 162.0 162.0 178.0 165.0 170.0 171.0 166.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.00 stddev:31.63 (42.2%) stddev-sans-first:33.33 18:51:51 INFO - PID 4142 | Values: 77.0 74.0 74.0 175.0 76.0 74.0 75.0 75.0 97.0 75.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:82.00 stddev:25.95 (31.6%) stddev-sans-first:26.79 18:51:51 INFO - PID 4142 | Values: 81.0 82.0 138.0 82.0 82.0 83.0 125.0 82.0 82.0 142.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 18:51:51 INFO - PID 4142 | Values: 114.0 115.0 114.0 117.0 117.0 114.0 114.0 115.0 114.0 115.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.32 (0.9%) stddev-sans-first:1.36 18:51:51 INFO - PID 4142 | Values: 150.0 151.0 150.0 150.0 153.0 150.0 151.0 153.0 151.0 149.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:2.91 (3.1%) stddev-sans-first:2.99 18:51:51 INFO - PID 4142 | Values: 94.0 101.0 95.0 98.0 95.0 94.0 101.0 94.0 94.0 94.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.97 (3.5%) stddev-sans-first:2.09 18:51:51 INFO - PID 4142 | Values: 56.0 60.0 54.0 55.0 57.0 58.0 54.0 56.0 54.0 55.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.71 18:51:51 INFO - PID 4142 | Values: 54.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 57.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.50 stddev:2.62 (3.3%) stddev-sans-first:2.76 18:51:51 INFO - PID 4142 | Values: 80.0 78.0 77.0 78.0 78.0 86.0 79.0 78.0 77.0 79.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.50 stddev:7.52 (5.4%) stddev-sans-first:7.91 18:51:51 INFO - PID 4142 | Values: 141.0 136.0 135.0 132.0 143.0 135.0 143.0 136.0 128.0 155.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.30 Median:198.00 stddev:8.15 (4.1%) stddev-sans-first:8.59 18:51:51 INFO - PID 4142 | Values: 198.0 178.0 193.0 187.0 198.0 202.0 193.0 206.0 196.0 202.0 18:51:51 INFO - PID 4142 | 18:51:51 INFO - PID 4142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.89 (2.7%) stddev-sans-first:1.96 18:51:51 INFO - PID 4142 | Values: 72.0 71.0 72.0 71.0 71.0 75.0 71.0 70.0 69.0 68.0 18:51:51 INFO - PID 4142 | -------- Summary: end -------- 18:51:51 INFO - PID 4142 | 18:51:52 INFO - TEST-INFO | 4142: exit 0 18:51:52 INFO - TEST-OK | kraken | took 62717ms 18:51:52 INFO - SUITE-END | took 1182s 18:51:53 INFO - Completed test suite (00:19:42) 18:51:53 INFO - javascript benchmark 18:51:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8067.553003421802, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.5251536011924, 3130.968690313097, 3137.498000319948, 3141.387429451258, 3156.6054243219605, 6053.909191362122, 6069.757209711612, 6096.390360963901, 6122.081687746835, 6137.631742095472, 5910.822675319737, 6078.331383547807, 6086.147939288492, 6112.297085835119, 6141.692915354237, 5625.831225063254, 5651.180578816079, 5680.943190568083, 5697.401772813857, 5722.141678748179, 5595.384507704129, 5704.058830293017, 5708.1437784332265, 5713.885722285552, 5726.685032323241, 5496.0931446311315, 5582.720863956786, 5602.551795856321, 5611.971940140274, 5653.689047102408, 5483.424240454735, 5517.668939863621, 5548.5838562108, 5575.470330318613, 5613.550915926716, 5615.466530679579, 5671.943280567183, 5677.971610141923, 5688.374278829326, 5735.1970724098655, 6090.847728806815, 6105.908411373833, 6145.9692701536205, 6170.475509581691, 6174.44430001302, 6456.741730330781, 6552.180977377828, 6689.163854518185, 6701.865962680719, 6702.4302934250645, 6491.9350806492275, 6527.706253218616, 6538.967305163444, 6583.473322134218, 6590.736370545173, 6089.512838972872, 6136.386361363828, 6143.631382117087, 6151.876962460726, 6172.598781079216, 6703.195616525951, 6707.865842683119, 6743.0, 6758.459323254128, 6806.863862722717, 6205.131281620576, 6317.178766760292, 6319.620822750558, 6324.08300796382, 6337.556371053982, 6472.482201423874, 6536.215654121441, 6605.669716514155, 6666.866662666719, 6682.532222744361, 6645.1361323027695, 6650.068990341356, 6665.0, 6671.766488172891, 6682.465402767767, 6450.322716114834, 6538.542302038812, 6546.672666366758, 6678.766243181465, 6697.531172817953, 5250.894982100336, 5260.631755777059, 5263.894722105613, 5292.814751483679, 5320.068987927175, 4567.0, 4603.447586289667, 4655.11552804966, 4665.066986602693, 4738.549837765407, 5758.798442054508, 5813.79651712188, 5841.036229022164, 5844.590878638454, 5852.0, 6685.826048776625, 6752.93247067523, 6757.290484499155, 6759.628220447923, 6783.525153239325, 5567.66594004361, 5656.2929633795775, 5702.572307076985, 5844.26946631671, 5849.064149736107, 5738.799142030009, 5772.826815195551, 5817.447342502455, 5879.941200588025, 5916.467517923407, 6339.270983836917, 6433.0, 6434.549581529248, 6439.484841212786, 6467.967660161669, 6704.564203326768, 6710.060591517289, 6717.0, 6730.932690673227, 6738.59568425896, 6126.059675755388, 6284.465820405134, 6394.808155755335, 6429.099926010269, 6430.742770289136, 6333.20834895638, 6422.518311126591, 6423.100765892872, 6424.550281480439, 6546.345365463606, 6684.398404143651, 6761.053452516553, 6782.898256526058, 6783.660816959231, 6802.387785099365, 6526.575772574767, 6538.117354157318, 6545.018247262758, 6548.607083575001, 6554.934450655433, 6489.805305840832, 6536.8365790855605, 6542.672866356758, 6562.048502966947, 6564.868702625825, 6180.320164781961, 6246.531510136667, 6256.311805701278, 6328.778492752732, 6453.096566480603, 6523.902141467976, 6575.967120164369, 6580.473562114924, 6591.34086591337, 6599.175103112111, 6377.17096777416, 6378.48972082223, 6400.711967961546, 6403.551751377358, 6405.679716014274], "value": 6032.155740612936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.6855760532193, 829.4525613095358, 861.6381119929629, 884.7964968057347, 887.4763889305309, 38306.616933830686, 39480.80259598705, 39549.0, 39618.8019059905, 39649.20701585967, 36120.0, 36187.457188142136, 36505.634943650555, 36564.634353656525, 36576.0, 6855.4858385621155, 6974.51178417511, 6981.266966968471, 6990.860182796341, 7020.543664661806, 6882.518223724342, 6983.9650801746175, 6987.68555415005, 7005.82485437863, 7029.578225306473, 6893.896591551131, 6958.860822783541, 6977.546459480143, 6981.511294209407, 7725.0, 7817.8827317590285, 7834.804129896741, 7856.921430785676, 7899.210078992112, 7915.4063445241545, 7649.923500764977, 7749.263819937097, 7791.9870416846015, 7811.33603643691, 7817.765467035998, 37908.0, 38139.618603813884, 38147.0, 38176.80911595452, 38248.42627360592, 3446.327966046622, 3451.7756345837693, 3457.4640930655787, 3466.0988143082727, 3480.773749706261, 29497.41005179906, 29516.557251641243, 29723.108306750833, 29734.0, 29897.402051959056, 3735.1595890924596, 3797.1836055247977, 3800.2969450651717, 3818.293615681108, 3882.5535063467782, 189528.0, 189899.0, 190167.0, 191641.0, 192023.0, 48657.0, 49141.75429122832, 49331.0, 49352.0, 49430.50569494331, 50622.74688626533, 50797.74601127044, 51105.0, 51281.0, 51384.0, 14343.211123388313, 14442.205678687564, 14533.128012319296, 14555.708885822225, 14562.344694488773, 11761.764764704658, 11789.705257368634, 11819.290842549475, 11833.763324733458, 11857.644270671894, 14154.575362739135, 14179.220142892034, 14182.14907105577, 14265.0, 14364.497242596668, 5479.0, 5593.07714227148, 5620.5503559715125, 5685.431456854281, 5735.082386818172, 967.8693376394237, 982.7444864335181, 988.6963375335451, 1017.7150397888603, 1023.9078482936422, 22073.889630551745, 23090.251360863127, 23231.419214519436, 23268.88365558195, 23733.406664833517, 1061.2995423020923, 1064.1167830700654, 1091.2143256855052, 1106.5463160104318, 1107.1530279336314, 12653.683657908627, 12956.157849739737, 12976.091673582947, 13031.761982611637, 13051.608451746462, 212983.0, 213631.0, 222092.0, 224020.0, 225015.0, 52338.73830630822, 52388.214176787376, 52808.207876881876, 52852.0, 52901.47098529043, 1437.1879887863533, 1438.611574874778, 1464.2312785787333, 1468.801711768919, 1474.8967572269837, 21446.0, 23248.83755812169, 23483.17808876681, 23518.176863810368, 23835.0, 37381.62618373781, 37662.81168594249, 37695.0, 37702.434463483616, 37723.24553508969, 196962.0, 198166.0, 198813.0, 199797.0, 199803.0, 30201.848990755785, 30407.695923040486, 30492.695073048984, 30498.23754406069, 34551.82724086363, 38611.42082868703, 40477.595224047385, 41310.79344603378, 41840.58159418367, 42927.785361072994, 29298.267543311587, 30315.484225789063, 30765.0, 31152.221194469414, 32226.35547289088, 30076.5488517668, 30078.69921300759, 30563.694363056085, 31618.367632647678, 31794.523082153322, 34167.82916085404, 36615.63384366122, 36724.08189795277, 37585.4362184562, 38324.42513362246, 27192.320191995357, 29079.85460072686, 30255.848720756254, 30480.695193047784, 30566.84716576403, 23437.531249375257, 25436.618450723625, 25661.615075773505, 25834.35414114662, 26169.73830261673], "value": 16573.415106876473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9641223320486, 559.2897020783605, 563.7660370946057, 577.4773829684135, 599.6132494541021, 21786.34640960772, 22820.087196512162, 22873.885630571865, 22901.198458053972, 22909.541809163806, 24251.636225456634, 24806.75193248067, 26086.608700869503, 26124.738752612517, 26408.471830563376, 6238.999999999989, 6257.687115644222, 6372.968135159318, 6381.968090159566, 6382.808515744512, 6335.461485773715, 6360.777372791953, 6370.331115232903, 6416.13382193405, 6425.261094974091, 5948.167256584082, 6225.221847269091, 6344.2386913570435, 6374.266959299694, 6454.838629034265, 6387.457066149383, 6454.160959075337, 6468.191476065515, 6482.67586620667, 6486.3513648635235, 6038.33578306386, 6038.63768173911, 6043.2748070231855, 6043.848903777397, 6048.818535443944, 27593.58609620857, 28714.856425717946, 29031.70968290311, 29198.708012920022, 29317.26706832325, 1919.395390452003, 1962.3229985654925, 1972.2998335590803, 1976.6540855350256, 1977.5945931084236, 17530.47408577745, 17909.7313540297, 17932.55168620782, 17997.910010449996, 18049.187786549635, 2322.6399908014287, 2334.9066037358657, 2367.573836709392, 2408.638704194367, 2425.1390756281617, 121109.39445302806, 123932.0, 124475.0, 124817.0, 125181.37409312987, 13252.885571890598, 14063.507777227747, 14578.781318280235, 14605.92697036508, 14694.706105878036, 22335.888320558617, 22497.88751056267, 22509.774902250767, 22556.436089097577, 22584.0, 8720.8691869622, 8960.910390896008, 8972.19250267479, 9159.496227707406, 9277.443353398683, 7864.331531819745, 7931.920680793233, 7999.400044996649, 8085.878711819328, 8106.47307924983, 8673.6530538779, 8772.605232764541, 8845.646174153091, 9068.0, 9195.862062069074, 2538.3548106964213, 2544.402065514603, 2589.9223023309332, 2783.3320003199087, 2892.0889919675233, 961.4615815143402, 979.299800642544, 985.081369881847, 1011.4335971855784, 1017.0, 18835.434936951915, 19110.044497775056, 19321.710174347398, 19725.605487890163, 19892.10485528155, 973.7176218896441, 988.9208863290919, 1004.7437903334603, 1017.1201910347644, 1027.0653705128448, 10556.841647375295, 10811.459427028618, 10977.28647637901, 11007.724806879893, 11040.558377664964, 454921.0, 477556.0, 480010.0, 483819.0, 488957.0, 105325.47337263265, 105478.47260763648, 106861.0, 111321.0, 113519.43240283911, 1180.2092597959388, 1222.6515443098851, 1224.0758227538329, 1229.4283158331418, 1237.7338872142532, 19306.0, 19474.415767526996, 20205.0, 21202.257920972694, 21854.344369668936, 51691.483085168664, 52247.47752522426, 54270.72864635652, 54956.17565736597, 57508.42491575031, 66615.0, 66715.0, 67310.0, 68060.0, 68812.3118768826, 12527.498900043896, 12687.873121269038, 12917.677058073623, 12990.935045325092, 13029.283389413673, 15823.841761582236, 18787.90606046961, 18827.529311767314, 18898.905505472383, 19061.523461913563, 14451.638709032359, 14505.274736262934, 14852.331645076214, 14894.106353618818, 15659.0, 13339.0, 13402.0, 14269.500567480089, 14411.92794036065, 14667.413303467742, 15956.521304360887, 15966.28151733198, 16155.515334539983, 16168.595785105466, 16223.351065957702, 12709.110362274921, 12776.36118194068, 12793.744125117259, 12834.0, 12981.675458113623, 15275.694486110438, 15285.6178595536, 15884.761728574313, 15891.364345426517, 15926.761098583298], "value": 11306.11645149653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.5379263465152, 1336.886364659004, 1347.7304539092183, 1361.897857660675, 1370.9520166794157, 12998.54505092322, 13506.729865402685, 13609.931950340235, 13670.0, 13754.931225343871, 13474.461021559126, 13879.583612491617, 13895.374708138133, 13948.372323245452, 13978.650533736662, 2320.9187678431217, 2341.7072865891764, 2352.188494969233, 2369.92890213293, 2374.8456350337174, 2229.15292188968, 2314.8032417244553, 2346.378209774411, 2347.58917189492, 2350.0, 2047.3243829536218, 2067.059487932994, 2081.2507497301035, 2176.227439259056, 2211.3808133722505, 2106.968395474069, 2131.296672098204, 2143.6355819510723, 2143.8284937205062, 2144.0, 2176.216562037665, 2225.643896976476, 2231.5871563760593, 2236.1726161320416, 2236.563870045342, 12881.162724422977, 13316.933415332958, 13325.800112998313, 13345.199288042748, 13374.933125334408, 7187.245339239357, 7516.135644400854, 7517.436192285546, 7523.473356865022, 7525.247475252486, 4138.255114079465, 4184.309588917825, 4244.384564238168, 4274.166537525184, 4316.072044510445, 1492.656688961534, 1578.968420631581, 1591.108978971768, 1597.8162511311232, 1609.0265389439455, 20770.06534705942, 20925.26761563338, 20936.895315523478, 20942.79057209439, 20957.0, 5863.237779088691, 6024.728887200086, 6179.62922224668, 6214.844628884314, 6237.407446292595, 14511.201883896276, 14935.477258295907, 14939.178345190901, 14973.326200321011, 15006.249687515581, 6958.199807022156, 7167.319104685151, 7199.1361036675935, 7217.603031833194, 7239.855202895913, 6520.315366886503, 6628.867422651617, 6671.933280667228, 6754.121964144728, 6770.898436523456, 4390.385346051556, 4497.123061003073, 4575.611073058761, 4577.427821522309, 4614.492405835355, 1390.986090139106, 1435.181946290625, 1442.9422823087168, 1460.291758497128, 1463.8755705764916, 849.961751721174, 862.5600943518725, 871.1810897756089, 875.470340444035, 897.7935074932672, 7894.881576776353, 8148.714794982147, 8306.958465207636, 8313.210245026712, 8624.827503449897, 969.1519920069939, 989.7030890732751, 1015.7308313296983, 1019.3170575714289, 1042.468341146021, 4787.688800227974, 4831.202851529529, 5452.6183167177915, 5571.850384045734, 5664.716764161858, 17406.39077632277, 17555.21001554933, 17787.377441789475, 17823.73264401035, 17825.7326140108, 17448.0, 18365.449036528924, 18420.907895460707, 18497.907510462363, 18530.629387412446, 9971.252156088321, 10069.848952265722, 10130.138938190335, 10143.594256229815, 10207.489625518843, 7082.822929426806, 7806.258405451473, 8075.838483230185, 8369.85494514269, 8541.231289184003, 13996.720065598834, 14111.858881411465, 15519.301631426839, 16251.431199907947, 16394.262258198647, 15200.0, 15531.378744850079, 16148.1925903702, 16352.509424717278, 16563.171841407642, 10106.595736170471, 10926.781464370828, 11129.998300153025, 11185.496652650487, 11212.383318917538, 11805.409729513318, 11935.76128477443, 12104.757904841677, 12134.393280336124, 12199.390030498262, 9553.808923821623, 9768.755781105529, 9985.850212246676, 10015.24885633595, 10069.748256293651, 9389.201917837061, 9520.619175232912, 9872.457014863965, 10150.898491014996, 10373.377597344184, 8180.631871565913, 8204.466709663853, 8223.465474744122, 8236.0, 8298.419110662197, 6444.613323200623, 6643.667816609247, 6712.93287067123, 6960.443164546723, 7096.503244773023, 6808.38724514796, 6913.51605387618, 7074.0, 7128.750493732695, 7251.637418129178], "value": 5922.605249994033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.1104495340954, 497.4577710295778, 512.9256257842616, 514.5420575687638, 522.0837430309806, 6263.624182549044, 6325.841853953653, 6328.905066424001, 6348.143000694905, 6362.204724409449, 6017.217761690985, 6141.785037523688, 6163.551565382131, 6218.595791273564, 6265.780697675582, 5025.999999999991, 5061.974690126563, 5071.956825904446, 5075.289459475676, 5133.589312854962, 5019.347484826967, 5035.169197082477, 5035.320231768719, 5116.769745361467, 5127.128388174001, 4967.875803104916, 4978.676386034915, 5001.0, 5002.774875130628, 5025.623078269126, 4780.760961951906, 4942.728149951751, 4952.207646776516, 4960.900781984376, 4971.875703107415, 4429.15845989261, 4492.303692927601, 4504.617107545862, 4518.051209246062, 4521.932171017437, 5975.133605627203, 6014.7594096236535, 6060.696965151725, 6070.332263451061, 6140.109684095781, 5689.345725241567, 5696.401877802812, 5711.571632127566, 5742.770289188469, 5762.855928601818, 6493.545451818374, 6565.967170164118, 6583.80248592543, 6592.241892182413, 6622.8344291393105, 4888.455869494624, 4901.103622620026, 4905.3623029006, 4908.656394052417, 4915.066137433876, 6877.5983370642825, 6932.480063995221, 6986.580805151707, 6999.0, 7003.894941575881, 5083.8983220335385, 5086.491350864884, 5095.847124586268, 5101.158308879068, 5101.438841727407, 5095.617828662791, 5114.846554603293, 5138.2806407103035, 5152.613553983466, 5181.870453238699, 5745.942540574624, 5747.770089196469, 5751.482366587027, 5756.539476841843, 5776.537876969833, 6641.771272314637, 6682.164729408824, 6690.264070952191, 6690.632015239111, 6692.0, 1740.9651806963789, 1762.753214549964, 1771.6456708658063, 1779.661864245789, 1786.0, 1200.783858905388, 1221.8350522679502, 1247.9812802807965, 1258.314218750783, 1260.6470188347278, 5625.268715067015, 5703.17303990919, 5770.88458230833, 5868.2664666916635, 5904.645721256738, 6711.664416779142, 6749.42629876466, 6793.966030169818, 6799.858044715898, 6825.419839313615, 5594.776208951678, 5768.653880767168, 5828.591998560145, 5832.891750567379, 5836.854078648068, 3515.191505953645, 3598.7300952428673, 3599.8580844397543, 3602.7658202217294, 3611.8916432507067, 6483.902741458882, 6487.935120648827, 6520.445762110179, 6523.8695226095215, 6550.312217217219, 6880.827979300458, 6891.483138764513, 6908.205556360982, 6915.239323674392, 6947.409470194989, 6509.641969691617, 6515.869682606416, 6522.706478208492, 6524.0, 6526.869462610816, 6739.59562426256, 6743.7302507901095, 6758.459323254227, 6783.321667833177, 6810.727570897108, 6630.171228596426, 6699.39214588505, 6703.731850725916, 6717.0, 6737.957225664562, 6506.154199953976, 6535.183102112236, 6548.672566371758, 6551.181102362205, 6573.967130164318, 4916.287138364845, 4955.925661115014, 4958.157113290677, 4963.280324352876, 5001.449840517613, 6764.1060503059225, 6777.6272305023695, 6784.388010615849, 6807.455403567604, 6808.9659551701925, 6188.4739797117745, 6556.180842237884, 6574.934250657623, 6586.8353291168105, 6601.0, 6419.523509592726, 6580.242287998001, 6612.305707900601, 6625.852719958174, 6636.800895973129, 6538.607683539003, 6546.345365463416, 6551.4103730664465, 6552.27924928248, 6587.242467116152, 6360.840978975562, 6637.900431493628, 6658.934570468702, 6660.167479065117, 6663.5002374821115, 6116.8776624468155, 6291.087792270187, 6298.811035668938, 6384.3934826191435, 6416.454601358937], "value": 5084.3824762846925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.6150805351349, 789.2383849585149, 811.6063709101085, 852.6035393542002, 866.9349798765093, 17185.48443546694, 17719.202635881386, 17726.113694315263, 17749.46751597451, 17871.55321116973, 17567.73648395275, 18159.364422245224, 18839.905800471013, 19110.904445477754, 19147.808521914776, 1034.2036631793515, 1046.7435478307825, 1047.3611097230682, 1048.7273308939693, 1049.4018409506584, 1050.9054185123337, 1058.62418841311, 1059.4332032362688, 1064.340109132339, 1064.6593090211136, 1031.3090229546222, 1106.8616422947132, 1110.6334909479892, 1119.7816425796973, 1121.159130652011, 1062.5271754069443, 1069.0805906920043, 1073.044989958937, 1082.6589624268408, 1085.1210519479248, 785.6700185921926, 788.6608758233957, 790.4980337485681, 797.9002624671916, 798.9680412783482, 16998.3200671973, 17155.313787448486, 17158.571035724082, 17199.914000430043, 18011.639767204713, 17447.21487533064, 17692.823071769373, 17715.46853594381, 17959.461216163407, 18019.27922883083, 15687.607809804733, 15703.0, 15746.842531574766, 15788.131652759093, 15823.525294241192, 3494.9825250873837, 3545.7517973741847, 3571.7321200910037, 3584.17563960288, 3627.891163265106, 93874.53062734642, 96285.51857240668, 98504.0, 99400.0, 100442.99999999927, 12793.0, 12971.41628626714, 12973.286469244282, 12977.221366718028, 12980.480780768852, 26491.337716557242, 28283.292917676812, 28331.29171770681, 28381.716182837907, 28598.14205573836, 8239.052508961426, 8261.297789687944, 8395.496270223806, 8397.95801020991, 8525.062243153248, 3985.123272879962, 4000.739951903117, 4012.3580227163516, 4024.054347228399, 4033.3546632538655, 4811.0, 4854.514548545188, 4923.08922849274, 4935.481774413706, 4941.827036053793, 869.4479005831216, 915.514777168102, 916.862470629411, 918.0360621347559, 918.4626993208914, 515.7362571313607, 642.2453617000007, 664.8603793203384, 675.9019942108465, 695.2873304862455, 10530.736731581772, 11125.388103654215, 11393.658190254306, 11667.416629168507, 11716.17986740937, 634.3783092569308, 653.1443808610735, 659.8779225843139, 669.8158006548239, 677.8034370032734, 4826.734529600905, 5027.245913113063, 5112.003159383885, 5171.4311425743135, 5245.160774276097, 91602.0, 92305.5384723072, 92643.0, 96545.5172724146, 96906.51546742363, 78953.60523197347, 80737.0, 82644.58677706574, 85029.57485212658, 85856.57071714726, 70507.2949270511, 71253.2874671257, 71652.64173679202, 72603.27396725965, 74460.62769686116, 9567.44202033896, 9760.170385517311, 9842.901570984199, 9961.800763984824, 10050.8492372613, 30725.385492290476, 31154.844225778725, 31620.841895790374, 31930.20174495656, 33525.48558858144, 39223.80388098041, 41366.9658258546, 42249.78875105605, 42288.365674514294, 42308.36537452002, 15024.17367044823, 15127.697446051237, 15156.696866062837, 15241.771373429629, 15541.37834486653, 16481.423150189687, 17114.14429278556, 17129.828701713323, 17133.0, 17259.0, 13920.234387108807, 14085.507007254697, 14216.502422415166, 14224.431022758974, 14378.137311761328, 13479.595612131652, 13758.380872860946, 14074.339953737053, 14125.646858828612, 14429.78355324692, 13192.340382981005, 13308.201507909556, 13328.0, 13440.798388024383, 15514.0, 12018.399080045789, 12436.564720234748, 13284.136531125447, 13711.177329360271, 14352.682677059769, 11902.226355286879, 11984.64046078619, 12235.75528489443, 12381.380930953235, 12515.624531264077], "value": 8099.831396657591, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 110.0, 107.0, 112.0, 114.0, 108.0, 108.0, 109.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 142.0, 180.0, 127.0, 154.0, 152.0, 122.0, 177.0, 123.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 165.0, 162.0, 162.0, 178.0, 165.0, 170.0, 171.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 175.0, 76.0, 74.0, 75.0, 75.0, 97.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 138.0, 82.0, 82.0, 83.0, 125.0, 82.0, 82.0, 142.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 117.0, 117.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 153.0, 150.0, 151.0, 153.0, 151.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 95.0, 98.0, 95.0, 94.0, 101.0, 94.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 54.0, 55.0, 57.0, 58.0, 54.0, 56.0, 54.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 78.0, 78.0, 86.0, 79.0, 78.0, 77.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 135.0, 132.0, 143.0, 135.0, 143.0, 136.0, 128.0, 155.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 178.0, 193.0, 187.0, 198.0, 202.0, 193.0, 206.0, 196.0, 202.0], "value": 195.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 75.0, 71.0, 70.0, 69.0, 68.0], "value": 71.0, "unit": "score"}]}]} 18:51:53 INFO - Return code: 0 18:51:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:53 INFO - # TBPL SUCCESS # 18:51:53 INFO - Running post-action listener: _resource_record_post_action 18:51:53 INFO - [mozharness: 2017-06-17 01:51:53.180225Z] Finished run-tests step (success) 18:51:53 INFO - Running post-run listener: _resource_record_post_run 18:51:53 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8826880; Write bytes: 434348032; Read time: 2920; Write time: 664156 18:51:53 INFO - TinderboxPrint: CPU usage
13.3% 18:51:53 INFO - TinderboxPrint: I/O read bytes / time
8,826,880 / 2,920 18:51:53 INFO - TinderboxPrint: I/O write bytes / time
434,348,032 / 664,156 18:51:53 INFO - TinderboxPrint: CPU idle
8,305.3 (86.7%) 18:51:53 INFO - TinderboxPrint: CPU user
1,210.2 (12.6%) 18:51:53 INFO - TinderboxPrint: Swap in / out
0 / 0 18:51:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 140689408; Read time: 0; Write time: 201188 18:51:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:51:53 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8704000; Write bytes: 247734272; Read time: 2624; Write time: 391300 18:51:53 INFO - Running post-run listener: _upload_blobber_files 18:51:53 INFO - Blob upload gear active. 18:51:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:51:53 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'] 18:51:53 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 18:51:54 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:55 INFO - (blobuploader) - INFO - Done attempting. 18:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:58 INFO - (blobuploader) - INFO - Done attempting. 18:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:59 INFO - (blobuploader) - INFO - Done attempting. 18:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:00 INFO - (blobuploader) - INFO - Done attempting. 18:52:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:00 INFO - Return code: 0 18:52:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f8ba9e05753b403d0a29323761eef7bdfc5462c29fb29aa8099780fd3b0a9c75638214963928e53eb3864dd7d0280804a762781965b47f05694218528faa27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f3727431e87575092639ac07f6519efc7763f22ad03ed898c948a542af3c305da831df887da591ab8527bd1f0fa22402bb8734fd9a617f94d81dfb2964fb67", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f80c89a79d47b118d0d4b1af231d6cb1ce6cd2e421a319691837e337c39dd77901a1cb3aac210d206c72d0b3cbbb9333179e259dccf1074e8560caa2b0722241", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f056156a961a2433f435d7f5d527dd2372ff4d3de603a68821a780a42daf155c72532dc8d7d795b2d7a6fd68d653bf196f2ec8da947a399595465542ce714574"} 18:52:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:00 INFO - Contents: 18:52:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f8ba9e05753b403d0a29323761eef7bdfc5462c29fb29aa8099780fd3b0a9c75638214963928e53eb3864dd7d0280804a762781965b47f05694218528faa27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f3727431e87575092639ac07f6519efc7763f22ad03ed898c948a542af3c305da831df887da591ab8527bd1f0fa22402bb8734fd9a617f94d81dfb2964fb67", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f80c89a79d47b118d0d4b1af231d6cb1ce6cd2e421a319691837e337c39dd77901a1cb3aac210d206c72d0b3cbbb9333179e259dccf1074e8560caa2b0722241", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f056156a961a2433f435d7f5d527dd2372ff4d3de603a68821a780a42daf155c72532dc8d7d795b2d7a6fd68d653bf196f2ec8da947a399595465542ce714574"} 18:52:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:00 INFO - Copying logs to upload dir... 18:52:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.505823 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-06-16 18:52:00.595432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-16 18:52:00.600289) ========= 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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 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/e4f8ba9e05753b403d0a29323761eef7bdfc5462c29fb29aa8099780fd3b0a9c75638214963928e53eb3864dd7d0280804a762781965b47f05694218528faa27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f3727431e87575092639ac07f6519efc7763f22ad03ed898c948a542af3c305da831df887da591ab8527bd1f0fa22402bb8734fd9a617f94d81dfb2964fb67", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f80c89a79d47b118d0d4b1af231d6cb1ce6cd2e421a319691837e337c39dd77901a1cb3aac210d206c72d0b3cbbb9333179e259dccf1074e8560caa2b0722241", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f056156a961a2433f435d7f5d527dd2372ff4d3de603a68821a780a42daf155c72532dc8d7d795b2d7a6fd68d653bf196f2ec8da947a399595465542ce714574"} build_url:https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/IY1VAlt1QuqUoQKcLP3klQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f8ba9e05753b403d0a29323761eef7bdfc5462c29fb29aa8099780fd3b0a9c75638214963928e53eb3864dd7d0280804a762781965b47f05694218528faa27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f3727431e87575092639ac07f6519efc7763f22ad03ed898c948a542af3c305da831df887da591ab8527bd1f0fa22402bb8734fd9a617f94d81dfb2964fb67", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f80c89a79d47b118d0d4b1af231d6cb1ce6cd2e421a319691837e337c39dd77901a1cb3aac210d206c72d0b3cbbb9333179e259dccf1074e8560caa2b0722241", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f056156a961a2433f435d7f5d527dd2372ff4d3de603a68821a780a42daf155c72532dc8d7d795b2d7a6fd68d653bf196f2ec8da947a399595465542ce714574"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-16 18:52:00.627317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:52:00.627622) ========= 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=5c37b704b588aaa989324530000001d0-1497662697.614789-41851528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-16 18:52:00.706681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-16 18:52:00.710030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-16 18:52:00.710327) ========= ========= Total master_lag: 0.22 =========