builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1500138519.52 results: success (0) revision: 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.518836) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.519399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.519720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.575013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.575361) ========= 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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-15 10:08:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.4M=0s 2017-07-15 10:08:40 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.189802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.781089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.781436) ========= 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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.834904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:39.835255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f --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 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f --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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-15 10:08:40,972 truncating revision to first 12 chars 2017-07-15 10:08:40,972 Setting DEBUG logging. 2017-07-15 10:08:40,972 attempt 1/10 2017-07-15 10:08:40,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13a2e506992c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-15 10:08:41,494 unpacking tar archive at: mozilla-central-13a2e506992c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.877146 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:40.733543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:40.733838) ========= script_repo_revision: 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:40.734233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:40.734503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-15 10:08:40.770143) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-15 10:08:40.770466) ========= /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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:42 INFO - MultiFileLogger online at 20170715 10:08:42 in /builds/slave/test 10:08:42 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 10:08:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:42 INFO - {'append_to_log': False, 10:08:42 INFO - 'base_work_dir': '/builds/slave/test', 10:08:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:42 INFO - 'branch': 'Firefox-Non-PGO', 10:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:42 INFO - 'code_coverage': False, 10:08:42 INFO - 'config_files': ('talos/linux_config.py',), 10:08:42 INFO - 'default_actions': ('clobber', 10:08:42 INFO - 'read-buildbot-config', 10:08:42 INFO - 'download-and-extract', 10:08:42 INFO - 'populate-webroot', 10:08:42 INFO - 'create-virtualenv', 10:08:42 INFO - 'install', 10:08:42 INFO - 'setup-mitmproxy', 10:08:42 INFO - 'run-tests'), 10:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:42 INFO - 'disable_ccov_upload': False, 10:08:42 INFO - 'download_minidump_stackwalk': True, 10:08:42 INFO - 'download_symbols': 'ondemand', 10:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:42 INFO - 'gecko_profile': False, 10:08:42 INFO - 'gecko_profile_interval': 0, 10:08:42 INFO - 'installer_path': 'installer.exe', 10:08:42 INFO - 'log_level': 'info', 10:08:42 INFO - 'log_name': 'talos', 10:08:42 INFO - 'log_to_console': True, 10:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:42 INFO - 'opt_config_files': (), 10:08:42 INFO - 'pip_index': False, 10:08:42 INFO - 'suite': 'dromaeojs-e10s', 10:08:42 INFO - 'system_bits': '32', 10:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:42 INFO - 'title': 'talos-linux64-ix-022', 10:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:42 INFO - 'use_talos_json': True, 10:08:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:42 INFO - 'work_dir': 'build'} 10:08:42 INFO - [mozharness: 2017-07-15 17:08:42.029150Z] Running clobber step. 10:08:42 INFO - Running pre-action listener: _resource_record_pre_action 10:08:42 INFO - Running main action method: clobber 10:08:42 INFO - rmtree: /builds/slave/test/build 10:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:43 INFO - Running post-action listener: _resource_record_post_action 10:08:43 INFO - [mozharness: 2017-07-15 17:08:43.093077Z] Finished clobber step (success) 10:08:43 INFO - [mozharness: 2017-07-15 17:08:43.093181Z] Running read-buildbot-config step. 10:08:43 INFO - Running pre-action listener: _resource_record_pre_action 10:08:43 INFO - Running main action method: read_buildbot_config 10:08:43 INFO - Using buildbot properties: 10:08:43 INFO - { 10:08:43 INFO - "project": "", 10:08:43 INFO - "product": "firefox", 10:08:43 INFO - "who": "ffxbld@noreply.mozilla.org", 10:08:43 INFO - "installer_path": "public/build/target.tar.bz2", 10:08:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:08:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:08:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:08:43 INFO - "stage_platform": "linux64", 10:08:43 INFO - "basedir": "/builds/slave/test", 10:08:43 INFO - "buildnumber": 961, 10:08:43 INFO - "platform": "ubuntu64_hw", 10:08:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:08:43 INFO - "slavebuilddir": "test", 10:08:43 INFO - "taskId": "J9GAEI_qSSm7QvbWc4dzPg", 10:08:43 INFO - "branch": "mozilla-central", 10:08:43 INFO - "script_repo_revision": "production", 10:08:43 INFO - "revision": "13a2e506992ccf07c1358d9f22cbf2dfdcb0120f", 10:08:43 INFO - "slavename": "talos-linux64-ix-022", 10:08:43 INFO - "repo_path": "mozilla-central" 10:08:43 INFO - } 10:08:43 INFO - Finding installer, test and symbols from parent task. 10:08:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9GAEI_qSSm7QvbWc4dzPg'}, attempt #1 10:08:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9GAEI_qSSm7QvbWc4dzPg'}, attempt #1 10:08:43 INFO - Task dependencies: DbysrQ7eQNm9u2zfnCk1Rw 10:08:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw'}, attempt #1 10:08:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 10:08:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/test_packages.json 10:08:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.crashreporter-symbols.zip 10:08:44 INFO - Running post-action listener: _resource_record_post_action 10:08:44 INFO - [mozharness: 2017-07-15 17:08:44.439911Z] Finished read-buildbot-config step (success) 10:08:44 INFO - [mozharness: 2017-07-15 17:08:44.440132Z] Running download-and-extract step. 10:08:44 INFO - Running pre-action listener: _resource_record_pre_action 10:08:44 INFO - Running main action method: download_and_extract 10:08:44 INFO - mkdir: /builds/slave/test/build/tests 10:08: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')]} 10:08:44 INFO - trying https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.test_packages.json 10:08:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:08:45 INFO - Downloaded 989 bytes. 10:08:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:08:45 INFO - Using the following test package requirements: 10:08:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:08:45 INFO - u'common': [u'target.common.tests.zip'], 10:08:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:08:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:08:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:08:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:08:45 INFO - u'mozbase': [u'target.common.tests.zip'], 10:08:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:08:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:08:45 INFO - u'web-platform': [u'target.common.tests.zip', 10:08:45 INFO - u'target.web-platform.tests.tar.gz'], 10:08:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:08:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:08:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip 10:08:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:08:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip into memory 10:08:46 INFO - Content-Length response header: 72753026 10:08:46 INFO - Bytes received: 72753026 10:08:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:08:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip 10:08:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:08:58 INFO - Fetch https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.common.tests.zip into memory 10:08:59 INFO - Content-Length response header: 72753026 10:08:59 INFO - Bytes received: 72753026 10:09:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.talos.tests.zip 10:09:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:09:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.talos.tests.zip into memory 10:09:13 INFO - Content-Length response header: 14495033 10:09:13 INFO - Bytes received: 14495033 10:09:14 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')]} 10:09:14 INFO - trying https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 10:09:14 INFO - Downloading https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:09:15 INFO - Downloaded 61880675 bytes. 10:09:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 10:09:15 INFO - mkdir: /builds/slave/test/properties 10:09:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:15 INFO - Contents: 10:09:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 10:09:15 INFO - Running post-action listener: _resource_record_post_action 10:09:15 INFO - Running post-action listener: set_extra_try_arguments 10:09:15 INFO - [mozharness: 2017-07-15 17:09:15.329787Z] Finished download-and-extract step (success) 10:09:15 INFO - [mozharness: 2017-07-15 17:09:15.329885Z] Running populate-webroot step. 10:09:15 INFO - Running pre-action listener: _resource_record_pre_action 10:09:15 INFO - Running main action method: populate_webroot 10:09:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:15 INFO - '--tppagecycles', 10:09:15 INFO - '7'], 10:09:15 INFO - 'tests': ['tsvgm']}}, 10:09:15 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['damp', 'tps']}, 10:09:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'tests': ['damp', 'tps']}, 10:09:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['dromaeo_dom']}, 10:09:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:09:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:09:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:09:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_many_windows', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_many_windows', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_many_windows', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['a11yr', 10:09:15 INFO - 'ts_paint', 10:09:15 INFO - 'tpaint', 10:09:15 INFO - 'sessionrestore', 10:09:15 INFO - 'sessionrestore_no_auto_restore', 10:09:15 INFO - 'tabpaint']}, 10:09:15 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 10:09:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:09:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:09:15 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:09:15 INFO - 'talos_options': ['--mitmproxy', 10:09:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:09:15 INFO - '--firstNonBlankPaint'], 10:09:15 INFO - 'tests': ['quantum_pageload_google', 10:09:15 INFO - 'quantum_pageload_youtube', 10:09:15 INFO - 'quantum_pageload_amazon', 10:09:15 INFO - 'quantum_pageload_facebook']}, 10:09:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['tsvgx', 10:09:15 INFO - 'tsvgr_opacity', 10:09:15 INFO - 'tart', 10:09:15 INFO - 'tscrollx', 10:09:15 INFO - 'cart', 10:09:15 INFO - 'tsvg_static']}, 10:09:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:15 INFO - 'tsvgr_opacity', 10:09:15 INFO - 'tart', 10:09:15 INFO - 'tscrollx', 10:09:15 INFO - 'cart', 10:09:15 INFO - 'tsvg_static']}, 10:09:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'talos_options': ['--disable-e10s'], 10:09:15 INFO - 'tests': ['tp5o']}, 10:09:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:09:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'talos_options': ['--disable-e10s', 10:09:15 INFO - '--xperf_path', 10:09:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:15 INFO - 'tests': ['tp5n']}, 10:09:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:09:15 INFO - 'talos_options': ['--xperf_path', 10:09:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:15 INFO - 'tests': ['tp5n']}}, 10:09:15 INFO - 'talos.zip': {'path': '', 10:09:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:15 INFO - Running post-action listener: _resource_record_post_action 10:09:15 INFO - [mozharness: 2017-07-15 17:09:15.345116Z] Finished populate-webroot step (success) 10:09:15 INFO - [mozharness: 2017-07-15 17:09:15.345206Z] Running create-virtualenv step. 10:09:15 INFO - Running pre-action listener: _resource_record_pre_action 10:09:15 INFO - Running main action method: create_virtualenv 10:09:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:15 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 10:09:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:09:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:15 INFO - Using real prefix '/usr' 10:09:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:15 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:17 INFO - Installing pip.................done. 10:09:17 INFO - Return code: 0 10:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:09:18 INFO - Reading from file tmpfile_stdout 10:09:18 INFO - Output received: 10:09:18 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) 10:09:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:18 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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 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 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:18 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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 INFO - Downloading/unpacking psutil>=3.1.1 10:09:18 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 10:09:18 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 10:09:18 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 10:09:18 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 10:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:19 INFO - Installing collected packages: psutil 10:09:19 INFO - Running setup.py install for psutil 10:09:19 INFO - building 'psutil._psutil_linux' extension 10:09:19 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 10:09:20 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 10:09:20 INFO - building 'psutil._psutil_posix' extension 10:09:20 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 10:09:20 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 10:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:20 INFO - Successfully installed psutil 10:09:20 INFO - Cleaning up... 10:09:20 INFO - Return code: 0 10:09:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:09:20 INFO - Using env: {'DISPLAY': ':0', 10:09:20 INFO - 'HOME': '/home/cltbld', 10:09:20 INFO - 'LANG': 'en_US.UTF-8', 10:09:20 INFO - 'LANGUAGE': 'en_US:en', 10:09:20 INFO - 'LOGNAME': 'cltbld', 10:09:20 INFO - 'MAIL': '/var/mail/cltbld', 10:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:20 INFO - 'MOZ_NO_REMOTE': '1', 10:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:20 INFO - 'NO_EM_RESTART': '1', 10:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:20 INFO - 'PWD': '/builds/slave/test', 10:09:20 INFO - 'SHELL': '/bin/bash', 10:09:20 INFO - 'SHLVL': '1', 10:09:20 INFO - 'TERM': 'linux', 10:09:20 INFO - 'TMOUT': '86400', 10:09:20 INFO - 'USER': 'cltbld', 10:09:20 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:20 INFO - '_': '/tools/buildbot/bin/python'} 10:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:20 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 10:09:20 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 10:09:20 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 10:09:20 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 10:09:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:21 INFO - Installing collected packages: mozsystemmonitor 10:09:21 INFO - Running setup.py install for mozsystemmonitor 10:09:21 INFO - Successfully installed mozsystemmonitor 10:09:21 INFO - Cleaning up... 10:09:21 INFO - Return code: 0 10:09:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:09:21 INFO - Using env: {'DISPLAY': ':0', 10:09:21 INFO - 'HOME': '/home/cltbld', 10:09:21 INFO - 'LANG': 'en_US.UTF-8', 10:09:21 INFO - 'LANGUAGE': 'en_US:en', 10:09:21 INFO - 'LOGNAME': 'cltbld', 10:09:21 INFO - 'MAIL': '/var/mail/cltbld', 10:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:21 INFO - 'MOZ_NO_REMOTE': '1', 10:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:21 INFO - 'NO_EM_RESTART': '1', 10:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:21 INFO - 'PWD': '/builds/slave/test', 10:09:21 INFO - 'SHELL': '/bin/bash', 10:09:21 INFO - 'SHLVL': '1', 10:09:21 INFO - 'TERM': 'linux', 10:09:21 INFO - 'TMOUT': '86400', 10:09:21 INFO - 'USER': 'cltbld', 10:09:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:21 INFO - '_': '/tools/buildbot/bin/python'} 10:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:22 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:23 INFO - warning: no files found matching '*.txt' 10:09:23 INFO - no previously-included directories found matching 'build' 10:09:23 INFO - no previously-included directories found matching 'dist' 10:09:23 INFO - no previously-included directories found matching '.git*' 10:09:23 INFO - Installing collected packages: jsonschema, functools32 10:09:23 INFO - Running setup.py install for functools32 10:09:23 INFO - warning: no files found matching '*.txt' 10:09:23 INFO - no previously-included directories found matching 'build' 10:09:23 INFO - no previously-included directories found matching 'dist' 10:09:23 INFO - no previously-included directories found matching '.git*' 10:09:23 INFO - Successfully installed jsonschema functools32 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:09:23 INFO - Using env: {'DISPLAY': ':0', 10:09:23 INFO - 'HOME': '/home/cltbld', 10:09:23 INFO - 'LANG': 'en_US.UTF-8', 10:09:23 INFO - 'LANGUAGE': 'en_US:en', 10:09:23 INFO - 'LOGNAME': 'cltbld', 10:09:23 INFO - 'MAIL': '/var/mail/cltbld', 10:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:23 INFO - 'MOZ_NO_REMOTE': '1', 10:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:23 INFO - 'NO_EM_RESTART': '1', 10:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:23 INFO - 'PWD': '/builds/slave/test', 10:09:23 INFO - 'SHELL': '/bin/bash', 10:09:23 INFO - 'SHLVL': '1', 10:09:23 INFO - 'TERM': 'linux', 10:09:23 INFO - 'TMOUT': '86400', 10:09:23 INFO - 'USER': 'cltbld', 10:09:23 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:23 INFO - '_': '/tools/buildbot/bin/python'} 10:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:09:23 INFO - Using env: {'DISPLAY': ':0', 10:09:23 INFO - 'HOME': '/home/cltbld', 10:09:23 INFO - 'LANG': 'en_US.UTF-8', 10:09:23 INFO - 'LANGUAGE': 'en_US:en', 10:09:23 INFO - 'LOGNAME': 'cltbld', 10:09:23 INFO - 'MAIL': '/var/mail/cltbld', 10:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:23 INFO - 'MOZ_NO_REMOTE': '1', 10:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:23 INFO - 'NO_EM_RESTART': '1', 10:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:23 INFO - 'PWD': '/builds/slave/test', 10:09:23 INFO - 'SHELL': '/bin/bash', 10:09:23 INFO - 'SHLVL': '1', 10:09:23 INFO - 'TERM': 'linux', 10:09:23 INFO - 'TMOUT': '86400', 10:09:23 INFO - 'USER': 'cltbld', 10:09:23 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:23 INFO - '_': '/tools/buildbot/bin/python'} 10:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:23 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 10:09:23 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 10:09:23 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 10:09:23 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 10:09:24 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:25 INFO - Downloading docopt-0.6.1.tar.gz 10:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:25 INFO - Running setup.py install for blobuploader 10:09:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:25 INFO - Running setup.py install for requests 10:09:26 INFO - Running setup.py install for docopt 10:09:26 INFO - Successfully installed blobuploader requests docopt 10:09:26 INFO - Cleaning up... 10:09:26 INFO - Return code: 0 10:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:26 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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:26 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 10:09:26 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 10:09:26 INFO - Using env: {'DISPLAY': ':0', 10:09:26 INFO - 'HOME': '/home/cltbld', 10:09:26 INFO - 'LANG': 'en_US.UTF-8', 10:09:26 INFO - 'LANGUAGE': 'en_US:en', 10:09:26 INFO - 'LOGNAME': 'cltbld', 10:09:26 INFO - 'MAIL': '/var/mail/cltbld', 10:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:26 INFO - 'MOZ_NO_REMOTE': '1', 10:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:26 INFO - 'NO_EM_RESTART': '1', 10:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:26 INFO - 'PWD': '/builds/slave/test', 10:09:26 INFO - 'SHELL': '/bin/bash', 10:09:26 INFO - 'SHLVL': '1', 10:09:26 INFO - 'TERM': 'linux', 10:09:26 INFO - 'TMOUT': '86400', 10:09:26 INFO - 'USER': 'cltbld', 10:09:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:26 INFO - '_': '/tools/buildbot/bin/python'} 10:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:26 INFO - Running setup.py (path:/tmp/pip-q7HHuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:26 INFO - Running setup.py (path:/tmp/pip-3Oaxn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:26 INFO - Running setup.py (path:/tmp/pip-56NOhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:26 INFO - Running setup.py (path:/tmp/pip-wSV1Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:26 INFO - Running setup.py (path:/tmp/pip-MDnVnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:26 INFO - Running setup.py (path:/tmp/pip-nF0rz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:26 INFO - Running setup.py (path:/tmp/pip-VXpfeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:26 INFO - Running setup.py (path:/tmp/pip-0mX5sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:26 INFO - Running setup.py (path:/tmp/pip-LJ1Cz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:27 INFO - Running setup.py (path:/tmp/pip-E68Uc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:27 INFO - Running setup.py (path:/tmp/pip-qfsP9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:27 INFO - Running setup.py (path:/tmp/pip-3P5QP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:27 INFO - Running setup.py (path:/tmp/pip-WfrUu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:27 INFO - Running setup.py (path:/tmp/pip-pUQcuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:27 INFO - Running setup.py (path:/tmp/pip-i1mzjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:27 INFO - Running setup.py (path:/tmp/pip-YKEJgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:27 INFO - Running setup.py (path:/tmp/pip-9BkHgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:27 INFO - Running setup.py install for manifestparser 10:09:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:27 INFO - Running setup.py install for mozcrash 10:09:27 INFO - Running setup.py install for mozdebug 10:09:27 INFO - Running setup.py install for mozdevice 10:09:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozfile 10:09:28 INFO - Running setup.py install for mozhttpd 10:09:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozinfo 10:09:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozInstall 10:09:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozleak 10:09:28 INFO - Running setup.py install for mozlog 10:09:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for moznetwork 10:09:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozprocess 10:09:28 INFO - Running setup.py install for mozprofile 10:09:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:28 INFO - Running setup.py install for mozrunner 10:09:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:29 INFO - Running setup.py install for mozscreenshot 10:09:29 INFO - Running setup.py install for moztest 10:09:29 INFO - Running setup.py install for mozversion 10:09:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:29 INFO - Cleaning up... 10:09:29 INFO - Return code: 0 10:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:29 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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:29 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 10:09:29 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 10:09:29 INFO - Using env: {'DISPLAY': ':0', 10:09:29 INFO - 'HOME': '/home/cltbld', 10:09:29 INFO - 'LANG': 'en_US.UTF-8', 10:09:29 INFO - 'LANGUAGE': 'en_US:en', 10:09:29 INFO - 'LOGNAME': 'cltbld', 10:09:29 INFO - 'MAIL': '/var/mail/cltbld', 10:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:29 INFO - 'MOZ_NO_REMOTE': '1', 10:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:29 INFO - 'NO_EM_RESTART': '1', 10:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:29 INFO - 'PWD': '/builds/slave/test', 10:09:29 INFO - 'SHELL': '/bin/bash', 10:09:29 INFO - 'SHLVL': '1', 10:09:29 INFO - 'TERM': 'linux', 10:09:29 INFO - 'TMOUT': '86400', 10:09:29 INFO - 'USER': 'cltbld', 10:09:29 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:29 INFO - '_': '/tools/buildbot/bin/python'} 10:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:29 INFO - Running setup.py (path:/tmp/pip-zaCiC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:29 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)) 10:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:29 INFO - Running setup.py (path:/tmp/pip-ICCrZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:29 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)) 10:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:29 INFO - Running setup.py (path:/tmp/pip-WdxoIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:29 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)) 10:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:29 INFO - Running setup.py (path:/tmp/pip-jT2Lf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:29 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)) 10:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:29 INFO - Running setup.py (path:/tmp/pip-7x2MO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:30 INFO - Running setup.py (path:/tmp/pip-GimgR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:30 INFO - Running setup.py (path:/tmp/pip-Rtj2S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:30 INFO - Running setup.py (path:/tmp/pip-t1XKis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:30 INFO - Running setup.py (path:/tmp/pip-iNHiI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:30 INFO - Running setup.py (path:/tmp/pip-urKo6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:30 INFO - Running setup.py (path:/tmp/pip-qPNShN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:30 INFO - Running setup.py (path:/tmp/pip-fwAZ6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:30 INFO - Running setup.py (path:/tmp/pip-MgJC1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:30 INFO - Running setup.py (path:/tmp/pip-z4Hi2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:30 INFO - Running setup.py (path:/tmp/pip-ZrKo9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:30 INFO - Running setup.py (path:/tmp/pip-wBGWlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:30 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)) 10:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:30 INFO - Running setup.py (path:/tmp/pip-4sQcAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:31 INFO - Downloading blessings-1.6.tar.gz 10:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:32 INFO - Installing collected packages: blessings 10:09:32 INFO - Running setup.py install for blessings 10:09:32 INFO - Successfully installed blessings 10:09:32 INFO - Cleaning up... 10:09:32 INFO - Return code: 0 10:09:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:32 INFO - Reading from file tmpfile_stdout 10:09:32 INFO - Current package versions: 10:09:32 INFO - argparse == 1.2.1 10:09:32 INFO - blessings == 1.6 10:09:32 INFO - blobuploader == 1.2.4 10:09:32 INFO - docopt == 0.6.1 10:09:32 INFO - functools32 == 3.2.3-2 10:09:32 INFO - jsonschema == 2.5.1 10:09:32 INFO - manifestparser == 1.1 10:09:32 INFO - mozInstall == 1.13 10:09:32 INFO - mozcrash == 1.0 10:09:32 INFO - mozdebug == 0.1 10:09:32 INFO - mozdevice == 0.51 10:09:32 INFO - mozfile == 1.2 10:09:32 INFO - mozhttpd == 0.7 10:09:32 INFO - mozinfo == 0.10 10:09:32 INFO - mozleak == 0.1 10:09:32 INFO - mozlog == 3.5 10:09:32 INFO - moznetwork == 0.27 10:09:32 INFO - mozprocess == 0.25 10:09:32 INFO - mozprofile == 0.28 10:09:32 INFO - mozrunner == 6.13 10:09:32 INFO - mozscreenshot == 0.1 10:09:32 INFO - mozsystemmonitor == 0.3 10:09:32 INFO - moztest == 0.8 10:09:32 INFO - mozversion == 1.4 10:09:32 INFO - psutil == 3.1.1 10:09:32 INFO - requests == 1.2.3 10:09:32 INFO - wsgiref == 0.1.2 10:09:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:32 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 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09:32 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 10:09:32 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 10:09:32 INFO - Using env: {'DISPLAY': ':0', 10:09:32 INFO - 'HOME': '/home/cltbld', 10:09:32 INFO - 'LANG': 'en_US.UTF-8', 10:09:32 INFO - 'LANGUAGE': 'en_US:en', 10:09:32 INFO - 'LOGNAME': 'cltbld', 10:09:32 INFO - 'MAIL': '/var/mail/cltbld', 10:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:32 INFO - 'MOZ_NO_REMOTE': '1', 10:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:32 INFO - 'NO_EM_RESTART': '1', 10:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:32 INFO - 'PWD': '/builds/slave/test', 10:09:32 INFO - 'SHELL': '/bin/bash', 10:09:32 INFO - 'SHLVL': '1', 10:09:32 INFO - 'TERM': 'linux', 10:09:32 INFO - 'TMOUT': '86400', 10:09:32 INFO - 'USER': 'cltbld', 10:09:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:32 INFO - '_': '/tools/buildbot/bin/python'} 10:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 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)) 10:09:32 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:09:32 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 10:09:32 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 10:09:32 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 10:09:32 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 10:09:33 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:09:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:09:33 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 10:09:33 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 10:09:33 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 10:09:33 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 10:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:09:34 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)) 10:09:34 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)) 10:09:34 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)) 10:09:34 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)) 10:09:34 INFO - Installing collected packages: marionette-driver, simplejson 10:09:34 INFO - Running setup.py install for marionette-driver 10:09:34 INFO - Running setup.py install for simplejson 10:09:34 INFO - building 'simplejson._speedups' extension 10:09:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 10:09:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 10:09:35 INFO - Successfully installed marionette-driver simplejson 10:09:35 INFO - Cleaning up... 10:09:35 INFO - Return code: 0 10:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09: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')]} 10:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c5b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, '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': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', '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 10:09: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', 'jsonschema'] in /builds/slave/test/build 10:09: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 jsonschema 10:09:35 INFO - Using env: {'DISPLAY': ':0', 10:09:35 INFO - 'HOME': '/home/cltbld', 10:09:35 INFO - 'LANG': 'en_US.UTF-8', 10:09:35 INFO - 'LANGUAGE': 'en_US:en', 10:09:35 INFO - 'LOGNAME': 'cltbld', 10:09:35 INFO - 'MAIL': '/var/mail/cltbld', 10:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:35 INFO - 'MOZ_NO_REMOTE': '1', 10:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:35 INFO - 'NO_EM_RESTART': '1', 10:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:35 INFO - 'PWD': '/builds/slave/test', 10:09:35 INFO - 'SHELL': '/bin/bash', 10:09:35 INFO - 'SHLVL': '1', 10:09:35 INFO - 'TERM': 'linux', 10:09:35 INFO - 'TMOUT': '86400', 10:09:35 INFO - 'USER': 'cltbld', 10:09:35 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:35 INFO - '_': '/tools/buildbot/bin/python'} 10:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:35 INFO - Cleaning up... 10:09:35 INFO - Return code: 0 10:09:35 INFO - Running post-action listener: _resource_record_post_action 10:09:35 INFO - Running post-action listener: _start_resource_monitoring 10:09:35 INFO - Starting resource monitoring. 10:09:35 INFO - [mozharness: 2017-07-15 17:09:35.489080Z] Finished create-virtualenv step (success) 10:09:35 INFO - [mozharness: 2017-07-15 17:09:35.489550Z] Running install step. 10:09:35 INFO - Running pre-action listener: _resource_record_pre_action 10:09:35 INFO - Running main action method: install 10:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:35 INFO - Reading from file tmpfile_stdout 10:09:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:35 INFO - Reading from file tmpfile_stdout 10:09:35 INFO - Output received: 10:09:35 INFO - Usage: mozinstall [options] installer 10:09:35 INFO - Options: 10:09:35 INFO - -h, --help show this help message and exit 10:09:35 INFO - -d DEST, --destination=DEST 10:09:35 INFO - Directory to install application into. [default: 10:09:35 INFO - "/builds/slave/test"] 10:09:35 INFO - --app=APP Application being installed. [default: firefox] 10:09:35 INFO - mkdir: /builds/slave/test/build/application 10:09:35 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'] 10:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:09:53 INFO - Reading from file tmpfile_stdout 10:09:53 INFO - Output received: 10:09:53 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:53 INFO - Running post-action listener: _resource_record_post_action 10:09:53 INFO - [mozharness: 2017-07-15 17:09:53.771096Z] Finished install step (success) 10:09:53 INFO - [mozharness: 2017-07-15 17:09:53.771246Z] Running setup-mitmproxy step. 10:09:53 INFO - Running pre-action listener: _resource_record_pre_action 10:09:53 INFO - Running main action method: setup_mitmproxy 10:09:53 INFO - Skipping: mitmproxy is not required 10:09:53 INFO - Running post-action listener: _resource_record_post_action 10:09:53 INFO - [mozharness: 2017-07-15 17:09:53.771998Z] Finished setup-mitmproxy step (success) 10:09:53 INFO - [mozharness: 2017-07-15 17:09:53.772219Z] Running run-tests step. 10:09:53 INFO - Running pre-action listener: _resource_record_pre_action 10:09:53 INFO - Running pre-action listener: _set_gcov_prefix 10:09:53 INFO - Running main action method: run_tests 10:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:53 INFO - Python 2.7.3 10:09:53 INFO - Return code: 0 10:09:53 INFO - grabbing minidump binary from tooltool 10:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:53 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 0x11c2d10>, '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 0x11c3c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c40c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:53 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 10:09:53 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 10:09:53 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 10:09:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:53 INFO - Return code: 0 10:09:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:53 INFO - ENV: RUST_BACKTRACE is now 1 10:09:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:53 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/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:09:53 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/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 10:09:53 INFO - Using env: {'DISPLAY': ':0', 10:09:53 INFO - 'HOME': '/home/cltbld', 10:09:53 INFO - 'LANG': 'en_US.UTF-8', 10:09:53 INFO - 'LANGUAGE': 'en_US:en', 10:09:53 INFO - 'LOGNAME': 'cltbld', 10:09:53 INFO - 'MAIL': '/var/mail/cltbld', 10:09:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:53 INFO - 'MOZ_NO_REMOTE': '1', 10:09:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:53 INFO - 'NO_EM_RESTART': '1', 10:09:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:53 INFO - 'PWD': '/builds/slave/test', 10:09:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:53 INFO - 'RUST_BACKTRACE': '1', 10:09:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:09:53 INFO - 'SHELL': '/bin/bash', 10:09:53 INFO - 'SHLVL': '1', 10:09:53 INFO - 'TERM': 'linux', 10:09:53 INFO - 'TMOUT': '86400', 10:09:53 INFO - 'USER': 'cltbld', 10:09:53 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527', 10:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:53 INFO - '_': '/tools/buildbot/bin/python'} 10:09:53 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/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:09:54 INFO - mozversion application_buildid: 20170715162808 10:09:54 INFO - mozversion application_changeset: 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f 10:09:54 INFO - mozversion application_display_name: Nightly 10:09:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:54 INFO - mozversion application_name: Firefox 10:09:54 INFO - mozversion application_remotingname: firefox 10:09:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:54 INFO - mozversion application_vendor: Mozilla 10:09:54 INFO - mozversion application_version: 56.0a1 10:09:54 INFO - mozversion platform_buildid: 20170715162808 10:09:54 INFO - mozversion platform_changeset: 13a2e506992ccf07c1358d9f22cbf2dfdcb0120f 10:09:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:54 INFO - mozversion platform_version: 56.0a1 10:09:54 INFO - using testdate: 1500138594 10:09:54 INFO - actual date: 1500138594 10:09:54 INFO - starting webserver on 'localhost:57816' 10:09:54 INFO - SUITE-START | Running 2 tests 10:09:54 INFO - TEST-START | dromaeo_css 10:09:54 INFO - Initialising browser for dromaeo_css test... 10:09:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57816/getInfo.html -profile /tmp/tmpqDm1x1/profile 10:09:54 INFO - TEST-INFO | started process 20866 (/builds/slave/test/build/application/firefox/firefox http://localhost:57816/getInfo.html) 10:10:00 INFO - TEST-INFO | 20866: exit 0 10:10:00 INFO - Browser initialized. 10:10:00 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:00 INFO - TEST-INFO | started process 21073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDm1x1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:11 INFO - PID 21073 | RSS: Main: 167383040 10:10:11 INFO - PID 21073 | 10:13:09 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57816/tests/dromaeo/cssquery-ext.html) 10:13:12 INFO - PID 21073 | RSS: Main: 175783936 10:13:12 INFO - PID 21073 | 10:16:13 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-ext.html (next: http://localhost:57816/tests/dromaeo/cssquery-jquery.html) 10:16:14 INFO - PID 21073 | RSS: Main: 173785088 10:16:14 INFO - PID 21073 | 10:19:15 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57816/tests/dromaeo/cssquery-mootools.html) 10:19:16 INFO - PID 21073 | RSS: Main: 175923200 10:19:16 INFO - PID 21073 | 10:22:18 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57816/tests/dromaeo/cssquery-prototype.html) 10:22:18 INFO - PID 21073 | RSS: Main: 174804992 10:22:18 INFO - PID 21073 | 10:25:21 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57816/tests/dromaeo/cssquery-yui.html) 10:25:22 INFO - PID 21073 | RSS: Main: 174272512 10:25:22 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | Cycle 1(1): loaded http://localhost:57816/tests/dromaeo/cssquery-yui.html (next: http://localhost:57816/tests/dromaeo/cssquery-dojo.html) 10:28:24 INFO - PID 21073 | RSS: Main: 177082368 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | __start_tp_report 10:28:24 INFO - PID 21073 | _x_x_mozilla_page_load 10:28:24 INFO - PID 21073 | _x_x_mozilla_page_load_details 10:28:24 INFO - PID 21073 | |i|pagename|runs| 10:28:24 INFO - PID 21073 | |0;dojo.html;3049.5578141169544;3078.5690003399513;3081.399127170201;3091.814491130532;3098.938021239575;6025.668588227646;6048;6083.057126145449;6119.969400152993;6138.877222455548;6086.087086936951;6118.602290851091;6184.041473571592;6225.906611400833;6234.0648902664625;5549.805756798512;5660.150977353389;5706.1726049722765;5713.885722285572;5730.885382292352;5651.632643878155;5669.149627555879;5720.22776925114;5756.424357564231;5756.884862302752;5495;5566.4990150886415;5597;5643.661380317174;5700.543956483492;5531.778728850841;5571.220029195916;5576.804811831607;5591.692456914868;5591.7483713233005;5430.83707488776;5495.093309603911;5504.064309067428;5513.8345849624575;5520.475554822286;5979.1629171915965;6002.8499287517725;6011.0382338825575;6019.187409699678;6019.307779605358;6490.967545162292;6491.383318584727;6533.085368048477;6533.2160140782935;6545.181852268466;6598.868022639568;6616.735330586819;6617.867642647168;6629.834254143637;6643.069970204176;5975.133605627203;6108.450239478469;6127.938720612781;6135.9693201534155;6148.754049838001;6820.863582728318;6822.727090916308;6887.2079710833395;6924.619145947021;6944.201416837027;6422.807315780534;6461.773837915651;6573.967130164318;6576.605403675795;6577.934220657828;6503.317151699098;6551.705173267119;6565.310642382577;6570.474362051024;6594.307597702172;6506.219253689587;6508;6551.21385433751;6556.934430655728;6568.014797780275;5335.733213339317;6585.3085426029575;6671;6680.899786503206;6682.532222744361;5356.330458692663;5369.5167434931045;5448.863778405493;5467.371252306036;5477.507024367826;4589.334546490807;4628.907421851544;4629.259318509023;4647.790849411785;4680.274557443602;5536.529395001389;5619.690916999522;5622.85942851432;5625.184348269478;5629.155626655953;6490.772822951174;6509.7396104155305;6569.704363303663;6596.60420374779;6631.767888123893;5586.636868603528;5633.859153521113;5704.286964129484;5715.599908006399;5716.857078572986;5806.1581070744505;5829.7376618052285;5892.616979896378;5902.586818922634;5935.52515798735;6224.439800417984;6290.245170579468;6322.430981211713;6324.810255692337;6352.237731472253;6560.9343906562235;6562.50781191403;6577;6580.7038683260325;6595.835104122435;6266.530010249158;6325.430711236011;6334.778282760081;6336.112944187726;6349.396807303298;6346.524010699124;6375.139356186855;6387.648679322682;6389.840253993501;6414.422701956846;5688.573356998324;6550.901736474052;6587.077809106633;6603.504737144637;6708.83227919306;6378.840528986812;6450.548461607643;6458.967705161444;6470.676466176578;6470.708818103102;6359.173307470184;6362.395572420613;6450.774222902176;6454.19322584677;6486.5459417842185;6227.50179985591;6297.023961286008;6339.207599050119;6342;6347.5556711029785;6216.849882771521;6309.747610095728;6333.714982825876;6420.454261387647;6513.381228783258;6135.447809697149;6166.383361663798;6221.906671400023;6234.501239900887;6234.594751341148 10:28:24 INFO - PID 21073 | |1;ext.html;747.249014740186;797.1470526536608;832.2094010689846;848.9405741598091;863.9697610583627;42207;42636;42725.57274427255;42877.571224287785;42909.57090429095;38173.80913095431;38346.42480362797;38644.42033369495;38670;38705.806470967604;6791.864162716755;6896.931030689704;6937.098177236952;6949.061876646664;6968.44252459802;6774.085498457719;6919.965400173017;6920.238773734885;6927.653617319139;6945.4096401805655;6867.553609015398;6906.343897329745;6951.860962780741;6961.895571566431;6987.0916780818425;6847.863042739143;6883.380495755381;6891.448684105259;6891.862162756767;6916.2737912519215;6098.237720284965;6140.907886381708;6144.600600960924;6171.59884607499;6201.472874805647;34716.30567388638;34807.4778878317;35011.4748278776;35022.82488587566;35065.824670876485;3432.1934345428804;3471.7222622190416;3484.1986343140966;3582.982085089558;3642.1258897864323;33652;33874.66125338765;34013.14967125817;34072.659273407444;34184.31631367359;4991.401031876162;4995.775190116417;5061.342025536656;5078.162103252959;5114.386273647149;199067;200915;201650.9917450418;207299;208396;43697.56302436935;49228.75385623049;49622.25566616504;49756.253656195186;50210.74894625504;52003.73998129985;52023;52203.73898130561;52207.47792522102;52215;16540.586485337964;16662.83337166637;16749.413770517975;16772.32910683559;16901.492955211364;13624.727505449835;13702.766750992458;13727.45090196381;13776.65558361049;13833.930830345784;13960;14035.578932632037;14109;14278.428862845578;14389.856101439062;5543.750531226105;5609.1305847593685;5623.493885550321;5687.829365119053;5695;1002.6190047781796;1014.2089170447063;1028.4343611013912;1039.7924391383428;1059.184427990443;22480.437989050406;22648.320550383516;22721.545569088525;22998.770012299996;23685.7631423687;1106.5352551928208;1107.983380249297;1129.5651174297955;1135.517405102828;1143.2454579977175;11885.524579016916;12066.336351500577;12078.456469458895;12194.146409751409;12281.69295767613;231864;235716;236380;236702;237116;54775.452245477034;55624;56028.71985640046;56201;56261.437385626436;1443.8050863133342;1492.634304595381;1517.7116347893864;1527.3127092808058;1539.276540026186;22308;22490.887545562167;22736.20423285177;22755.31734047981;23155.768442315362;39009.8049509762;39130.80434597809;39158;39257.2148557033;39292;188668;188723;188794;189008;191577;35443.82278088593;37445.43831842579;38424.23151536898;40213.59786402099;40231.59768402279;46524.53475465202;48395.03209935852;48551.5144848547;48995.77510562265;49411.75294123506;34668.653313466544;34739.30521389507;35136;35313;35545.28909421849;33784.32431351408;34328.82835585906;34890.65109348975;34947;35205.47191792074;38354.80822595869;38463.615363846;38580;38679.2264154721;38845;32463.350732984734;33356.83321583473;33714.49428258529;33801.83099084489;33801.98594042183;23126;23809.880950595136;24232.909519072036;24468.26595202147;24701.25896223116 10:28:24 INFO - PID 21073 | |2;jquery.html;568.2186992884785;576.3458474631298;576.4869266352947;582.921305623741;600.6486205569742;22017.33947981561;23155.768442315573;23248.070077196913;23255.186068487605;23374.88312558437;24166.75833241667;25008.249752507454;25306;26551;26623.334416639595;6627.105340779005;6783;6806.217285012238;6810.693518791666;6814.761483348084;6601.966990165042;6694.464442844585;6711.563748356341;6759.628220447873;6765.492588055891;4079.2453396121664;5187.766550505217;5593.3847276799515;6685.966570167142;6686.364795344434;6677.766278180265;6714.160729908762;6725.428338591226;6728.091707619482;6747.291534388916;6275.341089185616;6291.370862913718;6301.6534090625;6304.369563043705;6315.3684631536935;27766.86116569404;29321;29383;29557.556636650468;29706.405871882656;1871.2702046201991;1913.8660293779442;1916.290972340229;1921.9711704324445;1930.806919308072;18611.534711632183;19238.61522769537;19255.711164332548;19298.4210473686;19322.71015934762;2249.2455884410188;2336.123953517431;2381.142788596104;2393.521295740859;2398.2085911649115;136814;143072;143237.99999999895;143906;144013;14466.421343146156;14515;15068.623284417758;15080.662497312935;15514.146721930176;23458.765412345998;23778.881105594362;23780.286591402284;23885.641715374284;23910.52178956411;10453.268271221094;10651.30766500175;10653.57385704563;10755.032047115641;10955.890441095646;9804;9867;9913.504324783731;9986.500674966223;10028.197744180594;9028.232600229054;9272.907270927204;9388.95305523468;9403.90596094044;9476.573554190078;2607.77833884122;2665.13383150473;2677.196840947708;2733.6172935789004;2761.9723802761714;934.2946075712929;947.5215016416665;959.7408699651055;975.6877799104218;991.2317953585884;19586;19595.11821967986;20298.89850550738;23200.767992320198;24752.5049499009;1025.5590096258532;1061.0874647802884;1065.2383545764815;1071.3625392891217;1072.2065671403261;11120.110391168688;11305.152113591514;11342.69559000709;11401.48693308803;11471.139664525193;496714;496758;519177;521874;524051;119771;121665;123045;125056;126868.36565817296;1285.890699290552;1296.7795474769312;1325.9801102983463;1342.8791408773257;1345.387848528917;17962.5509362267;18081.005544695166;18153.636927261647;18326.633467330314;18455.169517372018;54772.45227547674;55892;57304.42695572991;58073;60883;71346.64326678333;71395.64302178456;71503.64248178726;72051;72574;14549.490767823076;14646.487372941896;14813.629659258604;15070.321835517647;15209.695806084037;23227.187048453223;23410.18064367739;23450.530989379775;23692.4076898072;23804.928778204678;18608.44174674762;18692.532686682942;19070.713939290643;19071.71392429087;19101.617967640846;15996.920015399848;16265;16704.498865034067;16953.406630767862;17810.91094544519;19110.33113841009;19190.328338508087;19346.322878699742;19378.321758738377;19573.314933977243;14872.553823385315;14920.328585213474;14923.179225142721;14930.17884016346;14960.700785984436;18434.354797582022;18754.906225468785;18916.148773304958;18965.33621323247;19228.327008554632 10:28:24 INFO - PID 21073 | |3;mootools.html;1351.50670005448;1394.5816255123473;1400.9719805603888;1406.395250042482;1413.9787903181455;13208.669783255424;13823;13864.237466939314;13877.930610346946;14027;12365.752684946296;12492.750144997095;12534.435950382232;12664.873351266484;12677.429515671794;2540.225231304456;2589.0161738539327;2593.8573378464175;2596.143272720007;2598.597217431301;2514.937126571832;2564.397366618843;2565.9230223093336;2566.6406703061584;2574.4207553300544;2498.900043998238;2541.9872900635564;2547.783438407738;2572.2283315005516;2584.3151564835334;2502.4995000999784;2521.9873900630473;2527.45659683169;2534.518441496128;2535.3154648244963;2440.9511809763703;2441.426264827764;2453.987730061356;2457.3733697907096;2462.4213309872166;12203.20679155852;13258.602241932758;13511.66220844477;13516.594502164853;13558.93220533901;7176.964115179443;7449.404047676173;7459.589722565257;7467.9626601867185;7470.85058298831;4823.324734537167;4954.8761280968265;5005.47442518534;5109.3613298337705;5122.487751224848;1729.0835856995686;1732.5755189978536;1741.5036714536295;1763.3034951194334;1776.7157254839292;20226.08982595772;20839.479013024797;21733.13067477299;21945.341639750834;22009.559808803733;5804.158397032406;5885.911711324334;6147.692615369214;6262.2172228471445;6324.525660575383;15303.770443443358;15328.080315181125;15390.07659540431;15397.307121179574;15413.691726165414;7189.676464559107;7370.189279179286;7393.667284972082;7404.703811847574;7431.256874312634;6825.965870170618;6871.5189936703955;6970.128733908262;6975.3024697530855;7044.295570442915;4777.378940737682;4921.188003979303;4994.500549944976;5004.474530174352;5031.195008798574;1400.6358346829693;1419.5883193873867;1431.5275958933528;1442.1563385419438;1451.252604908473;874.5452364770412;898.8112496375703;917.3532659475054;918.830016446946;932.5430539035959;7039.296070393022;7089.184743754431;7094.822629434306;8034.879476807852;8080.0707918590115;714.7284032067781;722.8048426924701;733.3656387225119;740.8666440040845;748.988765168523;4558.247889098262;5023.14606516893;5112.872178195575;5138.97430512845;5269.077911365495;18149.27402903869;18429.170687319103;18540.907295463436;18715;18978.905105474383;17998.280068797103;18389.448316550526;18399.816001840078;18576.814231857777;18637.254509819726;10751.08615767653;10757.354558726502;10771.353718776898;10792.136629069499;10830.187735919837;7500.587467689111;7828.178041305809;7904.367650587824;7947.562884041202;7948.324392426708;15516.301766420764;15982.920085399499;16085.678286433971;16162.999999999529;16171.919140404223;15707.851986871865;15929.123898185711;16338.183090845649;16793.41223057187;16903.32386704518;11261.831072533754;11437.656870293904;11467.082633389142;11477.82783258235;11558.422078895854;11911;11971.401429928295;12034.699132521757;12065;12076.75846483083;10203.234757393077;10513.211509136692;10570.577176912837;10944.94527527389;11039.944800275947;10061.798764024532;10226.6420675276;10253.231007674305;10558.894411055791;10756.085732712807;9230.907690923004;9283.953580232055;9318.906810931803;9366.625334986797;9400.15398614128;6664.233613134552;6909.89635155463;6986.825329366807;7055.012298278348;7105.893411598933;6866.662749015761;7080.221175670775;7175.461840362098;7181.605011724405;7184.856302874018 10:28:24 INFO - PID 21073 | |4;prototype.html;485.3520550065662;496.9180085285929;522.3209827224607;528.0600531054722;529.6663102245585;6076.331603523615;6090.695465226743;6102;6107.267127944648;6171.166892469515;5708.942910570893;5982.760689572412;5987.970060149704;6013.969930150354;6080.209572755547;4849.539293767104;4857.319975203465;4866.440359358666;4867.9269810952865;4886.799146559009;4838.854834354975;4841.56425921667;4843.152448321547;4863.343448634424;4884.675703483203;4832.951670483303;4841.540053694894;4850.757462126897;4861.149298872683;4891.581441381995;4678.789454474557;4836.806527738886;4875.9756201219125;4876.634252431047;4895.363602731658;4395.560443955611;4406.2815501954265;4415.763586195871;4430.579094985971;4450.554944505556;5804.388708478611;5857.88284234313;5898.793542226002;5949.107633854913;6001.459868611802;5552.444755524415;5557.944420555824;5582.86042848932;5594.13290939905;5635.126555383922;6345.827086456771;6412.647304398256;6462;6466.935330646727;6498.350164983511;4788.640851936118;4806.327114204014;4811.615070794328;4848.248521479177;4862.489438608931;6634.966825165891;6736.157980252468;6737.831554211135;6814.352636499574;6858.6570671466225;4981.676191047571;4983.775730092155;4992.775325110379;5005.774740136702;5042.470540593258;4999.925001124986;5055.823046193365;5064.985664192496;5068.8341681413485;5106.540411362921;5528.75120619573;5569.554435645138;5586.190002449622;5613.214150019001;5625.240592520039;6335.968320158369;6403.423691867754;6416.133821934072;6465.3857883501;6471.805845824632;1729.1440736835095;1735.4359833054307;1736.1076426694963;1738.9740053368573;1741.9303227870744;1105.5633024955098;1177.9764404711857;1188.3464094748026;1194.3610168559953;1224.9387530623433;5484.643498172606;5556.6943818089585;5587.413321601254;5641.502268593498;5671.829845104653;6434.581752186186;6554.344565543408;6567.34326567349;6618.172728408949;6637.900431493532;5509.531689806331;5602.170903693609;5622.550195984311;5649.774009039593;5697.202391665171;3505.158761897177;3510.947335789965;3519.260955199437;3523.9647603523636;3532.838109891684;6247.5939063960695;6401.231852177769;6478.773242936474;6489.286178520359;6507.934920650733;6698.966505167443;6776.17146312332;6782.491313151533;6857;6859.2454829968665;6387.584806987531;6416.909125448685;6444.935550644527;6463.450606698295;6482;6620;6650.600963942179;6652.73389064432;6669.666066786565;6690.69891854858;6600.702968366339;6603;6630.867382652416;6634.933650663432;6654.767083152066;6304.527160463075;6351.1425957496995;6374.936250637435;6376.489880809431;6402.679866006588;4898;4924.9507504924495;4925.876853078702;4945.2582112683385;4945.727984960861;6567.770128045496;6585.485338372106;6609.32322409425;6673.966630167012;6677.699503522256;6418.743250269937;6427.196600424947;6444.967775161094;6463.515236357198;6494.902576461452;6422.036694495863;6435.806925792233;6442.871142577029;6456.580322279036;6499.28507864144;6247.687615619292;6306.495480361652;6342.809715708536;6366.363363663597;6423.64669943139;5896.970515147397;6364.459020983269;6449.355064493513;6468.514861385321;6477.222733272038;6077.665728384981;6132.386761323832;6156.630602163706;6190.1952746142715;6198.2871969722255 10:28:24 INFO - PID 21073 | |5;yui.html;899.3165194452218;922.8846394200725;936.0218571592685;940.6895724410945;940.9482478463684;17505.124743762808;17646.294148234087;17758.46724598264;17906.64186716265;17996.190171442282;14469.276536173176;15233.695326093472;15267.618309542268;15271.92364038181;17466.737998930028;926.6571368593613;987.3384832162468;989;990.5294984882196;991.6876184002052;1039.8388249821253;1041.250299784154;1045.7699306152633;1050.5010120192885;1052.4527245832162;1068.5298468673798;1076.8815430302661;1081.799867024599;1086.940218287994;1088.3415533602176;1041.6874937518714;1048.0567489259652;1083.7344850511636;1085.489819784704;1091.1707102602;805.6817557064985;807.7778610881995;810.5379933437943;811.5820352518458;812.8658771302728;16511.504654860375;16555.66888662232;16625.4181103662;16648.500544983668;16940.491785246464;16111.355545778155;16883.32466701343;17048.829511704847;17362.13189340528;17450.040247786368;14730.631734206623;15041.849581504155;15148.772768408482;15281.923590382088;15556.144412057332;3312.337532493511;3334.0997930558856;3334.583177102862;3350.64818194091;3351.111955331839;107466;110730;111237.44381278123;111424;112176;12205.45075471606;12469.251844889335;12512.436940337706;12522.499100036079;12533.93733031329;21296.574068518545;25815;26820;26939.461210775673;27190.456190876073;7495.587742674096;7588.119207614143;7685.346745526693;7700.922990770133;7707.768766937001;3764.6235376462137;3821.407681809324;3823;3834.4631751554803;3852.749571277858;4684.859454216379;4790.161721698689;4804.42346918372;4823.204171311764;4843.782029808667;995.8406654935176;1002.2683441088046;1003.2174903575223;1008.6368907193405;1010.7271036820017;654.6235914349268;673.865226954611;685.530411668009;687.5118665747275;707.0878566648965;11269.38018408979;11442;12114.033246368946;12267;12967.85447296287;653.8463461086641;689.4036658290543;690.9481788865855;695.6382681005848;715.8282012317006;4943.28322393251;5125.69245845243;5175.663581867167;5211.843644690665;5241.868953276198;99476;101301.98698013074;101311;101545.49227253816;104401.47799260955;83479;86006.56996714976;87221.56389218013;89266;91286.54356728174;75261;78252.60873695595;78632.38468302813;78890.15905552234;78912.60543697244;11299.491522881326;11406;11740.765184696087;11758.529658813552;11950.760984780429;32218.677813222504;34739.826300868335;34918.47622285617;35179.94460166199;36191.27617447689;41392;43514;65209.673951629935;65531.67234163799;66405.66797165983;16091.114988675736;16303.836961630232;16729.581760456087;16907.492775216764;17346.392876249272;18245.270189192284;18492.260309587466;18593.721094183868;18599.44201673952;18787.34244301443;14845.33196006204;16018;16664.16679166061;17190.054547000036;17280.74078888843;15361.923190383977;15435.073895566302;15990.840091598935;16712.247948842087;16781.496555103367;16616.66766664684;17018.74471882898;17035.7444638333;17240.051797151278;17535.912320438318;12509.374531273217;12535.749285014432;12636.115471917245;12696.74606507883;13182.472701091849;12452.937735311629;12475.500979961063;12858.871411285767;12881.162724422882;12963.546275880299 10:28:24 INFO - PID 21073 | __end_tp_report 10:28:24 INFO - PID 21073 | __start_cc_report 10:28:24 INFO - PID 21073 | _x_x_mozilla_cycle_collect,352 10:28:24 INFO - PID 21073 | __end_cc_report 10:28:24 INFO - PID 21073 | __startTimestamp1500139704426__endTimestamp 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | ------- Summary: start ------- 10:28:24 INFO - PID 21073 | Number of tests: 6 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#0] dojo.html Cycles:165 Average:6031.34 Median:6234.06 stddev:710.43 (11.4%) stddev-sans-first:673.00 10:28:24 INFO - PID 21073 | Values: 3049.6 3078.6 3081.4 3091.8 3098.9 6025.7 6048.0 6083.1 6120.0 6138.9 6086.1 6118.6 6184.0 6225.9 6234.1 5549.8 5660.2 5706.2 5713.9 5730.9 5651.6 5669.1 5720.2 5756.4 5756.9 5495.0 5566.5 5597.0 5643.7 5700.5 5531.8 5571.2 5576.8 5591.7 5591.7 5430.8 5495.1 5504.1 5513.8 5520.5 5979.2 6002.8 6011.0 6019.2 6019.3 6491.0 6491.4 6533.1 6533.2 6545.2 6598.9 6616.7 6617.9 6629.8 6643.1 5975.1 6108.5 6127.9 6136.0 6148.8 6820.9 6822.7 6887.2 6924.6 6944.2 6422.8 6461.8 6574.0 6576.6 6577.9 6503.3 6551.7 6565.3 6570.5 6594.3 6506.2 6508.0 6551.2 6556.9 6568.0 5335.7 6585.3 6671.0 6680.9 6682.5 5356.3 5369.5 5448.9 5467.4 5477.5 4589.3 4628.9 4629.3 4647.8 4680.3 5536.5 5619.7 5622.9 5625.2 5629.2 6490.8 6509.7 6569.7 6596.6 6631.8 5586.6 5633.9 5704.3 5715.6 5716.9 5806.2 5829.7 5892.6 5902.6 5935.5 6224.4 6290.2 6322.4 6324.8 6352.2 6560.9 6562.5 6577.0 6580.7 6595.8 6266.5 6325.4 6334.8 6336.1 6349.4 6346.5 6375.1 6387.6 6389.8 6414.4 5688.6 6550.9 6587.1 6603.5 6708.8 6378.8 6450.5 6459.0 6470.7 6470.7 6359.2 6362.4 6450.8 6454.2 6486.5 6227.5 6297.0 6339.2 6342.0 6347.6 6216.8 6309.7 6333.7 6420.5 6513.4 6135.4 6166.4 6221.9 6234.5 6234.6 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#1] ext.html Cycles:180 Average:38369.62 Median:35259.24 stddev:54605.43 (154.9%) stddev-sans-first:54685.54 10:28:24 INFO - PID 21073 | Values: 747.2 797.1 832.2 848.9 864.0 42207.0 42636.0 42725.6 42877.6 42909.6 38173.8 38346.4 38644.4 38670.0 38705.8 6791.9 6896.9 6937.1 6949.1 6968.4 6774.1 6920.0 6920.2 6927.7 6945.4 6867.6 6906.3 6951.9 6961.9 6987.1 6847.9 6883.4 6891.4 6891.9 6916.3 6098.2 6140.9 6144.6 6171.6 6201.5 34716.3 34807.5 35011.5 35022.8 35065.8 3432.2 3471.7 3484.2 3583.0 3642.1 33652.0 33874.7 34013.1 34072.7 34184.3 4991.4 4995.8 5061.3 5078.2 5114.4 199067.0 200915.0 201651.0 207299.0 208396.0 43697.6 49228.8 49622.3 49756.3 50210.7 52003.7 52023.0 52203.7 52207.5 52215.0 16540.6 16662.8 16749.4 16772.3 16901.5 13624.7 13702.8 13727.5 13776.7 13833.9 13960.0 14035.6 14109.0 14278.4 14389.9 5543.8 5609.1 5623.5 5687.8 5695.0 1002.6 1014.2 1028.4 1039.8 1059.2 22480.4 22648.3 22721.5 22998.8 23685.8 1106.5 1108.0 1129.6 1135.5 1143.2 11885.5 12066.3 12078.5 12194.1 12281.7 231864.0 235716.0 236380.0 236702.0 237116.0 54775.5 55624.0 56028.7 56201.0 56261.4 1443.8 1492.6 1517.7 1527.3 1539.3 22308.0 22490.9 22736.2 22755.3 23155.8 39009.8 39130.8 39158.0 39257.2 39292.0 188668.0 188723.0 188794.0 189008.0 191577.0 35443.8 37445.4 38424.2 40213.6 40231.6 46524.5 48395.0 48551.5 48995.8 49411.8 34668.7 34739.3 35136.0 35313.0 35545.3 33784.3 34328.8 34890.7 34947.0 35205.5 38354.8 38463.6 38580.0 38679.2 38845.0 32463.4 33356.8 33714.5 33801.8 33802.0 23126.0 23809.9 24232.9 24468.3 24701.3 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#2] jquery.html Cycles:180 Average:35915.80 Median:12795.66 stddev:86272.15 (674.2%) stddev-sans-first:86473.34 10:28:24 INFO - PID 21073 | Values: 568.2 576.3 576.5 582.9 600.6 22017.3 23155.8 23248.1 23255.2 23374.9 24166.8 25008.2 25306.0 26551.0 26623.3 6627.1 6783.0 6806.2 6810.7 6814.8 6602.0 6694.5 6711.6 6759.6 6765.5 4079.2 5187.8 5593.4 6686.0 6686.4 6677.8 6714.2 6725.4 6728.1 6747.3 6275.3 6291.4 6301.7 6304.4 6315.4 27766.9 29321.0 29383.0 29557.6 29706.4 1871.3 1913.9 1916.3 1922.0 1930.8 18611.5 19238.6 19255.7 19298.4 19322.7 2249.2 2336.1 2381.1 2393.5 2398.2 136814.0 143072.0 143238.0 143906.0 144013.0 14466.4 14515.0 15068.6 15080.7 15514.1 23458.8 23778.9 23780.3 23885.6 23910.5 10453.3 10651.3 10653.6 10755.0 10955.9 9804.0 9867.0 9913.5 9986.5 10028.2 9028.2 9272.9 9389.0 9403.9 9476.6 2607.8 2665.1 2677.2 2733.6 2762.0 934.3 947.5 959.7 975.7 991.2 19586.0 19595.1 20298.9 23200.8 24752.5 1025.6 1061.1 1065.2 1071.4 1072.2 11120.1 11305.2 11342.7 11401.5 11471.1 496714.0 496758.0 519177.0 521874.0 524051.0 119771.0 121665.0 123045.0 125056.0 126868.4 1285.9 1296.8 1326.0 1342.9 1345.4 17962.6 18081.0 18153.6 18326.6 18455.2 54772.5 55892.0 57304.4 58073.0 60883.0 71346.6 71395.6 71503.6 72051.0 72574.0 14549.5 14646.5 14813.6 15070.3 15209.7 23227.2 23410.2 23450.5 23692.4 23804.9 18608.4 18692.5 19070.7 19071.7 19101.6 15996.9 16265.0 16704.5 16953.4 17810.9 19110.3 19190.3 19346.3 19378.3 19573.3 14872.6 14920.3 14923.2 14930.2 14960.7 18434.4 18754.9 18916.1 18965.3 19228.3 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#3] mootools.html Cycles:180 Average:8362.82 Median:2500.70 stddev:5611.04 (224.4%) stddev-sans-first:5602.05 10:28:24 INFO - PID 21073 | Values: 1351.5 1394.6 1401.0 1406.4 1414.0 13208.7 13823.0 13864.2 13877.9 14027.0 12365.8 12492.8 12534.4 12664.9 12677.4 2540.2 2589.0 2593.9 2596.1 2598.6 2514.9 2564.4 2565.9 2566.6 2574.4 2498.9 2542.0 2547.8 2572.2 2584.3 2502.5 2522.0 2527.5 2534.5 2535.3 2441.0 2441.4 2454.0 2457.4 2462.4 12203.2 13258.6 13511.7 13516.6 13558.9 7177.0 7449.4 7459.6 7468.0 7470.9 4823.3 4954.9 5005.5 5109.4 5122.5 1729.1 1732.6 1741.5 1763.3 1776.7 20226.1 20839.5 21733.1 21945.3 22009.6 5804.2 5885.9 6147.7 6262.2 6324.5 15303.8 15328.1 15390.1 15397.3 15413.7 7189.7 7370.2 7393.7 7404.7 7431.3 6826.0 6871.5 6970.1 6975.3 7044.3 4777.4 4921.2 4994.5 5004.5 5031.2 1400.6 1419.6 1431.5 1442.2 1451.3 874.5 898.8 917.4 918.8 932.5 7039.3 7089.2 7094.8 8034.9 8080.1 714.7 722.8 733.4 740.9 749.0 4558.2 5023.1 5112.9 5139.0 5269.1 18149.3 18429.2 18540.9 18715.0 18978.9 17998.3 18389.4 18399.8 18576.8 18637.3 10751.1 10757.4 10771.4 10792.1 10830.2 7500.6 7828.2 7904.4 7947.6 7948.3 15516.3 15982.9 16085.7 16163.0 16171.9 15707.9 15929.1 16338.2 16793.4 16903.3 11261.8 11437.7 11467.1 11477.8 11558.4 11911.0 11971.4 12034.7 12065.0 12076.8 10203.2 10513.2 10570.6 10944.9 11039.9 10061.8 10226.6 10253.2 10558.9 10756.1 9230.9 9284.0 9318.9 9366.6 9400.2 6664.2 6909.9 6986.8 7055.0 7105.9 6866.7 7080.2 7175.5 7181.6 7184.9 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#4] prototype.html Cycles:180 Average:5409.62 Median:5965.93 stddev:1517.21 (25.4%) stddev-sans-first:1475.76 10:28:24 INFO - PID 21073 | Values: 485.4 496.9 522.3 528.1 529.7 6076.3 6090.7 6102.0 6107.3 6171.2 5708.9 5982.8 5988.0 6014.0 6080.2 4849.5 4857.3 4866.4 4867.9 4886.8 4838.9 4841.6 4843.2 4863.3 4884.7 4833.0 4841.5 4850.8 4861.1 4891.6 4678.8 4836.8 4876.0 4876.6 4895.4 4395.6 4406.3 4415.8 4430.6 4450.6 5804.4 5857.9 5898.8 5949.1 6001.5 5552.4 5557.9 5582.9 5594.1 5635.1 6345.8 6412.6 6462.0 6466.9 6498.4 4788.6 4806.3 4811.6 4848.2 4862.5 6635.0 6736.2 6737.8 6814.4 6858.7 4981.7 4983.8 4992.8 5005.8 5042.5 4999.9 5055.8 5065.0 5068.8 5106.5 5528.8 5569.6 5586.2 5613.2 5625.2 6336.0 6403.4 6416.1 6465.4 6471.8 1729.1 1735.4 1736.1 1739.0 1741.9 1105.6 1178.0 1188.3 1194.4 1224.9 5484.6 5556.7 5587.4 5641.5 5671.8 6434.6 6554.3 6567.3 6618.2 6637.9 5509.5 5602.2 5622.6 5649.8 5697.2 3505.2 3510.9 3519.3 3524.0 3532.8 6247.6 6401.2 6478.8 6489.3 6507.9 6699.0 6776.2 6782.5 6857.0 6859.2 6387.6 6416.9 6444.9 6463.5 6482.0 6620.0 6650.6 6652.7 6669.7 6690.7 6600.7 6603.0 6630.9 6634.9 6654.8 6304.5 6351.1 6374.9 6376.5 6402.7 4898.0 4925.0 4925.9 4945.3 4945.7 6567.8 6585.5 6609.3 6674.0 6677.7 6418.7 6427.2 6445.0 6463.5 6494.9 6422.0 6435.8 6442.9 6456.6 6499.3 6247.7 6306.5 6342.8 6366.4 6423.6 5897.0 6364.5 6449.4 6468.5 6477.2 6077.7 6132.4 6156.6 6190.2 6198.3 10:28:24 INFO - PID 21073 | 10:28:24 INFO - PID 21073 | [#5] yui.html Cycles:180 Average:20992.04 Median:17458.39 stddev:28613.12 (163.9%) stddev-sans-first:28653.61 10:28:24 INFO - PID 21073 | Values: 899.3 922.9 936.0 940.7 940.9 17505.1 17646.3 17758.5 17906.6 17996.2 14469.3 15233.7 15267.6 15271.9 17466.7 926.7 987.3 989.0 990.5 991.7 1039.8 1041.3 1045.8 1050.5 1052.5 1068.5 1076.9 1081.8 1086.9 1088.3 1041.7 1048.1 1083.7 1085.5 1091.2 805.7 807.8 810.5 811.6 812.9 16511.5 16555.7 16625.4 16648.5 16940.5 16111.4 16883.3 17048.8 17362.1 17450.0 14730.6 15041.8 15148.8 15281.9 15556.1 3312.3 3334.1 3334.6 3350.6 3351.1 107466.0 110730.0 111237.4 111424.0 112176.0 12205.5 12469.3 12512.4 12522.5 12533.9 21296.6 25815.0 26820.0 26939.5 27190.5 7495.6 7588.1 7685.3 7700.9 7707.8 3764.6 3821.4 3823.0 3834.5 3852.7 4684.9 4790.2 4804.4 4823.2 4843.8 995.8 1002.3 1003.2 1008.6 1010.7 654.6 673.9 685.5 687.5 707.1 11269.4 11442.0 12114.0 12267.0 12967.9 653.8 689.4 690.9 695.6 715.8 4943.3 5125.7 5175.7 5211.8 5241.9 99476.0 101302.0 101311.0 101545.5 104401.5 83479.0 86006.6 87221.6 89266.0 91286.5 75261.0 78252.6 78632.4 78890.2 78912.6 11299.5 11406.0 11740.8 11758.5 11950.8 32218.7 34739.8 34918.5 35179.9 36191.3 41392.0 43514.0 65209.7 65531.7 66405.7 16091.1 16303.8 16729.6 16907.5 17346.4 18245.3 18492.3 18593.7 18599.4 18787.3 14845.3 16018.0 16664.2 17190.1 17280.7 15361.9 15435.1 15990.8 16712.2 16781.5 16616.7 17018.7 17035.7 17240.1 17535.9 12509.4 12535.7 12636.1 12696.7 13182.5 12452.9 12475.5 12858.9 12881.2 12963.5 10:28:24 INFO - PID 21073 | -------- Summary: end -------- 10:28:24 INFO - PID 21073 | 10:28:25 INFO - TEST-INFO | 21073: exit 0 10:28:25 INFO - TEST-OK | dromaeo_css | took 1110879ms 10:28:25 INFO - TEST-START | kraken 10:28:25 INFO - Initialising browser for kraken test... 10:28:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57816/getInfo.html -profile /tmp/tmpmMHeFY/profile 10:28:25 INFO - TEST-INFO | started process 21481 (/builds/slave/test/build/application/firefox/firefox http://localhost:57816/getInfo.html) 10:28:31 INFO - TEST-INFO | 21481: exit 0 10:28:31 INFO - Browser initialized. 10:28:31 INFO - Running cycle 1/1 for kraken test... 10:28:31 INFO - TEST-INFO | started process 21686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmMHeFY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:42 INFO - PID 21686 | RSS: Main: 167432192 10:28:42 INFO - PID 21686 | 10:28:45 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57816/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:46 INFO - PID 21686 | RSS: Main: 173998080 10:28:46 INFO - PID 21686 | 10:28:48 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57816/tests/kraken/driver.html?testName=audio-dft) 10:28:49 INFO - PID 21686 | RSS: Main: 174555136 10:28:49 INFO - PID 21686 | 10:28:52 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57816/tests/kraken/driver.html?testName=audio-fft) 10:28:53 INFO - PID 21686 | RSS: Main: 168239104 10:28:53 INFO - PID 21686 | 10:28:55 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57816/tests/kraken/driver.html?testName=audio-oscillator) 10:28:55 INFO - PID 21686 | RSS: Main: 169705472 10:28:55 INFO - PID 21686 | 10:28:57 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57816/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:58 INFO - PID 21686 | RSS: Main: 169570304 10:28:58 INFO - PID 21686 | 10:29:01 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57816/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:02 INFO - PID 21686 | RSS: Main: 172552192 10:29:02 INFO - PID 21686 | 10:29:05 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57816/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:06 INFO - PID 21686 | RSS: Main: 174276608 10:29:06 INFO - PID 21686 | 10:29:08 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57816/tests/kraken/driver.html?testName=json-parse-financial) 10:29:09 INFO - PID 21686 | RSS: Main: 173191168 10:29:09 INFO - PID 21686 | 10:29:11 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57816/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:11 INFO - PID 21686 | RSS: Main: 172888064 10:29:11 INFO - PID 21686 | 10:29:13 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:14 INFO - PID 21686 | RSS: Main: 173219840 10:29:14 INFO - PID 21686 | 10:29:16 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:16 INFO - PID 21686 | RSS: Main: 173158400 10:29:16 INFO - PID 21686 | 10:29:19 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:20 INFO - PID 21686 | RSS: Main: 173154304 10:29:20 INFO - PID 21686 | 10:29:23 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:23 INFO - PID 21686 | RSS: Main: 173539328 10:29:23 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | Cycle 1(1): loaded http://localhost:57816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57816/tests/kraken/driver.html?testName=ai-astar) 10:29:25 INFO - PID 21686 | RSS: Main: 174424064 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | __start_tp_report 10:29:25 INFO - PID 21686 | _x_x_mozilla_page_load 10:29:25 INFO - PID 21686 | _x_x_mozilla_page_load_details 10:29:25 INFO - PID 21686 | |i|pagename|runs| 10:29:25 INFO - PID 21686 | |0;ai-astar;100;109;109;107;108;108;108;109;109;110 10:29:25 INFO - PID 21686 | |1;audio-beat-detection;152;126;146;177;122;153;144;123;174;126 10:29:25 INFO - PID 21686 | |2;audio-dft;163;163;162;164;163;171;163;166;163;167 10:29:25 INFO - PID 21686 | |3;audio-fft;75;74;77;158;78;75;76;75;94;78 10:29:25 INFO - PID 21686 | |4;audio-oscillator;81;81;136;81;82;82;133;83;81;135 10:29:25 INFO - PID 21686 | |5;imaging-gaussian-blur;114;114;114;114;113;115;115;116;115;114 10:29:25 INFO - PID 21686 | |6;imaging-darkroom;150;150;150;149;150;151;149;149;149;149 10:29:25 INFO - PID 21686 | |7;imaging-desaturate;94;95;94;95;94;94;95;95;95;94 10:29:25 INFO - PID 21686 | |8;json-parse-financial;56;57;54;61;55;56;55;54;55;55 10:29:25 INFO - PID 21686 | |9;json-stringify-tinderbox;53;54;55;54;55;56;54;53;56;55 10:29:25 INFO - PID 21686 | |10;stanford-crypto-aes;78;77;79;79;77;77;77;78;76;77 10:29:25 INFO - PID 21686 | |11;stanford-crypto-ccm;132;129;136;125;129;126;127;125;130;160 10:29:25 INFO - PID 21686 | |12;stanford-crypto-pbkdf2;187;181;187;195;180;178;183;183;188;176 10:29:25 INFO - PID 21686 | |13;stanford-crypto-sha256-iterative;70;78;68;87;70;71;70;68;68;70 10:29:25 INFO - PID 21686 | __end_tp_report 10:29:25 INFO - PID 21686 | __start_cc_report 10:29:25 INFO - PID 21686 | _x_x_mozilla_cycle_collect,930 10:29:25 INFO - PID 21686 | __end_cc_report 10:29:25 INFO - PID 21686 | __startTimestamp1500139765708__endTimestamp 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | ------- Summary: start ------- 10:29:25 INFO - PID 21686 | Number of tests: 14 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:2.83 (2.6%) stddev-sans-first:0.88 10:29:25 INFO - PID 21686 | Values: 100.0 109.0 109.0 107.0 108.0 108.0 108.0 109.0 109.0 110.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.00 stddev:20.30 (13.6%) stddev-sans-first:21.34 10:29:25 INFO - PID 21686 | Values: 152.0 126.0 146.0 177.0 122.0 153.0 144.0 123.0 174.0 126.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:2.76 (1.7%) stddev-sans-first:2.87 10:29:25 INFO - PID 21686 | Values: 163.0 163.0 162.0 164.0 163.0 171.0 163.0 166.0 163.0 167.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#3] audio-fft Cycles:10 Average:86.00 Median:76.50 stddev:25.96 (33.9%) stddev-sans-first:27.22 10:29:25 INFO - PID 21686 | Values: 75.0 74.0 77.0 158.0 78.0 75.0 76.0 75.0 94.0 78.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:81.00 stddev:25.67 (31.7%) stddev-sans-first:26.52 10:29:25 INFO - PID 21686 | Values: 81.0 81.0 136.0 81.0 82.0 82.0 133.0 83.0 81.0 135.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 10:29:25 INFO - PID 21686 | Values: 114.0 114.0 114.0 114.0 113.0 115.0 115.0 116.0 115.0 114.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:29:25 INFO - PID 21686 | Values: 150.0 150.0 150.0 149.0 150.0 151.0 149.0 149.0 149.0 149.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:29:25 INFO - PID 21686 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.04 (3.7%) stddev-sans-first:2.17 10:29:25 INFO - PID 21686 | Values: 56.0 57.0 54.0 61.0 55.0 56.0 55.0 54.0 55.0 55.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.00 10:29:25 INFO - PID 21686 | Values: 53.0 54.0 55.0 54.0 55.0 56.0 54.0 53.0 56.0 55.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:0.97 (1.3%) stddev-sans-first:1.01 10:29:25 INFO - PID 21686 | Values: 78.0 77.0 79.0 79.0 77.0 77.0 77.0 78.0 76.0 77.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:129.50 stddev:10.44 (8.1%) stddev-sans-first:11.07 10:29:25 INFO - PID 21686 | Values: 132.0 129.0 136.0 125.0 129.0 126.0 127.0 125.0 130.0 160.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:185.00 stddev:5.59 (3.0%) stddev-sans-first:5.81 10:29:25 INFO - PID 21686 | Values: 187.0 181.0 187.0 195.0 180.0 178.0 183.0 183.0 188.0 176.0 10:29:25 INFO - PID 21686 | 10:29:25 INFO - PID 21686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:70.00 stddev:6.02 (8.6%) stddev-sans-first:6.34 10:29:25 INFO - PID 21686 | Values: 70.0 78.0 68.0 87.0 70.0 71.0 70.0 68.0 68.0 70.0 10:29:25 INFO - PID 21686 | -------- Summary: end -------- 10:29:25 INFO - PID 21686 | 10:29:26 INFO - PID 21686 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:29:26 INFO - TEST-INFO | 21686: exit 0 10:29:26 INFO - TEST-OK | kraken | took 61462ms 10:29:26 INFO - SUITE-END | took 1172s 10:29:26 INFO - Completed test suite (00:19:32) 10:29:26 INFO - javascript benchmark 10:29:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8261.548709485804, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.5578141169544, 3078.5690003399513, 3081.399127170201, 3091.814491130532, 3098.938021239575, 6025.668588227646, 6048.0, 6083.057126145449, 6119.969400152993, 6138.877222455548, 6086.087086936951, 6118.602290851091, 6184.041473571592, 6225.906611400833, 6234.0648902664625, 5549.805756798512, 5660.150977353389, 5706.1726049722765, 5713.885722285572, 5730.885382292352, 5651.632643878155, 5669.149627555879, 5720.22776925114, 5756.424357564231, 5756.884862302752, 5495.0, 5566.4990150886415, 5597.0, 5643.661380317174, 5700.543956483492, 5531.778728850841, 5571.220029195916, 5576.804811831607, 5591.692456914868, 5591.7483713233005, 5430.83707488776, 5495.093309603911, 5504.064309067428, 5513.8345849624575, 5520.475554822286, 5979.1629171915965, 6002.8499287517725, 6011.0382338825575, 6019.187409699678, 6019.307779605358, 6490.967545162292, 6491.383318584727, 6533.085368048477, 6533.2160140782935, 6545.181852268466, 6598.868022639568, 6616.735330586819, 6617.867642647168, 6629.834254143637, 6643.069970204176, 5975.133605627203, 6108.450239478469, 6127.938720612781, 6135.9693201534155, 6148.754049838001, 6820.863582728318, 6822.727090916308, 6887.2079710833395, 6924.619145947021, 6944.201416837027, 6422.807315780534, 6461.773837915651, 6573.967130164318, 6576.605403675795, 6577.934220657828, 6503.317151699098, 6551.705173267119, 6565.310642382577, 6570.474362051024, 6594.307597702172, 6506.219253689587, 6508.0, 6551.21385433751, 6556.934430655728, 6568.014797780275, 5335.733213339317, 6585.3085426029575, 6671.0, 6680.899786503206, 6682.532222744361, 5356.330458692663, 5369.5167434931045, 5448.863778405493, 5467.371252306036, 5477.507024367826, 4589.334546490807, 4628.907421851544, 4629.259318509023, 4647.790849411785, 4680.274557443602, 5536.529395001389, 5619.690916999522, 5622.85942851432, 5625.184348269478, 5629.155626655953, 6490.772822951174, 6509.7396104155305, 6569.704363303663, 6596.60420374779, 6631.767888123893, 5586.636868603528, 5633.859153521113, 5704.286964129484, 5715.599908006399, 5716.857078572986, 5806.1581070744505, 5829.7376618052285, 5892.616979896378, 5902.586818922634, 5935.52515798735, 6224.439800417984, 6290.245170579468, 6322.430981211713, 6324.810255692337, 6352.237731472253, 6560.9343906562235, 6562.50781191403, 6577.0, 6580.7038683260325, 6595.835104122435, 6266.530010249158, 6325.430711236011, 6334.778282760081, 6336.112944187726, 6349.396807303298, 6346.524010699124, 6375.139356186855, 6387.648679322682, 6389.840253993501, 6414.422701956846, 5688.573356998324, 6550.901736474052, 6587.077809106633, 6603.504737144637, 6708.83227919306, 6378.840528986812, 6450.548461607643, 6458.967705161444, 6470.676466176578, 6470.708818103102, 6359.173307470184, 6362.395572420613, 6450.774222902176, 6454.19322584677, 6486.5459417842185, 6227.50179985591, 6297.023961286008, 6339.207599050119, 6342.0, 6347.5556711029785, 6216.849882771521, 6309.747610095728, 6333.714982825876, 6420.454261387647, 6513.381228783258, 6135.447809697149, 6166.383361663798, 6221.906671400023, 6234.501239900887, 6234.594751341148], "value": 5979.08439770953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.249014740186, 797.1470526536608, 832.2094010689846, 848.9405741598091, 863.9697610583627, 42207.0, 42636.0, 42725.57274427255, 42877.571224287785, 42909.57090429095, 38173.80913095431, 38346.42480362797, 38644.42033369495, 38670.0, 38705.806470967604, 6791.864162716755, 6896.931030689704, 6937.098177236952, 6949.061876646664, 6968.44252459802, 6774.085498457719, 6919.965400173017, 6920.238773734885, 6927.653617319139, 6945.4096401805655, 6867.553609015398, 6906.343897329745, 6951.860962780741, 6961.895571566431, 6987.0916780818425, 6847.863042739143, 6883.380495755381, 6891.448684105259, 6891.862162756767, 6916.2737912519215, 6098.237720284965, 6140.907886381708, 6144.600600960924, 6171.59884607499, 6201.472874805647, 34716.30567388638, 34807.4778878317, 35011.4748278776, 35022.82488587566, 35065.824670876485, 3432.1934345428804, 3471.7222622190416, 3484.1986343140966, 3582.982085089558, 3642.1258897864323, 33652.0, 33874.66125338765, 34013.14967125817, 34072.659273407444, 34184.31631367359, 4991.401031876162, 4995.775190116417, 5061.342025536656, 5078.162103252959, 5114.386273647149, 199067.0, 200915.0, 201650.9917450418, 207299.0, 208396.0, 43697.56302436935, 49228.75385623049, 49622.25566616504, 49756.253656195186, 50210.74894625504, 52003.73998129985, 52023.0, 52203.73898130561, 52207.47792522102, 52215.0, 16540.586485337964, 16662.83337166637, 16749.413770517975, 16772.32910683559, 16901.492955211364, 13624.727505449835, 13702.766750992458, 13727.45090196381, 13776.65558361049, 13833.930830345784, 13960.0, 14035.578932632037, 14109.0, 14278.428862845578, 14389.856101439062, 5543.750531226105, 5609.1305847593685, 5623.493885550321, 5687.829365119053, 5695.0, 1002.6190047781796, 1014.2089170447063, 1028.4343611013912, 1039.7924391383428, 1059.184427990443, 22480.437989050406, 22648.320550383516, 22721.545569088525, 22998.770012299996, 23685.7631423687, 1106.5352551928208, 1107.983380249297, 1129.5651174297955, 1135.517405102828, 1143.2454579977175, 11885.524579016916, 12066.336351500577, 12078.456469458895, 12194.146409751409, 12281.69295767613, 231864.0, 235716.0, 236380.0, 236702.0, 237116.0, 54775.452245477034, 55624.0, 56028.71985640046, 56201.0, 56261.437385626436, 1443.8050863133342, 1492.634304595381, 1517.7116347893864, 1527.3127092808058, 1539.276540026186, 22308.0, 22490.887545562167, 22736.20423285177, 22755.31734047981, 23155.768442315362, 39009.8049509762, 39130.80434597809, 39158.0, 39257.2148557033, 39292.0, 188668.0, 188723.0, 188794.0, 189008.0, 191577.0, 35443.82278088593, 37445.43831842579, 38424.23151536898, 40213.59786402099, 40231.59768402279, 46524.53475465202, 48395.03209935852, 48551.5144848547, 48995.77510562265, 49411.75294123506, 34668.653313466544, 34739.30521389507, 35136.0, 35313.0, 35545.28909421849, 33784.32431351408, 34328.82835585906, 34890.65109348975, 34947.0, 35205.47191792074, 38354.80822595869, 38463.615363846, 38580.0, 38679.2264154721, 38845.0, 32463.350732984734, 33356.83321583473, 33714.49428258529, 33801.83099084489, 33801.98594042183, 23126.0, 23809.880950595136, 24232.909519072036, 24468.26595202147, 24701.25896223116], "value": 17165.022568894074, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2186992884785, 576.3458474631298, 576.4869266352947, 582.921305623741, 600.6486205569742, 22017.33947981561, 23155.768442315573, 23248.070077196913, 23255.186068487605, 23374.88312558437, 24166.75833241667, 25008.249752507454, 25306.0, 26551.0, 26623.334416639595, 6627.105340779005, 6783.0, 6806.217285012238, 6810.693518791666, 6814.761483348084, 6601.966990165042, 6694.464442844585, 6711.563748356341, 6759.628220447873, 6765.492588055891, 4079.2453396121664, 5187.766550505217, 5593.3847276799515, 6685.966570167142, 6686.364795344434, 6677.766278180265, 6714.160729908762, 6725.428338591226, 6728.091707619482, 6747.291534388916, 6275.341089185616, 6291.370862913718, 6301.6534090625, 6304.369563043705, 6315.3684631536935, 27766.86116569404, 29321.0, 29383.0, 29557.556636650468, 29706.405871882656, 1871.2702046201991, 1913.8660293779442, 1916.290972340229, 1921.9711704324445, 1930.806919308072, 18611.534711632183, 19238.61522769537, 19255.711164332548, 19298.4210473686, 19322.71015934762, 2249.2455884410188, 2336.123953517431, 2381.142788596104, 2393.521295740859, 2398.2085911649115, 136814.0, 143072.0, 143237.99999999895, 143906.0, 144013.0, 14466.421343146156, 14515.0, 15068.623284417758, 15080.662497312935, 15514.146721930176, 23458.765412345998, 23778.881105594362, 23780.286591402284, 23885.641715374284, 23910.52178956411, 10453.268271221094, 10651.30766500175, 10653.57385704563, 10755.032047115641, 10955.890441095646, 9804.0, 9867.0, 9913.504324783731, 9986.500674966223, 10028.197744180594, 9028.232600229054, 9272.907270927204, 9388.95305523468, 9403.90596094044, 9476.573554190078, 2607.77833884122, 2665.13383150473, 2677.196840947708, 2733.6172935789004, 2761.9723802761714, 934.2946075712929, 947.5215016416665, 959.7408699651055, 975.6877799104218, 991.2317953585884, 19586.0, 19595.11821967986, 20298.89850550738, 23200.767992320198, 24752.5049499009, 1025.5590096258532, 1061.0874647802884, 1065.2383545764815, 1071.3625392891217, 1072.2065671403261, 11120.110391168688, 11305.152113591514, 11342.69559000709, 11401.48693308803, 11471.139664525193, 496714.0, 496758.0, 519177.0, 521874.0, 524051.0, 119771.0, 121665.0, 123045.0, 125056.0, 126868.36565817296, 1285.890699290552, 1296.7795474769312, 1325.9801102983463, 1342.8791408773257, 1345.387848528917, 17962.5509362267, 18081.005544695166, 18153.636927261647, 18326.633467330314, 18455.169517372018, 54772.45227547674, 55892.0, 57304.42695572991, 58073.0, 60883.0, 71346.64326678333, 71395.64302178456, 71503.64248178726, 72051.0, 72574.0, 14549.490767823076, 14646.487372941896, 14813.629659258604, 15070.321835517647, 15209.695806084037, 23227.187048453223, 23410.18064367739, 23450.530989379775, 23692.4076898072, 23804.928778204678, 18608.44174674762, 18692.532686682942, 19070.713939290643, 19071.71392429087, 19101.617967640846, 15996.920015399848, 16265.0, 16704.498865034067, 16953.406630767862, 17810.91094544519, 19110.33113841009, 19190.328338508087, 19346.322878699742, 19378.321758738377, 19573.314933977243, 14872.553823385315, 14920.328585213474, 14923.179225142721, 14930.17884016346, 14960.700785984436, 18434.354797582022, 18754.906225468785, 18916.148773304958, 18965.33621323247, 19228.327008554632], "value": 12166.159466233172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.50670005448, 1394.5816255123473, 1400.9719805603888, 1406.395250042482, 1413.9787903181455, 13208.669783255424, 13823.0, 13864.237466939314, 13877.930610346946, 14027.0, 12365.752684946296, 12492.750144997095, 12534.435950382232, 12664.873351266484, 12677.429515671794, 2540.225231304456, 2589.0161738539327, 2593.8573378464175, 2596.143272720007, 2598.597217431301, 2514.937126571832, 2564.397366618843, 2565.9230223093336, 2566.6406703061584, 2574.4207553300544, 2498.900043998238, 2541.9872900635564, 2547.783438407738, 2572.2283315005516, 2584.3151564835334, 2502.4995000999784, 2521.9873900630473, 2527.45659683169, 2534.518441496128, 2535.3154648244963, 2440.9511809763703, 2441.426264827764, 2453.987730061356, 2457.3733697907096, 2462.4213309872166, 12203.20679155852, 13258.602241932758, 13511.66220844477, 13516.594502164853, 13558.93220533901, 7176.964115179443, 7449.404047676173, 7459.589722565257, 7467.9626601867185, 7470.85058298831, 4823.324734537167, 4954.8761280968265, 5005.47442518534, 5109.3613298337705, 5122.487751224848, 1729.0835856995686, 1732.5755189978536, 1741.5036714536295, 1763.3034951194334, 1776.7157254839292, 20226.08982595772, 20839.479013024797, 21733.13067477299, 21945.341639750834, 22009.559808803733, 5804.158397032406, 5885.911711324334, 6147.692615369214, 6262.2172228471445, 6324.525660575383, 15303.770443443358, 15328.080315181125, 15390.07659540431, 15397.307121179574, 15413.691726165414, 7189.676464559107, 7370.189279179286, 7393.667284972082, 7404.703811847574, 7431.256874312634, 6825.965870170618, 6871.5189936703955, 6970.128733908262, 6975.3024697530855, 7044.295570442915, 4777.378940737682, 4921.188003979303, 4994.500549944976, 5004.474530174352, 5031.195008798574, 1400.6358346829693, 1419.5883193873867, 1431.5275958933528, 1442.1563385419438, 1451.252604908473, 874.5452364770412, 898.8112496375703, 917.3532659475054, 918.830016446946, 932.5430539035959, 7039.296070393022, 7089.184743754431, 7094.822629434306, 8034.879476807852, 8080.0707918590115, 714.7284032067781, 722.8048426924701, 733.3656387225119, 740.8666440040845, 748.988765168523, 4558.247889098262, 5023.14606516893, 5112.872178195575, 5138.97430512845, 5269.077911365495, 18149.27402903869, 18429.170687319103, 18540.907295463436, 18715.0, 18978.905105474383, 17998.280068797103, 18389.448316550526, 18399.816001840078, 18576.814231857777, 18637.254509819726, 10751.08615767653, 10757.354558726502, 10771.353718776898, 10792.136629069499, 10830.187735919837, 7500.587467689111, 7828.178041305809, 7904.367650587824, 7947.562884041202, 7948.324392426708, 15516.301766420764, 15982.920085399499, 16085.678286433971, 16162.999999999529, 16171.919140404223, 15707.851986871865, 15929.123898185711, 16338.183090845649, 16793.41223057187, 16903.32386704518, 11261.831072533754, 11437.656870293904, 11467.082633389142, 11477.82783258235, 11558.422078895854, 11911.0, 11971.401429928295, 12034.699132521757, 12065.0, 12076.75846483083, 10203.234757393077, 10513.211509136692, 10570.577176912837, 10944.94527527389, 11039.944800275947, 10061.798764024532, 10226.6420675276, 10253.231007674305, 10558.894411055791, 10756.085732712807, 9230.907690923004, 9283.953580232055, 9318.906810931803, 9366.625334986797, 9400.15398614128, 6664.233613134552, 6909.89635155463, 6986.825329366807, 7055.012298278348, 7105.893411598933, 6866.662749015761, 7080.221175670775, 7175.461840362098, 7181.605011724405, 7184.856302874018], "value": 6113.839049383352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.3520550065662, 496.9180085285929, 522.3209827224607, 528.0600531054722, 529.6663102245585, 6076.331603523615, 6090.695465226743, 6102.0, 6107.267127944648, 6171.166892469515, 5708.942910570893, 5982.760689572412, 5987.970060149704, 6013.969930150354, 6080.209572755547, 4849.539293767104, 4857.319975203465, 4866.440359358666, 4867.9269810952865, 4886.799146559009, 4838.854834354975, 4841.56425921667, 4843.152448321547, 4863.343448634424, 4884.675703483203, 4832.951670483303, 4841.540053694894, 4850.757462126897, 4861.149298872683, 4891.581441381995, 4678.789454474557, 4836.806527738886, 4875.9756201219125, 4876.634252431047, 4895.363602731658, 4395.560443955611, 4406.2815501954265, 4415.763586195871, 4430.579094985971, 4450.554944505556, 5804.388708478611, 5857.88284234313, 5898.793542226002, 5949.107633854913, 6001.459868611802, 5552.444755524415, 5557.944420555824, 5582.86042848932, 5594.13290939905, 5635.126555383922, 6345.827086456771, 6412.647304398256, 6462.0, 6466.935330646727, 6498.350164983511, 4788.640851936118, 4806.327114204014, 4811.615070794328, 4848.248521479177, 4862.489438608931, 6634.966825165891, 6736.157980252468, 6737.831554211135, 6814.352636499574, 6858.6570671466225, 4981.676191047571, 4983.775730092155, 4992.775325110379, 5005.774740136702, 5042.470540593258, 4999.925001124986, 5055.823046193365, 5064.985664192496, 5068.8341681413485, 5106.540411362921, 5528.75120619573, 5569.554435645138, 5586.190002449622, 5613.214150019001, 5625.240592520039, 6335.968320158369, 6403.423691867754, 6416.133821934072, 6465.3857883501, 6471.805845824632, 1729.1440736835095, 1735.4359833054307, 1736.1076426694963, 1738.9740053368573, 1741.9303227870744, 1105.5633024955098, 1177.9764404711857, 1188.3464094748026, 1194.3610168559953, 1224.9387530623433, 5484.643498172606, 5556.6943818089585, 5587.413321601254, 5641.502268593498, 5671.829845104653, 6434.581752186186, 6554.344565543408, 6567.34326567349, 6618.172728408949, 6637.900431493532, 5509.531689806331, 5602.170903693609, 5622.550195984311, 5649.774009039593, 5697.202391665171, 3505.158761897177, 3510.947335789965, 3519.260955199437, 3523.9647603523636, 3532.838109891684, 6247.5939063960695, 6401.231852177769, 6478.773242936474, 6489.286178520359, 6507.934920650733, 6698.966505167443, 6776.17146312332, 6782.491313151533, 6857.0, 6859.2454829968665, 6387.584806987531, 6416.909125448685, 6444.935550644527, 6463.450606698295, 6482.0, 6620.0, 6650.600963942179, 6652.73389064432, 6669.666066786565, 6690.69891854858, 6600.702968366339, 6603.0, 6630.867382652416, 6634.933650663432, 6654.767083152066, 6304.527160463075, 6351.1425957496995, 6374.936250637435, 6376.489880809431, 6402.679866006588, 4898.0, 4924.9507504924495, 4925.876853078702, 4945.2582112683385, 4945.727984960861, 6567.770128045496, 6585.485338372106, 6609.32322409425, 6673.966630167012, 6677.699503522256, 6418.743250269937, 6427.196600424947, 6444.967775161094, 6463.515236357198, 6494.902576461452, 6422.036694495863, 6435.806925792233, 6442.871142577029, 6456.580322279036, 6499.28507864144, 6247.687615619292, 6306.495480361652, 6342.809715708536, 6366.363363663597, 6423.64669943139, 5896.970515147397, 6364.459020983269, 6449.355064493513, 6468.514861385321, 6477.222733272038, 6077.665728384981, 6132.386761323832, 6156.630602163706, 6190.1952746142715, 6198.2871969722255], "value": 4964.339523809707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.3165194452218, 922.8846394200725, 936.0218571592685, 940.6895724410945, 940.9482478463684, 17505.124743762808, 17646.294148234087, 17758.46724598264, 17906.64186716265, 17996.190171442282, 14469.276536173176, 15233.695326093472, 15267.618309542268, 15271.92364038181, 17466.737998930028, 926.6571368593613, 987.3384832162468, 989.0, 990.5294984882196, 991.6876184002052, 1039.8388249821253, 1041.250299784154, 1045.7699306152633, 1050.5010120192885, 1052.4527245832162, 1068.5298468673798, 1076.8815430302661, 1081.799867024599, 1086.940218287994, 1088.3415533602176, 1041.6874937518714, 1048.0567489259652, 1083.7344850511636, 1085.489819784704, 1091.1707102602, 805.6817557064985, 807.7778610881995, 810.5379933437943, 811.5820352518458, 812.8658771302728, 16511.504654860375, 16555.66888662232, 16625.4181103662, 16648.500544983668, 16940.491785246464, 16111.355545778155, 16883.32466701343, 17048.829511704847, 17362.13189340528, 17450.040247786368, 14730.631734206623, 15041.849581504155, 15148.772768408482, 15281.923590382088, 15556.144412057332, 3312.337532493511, 3334.0997930558856, 3334.583177102862, 3350.64818194091, 3351.111955331839, 107466.0, 110730.0, 111237.44381278123, 111424.0, 112176.0, 12205.45075471606, 12469.251844889335, 12512.436940337706, 12522.499100036079, 12533.93733031329, 21296.574068518545, 25815.0, 26820.0, 26939.461210775673, 27190.456190876073, 7495.587742674096, 7588.119207614143, 7685.346745526693, 7700.922990770133, 7707.768766937001, 3764.6235376462137, 3821.407681809324, 3823.0, 3834.4631751554803, 3852.749571277858, 4684.859454216379, 4790.161721698689, 4804.42346918372, 4823.204171311764, 4843.782029808667, 995.8406654935176, 1002.2683441088046, 1003.2174903575223, 1008.6368907193405, 1010.7271036820017, 654.6235914349268, 673.865226954611, 685.530411668009, 687.5118665747275, 707.0878566648965, 11269.38018408979, 11442.0, 12114.033246368946, 12267.0, 12967.85447296287, 653.8463461086641, 689.4036658290543, 690.9481788865855, 695.6382681005848, 715.8282012317006, 4943.28322393251, 5125.69245845243, 5175.663581867167, 5211.843644690665, 5241.868953276198, 99476.0, 101301.98698013074, 101311.0, 101545.49227253816, 104401.47799260955, 83479.0, 86006.56996714976, 87221.56389218013, 89266.0, 91286.54356728174, 75261.0, 78252.60873695595, 78632.38468302813, 78890.15905552234, 78912.60543697244, 11299.491522881326, 11406.0, 11740.765184696087, 11758.529658813552, 11950.760984780429, 32218.677813222504, 34739.826300868335, 34918.47622285617, 35179.94460166199, 36191.27617447689, 41392.0, 43514.0, 65209.673951629935, 65531.67234163799, 66405.66797165983, 16091.114988675736, 16303.836961630232, 16729.581760456087, 16907.492775216764, 17346.392876249272, 18245.270189192284, 18492.260309587466, 18593.721094183868, 18599.44201673952, 18787.34244301443, 14845.33196006204, 16018.0, 16664.16679166061, 17190.054547000036, 17280.74078888843, 15361.923190383977, 15435.073895566302, 15990.840091598935, 16712.247948842087, 16781.496555103367, 16616.66766664684, 17018.74471882898, 17035.7444638333, 17240.051797151278, 17535.912320438318, 12509.374531273217, 12535.749285014432, 12636.115471917245, 12696.74606507883, 13182.472701091849, 12452.937735311629, 12475.500979961063, 12858.871411285767, 12881.162724422882, 12963.546275880299], "value": 8389.426229468738, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 109.0, 107.0, 108.0, 108.0, 108.0, 109.0, 109.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 146.0, 177.0, 122.0, 153.0, 144.0, 123.0, 174.0, 126.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 164.0, 163.0, 171.0, 163.0, 166.0, 163.0, 167.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 158.0, 78.0, 75.0, 76.0, 75.0, 94.0, 78.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 136.0, 81.0, 82.0, 82.0, 133.0, 83.0, 81.0, 135.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 115.0, 116.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 149.0, 150.0, 151.0, 149.0, 149.0, 149.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 61.0, 55.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 55.0, 56.0, 54.0, 53.0, 56.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 79.0, 77.0, 77.0, 77.0, 78.0, 76.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 136.0, 125.0, 129.0, 126.0, 127.0, 125.0, 130.0, 160.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 181.0, 187.0, 195.0, 180.0, 178.0, 183.0, 183.0, 188.0, 176.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 68.0, 87.0, 70.0, 71.0, 70.0, 68.0, 68.0, 70.0], "value": 72.0, "unit": "score"}]}]} 10:29:26 INFO - Return code: 0 10:29:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:27 INFO - # TBPL SUCCESS # 10:29:27 INFO - Running post-action listener: _package_coverage_data 10:29:27 INFO - Running post-action listener: _resource_record_post_action 10:29:27 INFO - [mozharness: 2017-07-15 17:29:27.006450Z] Finished run-tests step (success) 10:29:27 INFO - Running post-run listener: _resource_record_post_run 10:29:27 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 435548160; Read time: 40; Write time: 298316 10:29:27 INFO - TinderboxPrint: CPU usage
13.1% 10:29:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 10:29:27 INFO - TinderboxPrint: I/O write bytes / time
435,548,160 / 298,316 10:29:27 INFO - TinderboxPrint: CPU idle
8,253.7 (86.9%) 10:29:27 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 10:29:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107356160; Read time: 4; Write time: 102272 10:29:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:29:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328192000; Read time: 36; Write time: 196044 10:29:27 INFO - Running post-run listener: _upload_blobber_files 10:29:27 INFO - Blob upload gear active. 10:29:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:29:27 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'] 10:29:27 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 10:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:29 INFO - (blobuploader) - INFO - Done attempting. 10:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:33 INFO - (blobuploader) - INFO - Done attempting. 10:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:34 INFO - (blobuploader) - INFO - Done attempting. 10:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:35 INFO - (blobuploader) - INFO - Done attempting. 10:29:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:35 INFO - Return code: 0 10:29:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f558366c7aedd0b87ba476cd8aedeaf1ebfdf422929c941cb50779794ca971fd428812e17ae2944acd454d07f522a940c8ed56ed435d9d7336e6bfcdb57837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d95370127d857d308080746059a67998aea72adb0759daee14b74a327e7aabd2d142f6e642859a0d80f0deb2d82c54c29cdb86c988158c4d5133eba8a49dde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b18faca35f7fbab0a8adc5fabe4a44f32f1f3820cc25b5c998a0aac85a2d1fd81924319f2bdf4c27c3caab0fd7ad8eddaaf79f994759b194ae70c8ae9b860c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6d68911285949f58788577b0587ac916a256046ad2f143abdee923a90915d12f4768147658302342f5de4d8ca410913c6eba63a1406db9328fe2045eb795fa1"} 10:29:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:35 INFO - Contents: 10:29:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f558366c7aedd0b87ba476cd8aedeaf1ebfdf422929c941cb50779794ca971fd428812e17ae2944acd454d07f522a940c8ed56ed435d9d7336e6bfcdb57837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d95370127d857d308080746059a67998aea72adb0759daee14b74a327e7aabd2d142f6e642859a0d80f0deb2d82c54c29cdb86c988158c4d5133eba8a49dde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b18faca35f7fbab0a8adc5fabe4a44f32f1f3820cc25b5c998a0aac85a2d1fd81924319f2bdf4c27c3caab0fd7ad8eddaaf79f994759b194ae70c8ae9b860c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6d68911285949f58788577b0587ac916a256046ad2f143abdee923a90915d12f4768147658302342f5de4d8ca410913c6eba63a1406db9328fe2045eb795fa1"} 10:29:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:35 INFO - Copying logs to upload dir... 10:29:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.441595 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-15 10:29:34.196095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-15 10:29:34.200378) ========= 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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 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/40f558366c7aedd0b87ba476cd8aedeaf1ebfdf422929c941cb50779794ca971fd428812e17ae2944acd454d07f522a940c8ed56ed435d9d7336e6bfcdb57837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d95370127d857d308080746059a67998aea72adb0759daee14b74a327e7aabd2d142f6e642859a0d80f0deb2d82c54c29cdb86c988158c4d5133eba8a49dde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b18faca35f7fbab0a8adc5fabe4a44f32f1f3820cc25b5c998a0aac85a2d1fd81924319f2bdf4c27c3caab0fd7ad8eddaaf79f994759b194ae70c8ae9b860c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6d68911285949f58788577b0587ac916a256046ad2f143abdee923a90915d12f4768147658302342f5de4d8ca410913c6eba63a1406db9328fe2045eb795fa1"} build_url:https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/DbysrQ7eQNm9u2zfnCk1Rw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f558366c7aedd0b87ba476cd8aedeaf1ebfdf422929c941cb50779794ca971fd428812e17ae2944acd454d07f522a940c8ed56ed435d9d7336e6bfcdb57837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d95370127d857d308080746059a67998aea72adb0759daee14b74a327e7aabd2d142f6e642859a0d80f0deb2d82c54c29cdb86c988158c4d5133eba8a49dde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b18faca35f7fbab0a8adc5fabe4a44f32f1f3820cc25b5c998a0aac85a2d1fd81924319f2bdf4c27c3caab0fd7ad8eddaaf79f994759b194ae70c8ae9b860c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6d68911285949f58788577b0587ac916a256046ad2f143abdee923a90915d12f4768147658302342f5de4d8ca410913c6eba63a1406db9328fe2045eb795fa1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-15 10:29:34.227251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:29:34.227573) ========= 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=930c87414c89fc706ee2024c000001c6-1500134607.435360-1108346527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 10:29:34.311976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-15 10:29:34.312286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-15 10:29:34.312596) ========= ========= Total master_lag: 0.15 =========