builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1500687404.82 results: success (0) revision: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.815689) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.816209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.816581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.833918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.834232) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-21 18:36:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-07-21 18:36:45 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170679 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.018349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.018674) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.068795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.069151) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8bb5530a0925ac0823bdb6d525cbc6f304f8928 --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 a8bb5530a0925ac0823bdb6d525cbc6f304f8928 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-21 18:36:45,386 truncating revision to first 12 chars 2017-07-21 18:36:45,386 Setting DEBUG logging. 2017-07-21 18:36:45,386 attempt 1/10 2017-07-21 18:36:45,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8bb5530a092?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-21 18:36:45,911 unpacking tar archive at: mozilla-central-a8bb5530a092/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.951416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.951896) ========= script_repo_revision: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.952381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.952704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.961726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-21 18:36:45.962156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:36:46 INFO - MultiFileLogger online at 20170721 18:36:46 in /builds/slave/test 18:36:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:36:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:36:46 INFO - {'append_to_log': False, 18:36:46 INFO - 'base_work_dir': '/builds/slave/test', 18:36:46 INFO - 'blob_upload_branch': 'Firefox', 18:36:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:36:46 INFO - 'branch': 'Firefox', 18:36:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:36:46 INFO - 'code_coverage': False, 18:36:46 INFO - 'config_files': ('talos/linux_config.py',), 18:36:46 INFO - 'default_actions': ('clobber', 18:36:46 INFO - 'read-buildbot-config', 18:36:46 INFO - 'download-and-extract', 18:36:46 INFO - 'populate-webroot', 18:36:46 INFO - 'create-virtualenv', 18:36:46 INFO - 'install', 18:36:46 INFO - 'setup-mitmproxy', 18:36:46 INFO - 'run-tests'), 18:36:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:36:46 INFO - 'disable_ccov_upload': False, 18:36:46 INFO - 'download_minidump_stackwalk': True, 18:36:46 INFO - 'download_symbols': 'ondemand', 18:36:46 INFO - 'enable_stylo': False, 18:36:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:36:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:36:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:36:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:36:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:36:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:36:46 INFO - 'gecko_profile': False, 18:36:46 INFO - 'gecko_profile_interval': 0, 18:36:46 INFO - 'installer_path': 'installer.exe', 18:36:46 INFO - 'log_level': 'info', 18:36:46 INFO - 'log_name': 'talos', 18:36:46 INFO - 'log_to_console': True, 18:36:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:36:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:36:46 INFO - 'opt_config_files': (), 18:36:46 INFO - 'pip_index': False, 18:36:46 INFO - 'suite': 'dromaeojs-e10s', 18:36:46 INFO - 'system_bits': '32', 18:36:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:36:46 INFO - 'title': 'talos-linux64-ix-036', 18:36:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:36:46 INFO - 'use_talos_json': True, 18:36:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:36:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:36:46 INFO - 'work_dir': 'build'} 18:36:46 INFO - [mozharness: 2017-07-22 01:36:46.386352Z] Running clobber step. 18:36:46 INFO - Running pre-action listener: _resource_record_pre_action 18:36:46 INFO - Running main action method: clobber 18:36:46 INFO - rmtree: /builds/slave/test/build 18:36:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:36:47 INFO - Running post-action listener: _resource_record_post_action 18:36:47 INFO - [mozharness: 2017-07-22 01:36:47.423192Z] Finished clobber step (success) 18:36:47 INFO - [mozharness: 2017-07-22 01:36:47.423296Z] Running read-buildbot-config step. 18:36:47 INFO - Running pre-action listener: _resource_record_pre_action 18:36:47 INFO - Running main action method: read_buildbot_config 18:36:47 INFO - Using buildbot properties: 18:36:47 INFO - { 18:36:47 INFO - "project": "", 18:36:47 INFO - "product": "firefox", 18:36:47 INFO - "who": "kwierso@gmail.com", 18:36:47 INFO - "installer_path": "public/build/target.tar.bz2", 18:36:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:36:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:36:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:36:47 INFO - "stage_platform": "linux64-stylosequential", 18:36:47 INFO - "basedir": "/builds/slave/test", 18:36:47 INFO - "buildnumber": 138, 18:36:47 INFO - "platform": "ubuntu64_hw_styloseq", 18:36:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:36:47 INFO - "slavebuilddir": "test", 18:36:47 INFO - "taskId": "Ox3N6NdCThGYGaLkz1cQ-Q", 18:36:47 INFO - "branch": "mozilla-central", 18:36:47 INFO - "script_repo_revision": "production", 18:36:47 INFO - "revision": "a8bb5530a0925ac0823bdb6d525cbc6f304f8928", 18:36:47 INFO - "slavename": "talos-linux64-ix-036", 18:36:47 INFO - "repo_path": "mozilla-central" 18:36:47 INFO - } 18:36:47 INFO - Finding installer, test and symbols from parent task. 18:36:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ox3N6NdCThGYGaLkz1cQ-Q'}, attempt #1 18:36:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ox3N6NdCThGYGaLkz1cQ-Q'}, attempt #1 18:36:48 INFO - Task dependencies: Y8YpW8kQQ-CotAK7YQIfmQ 18:36:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ'}, attempt #1 18:36:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:36:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/test_packages.json 18:36:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip 18:36:48 INFO - Running post-action listener: _resource_record_post_action 18:36:48 INFO - [mozharness: 2017-07-22 01:36:48.761945Z] Finished read-buildbot-config step (success) 18:36:48 INFO - [mozharness: 2017-07-22 01:36:48.762168Z] Running download-and-extract step. 18:36:48 INFO - Running pre-action listener: _resource_record_pre_action 18:36:48 INFO - Running main action method: download_and_extract 18:36:48 INFO - mkdir: /builds/slave/test/build/tests 18:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:36:48 INFO - trying https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json 18:36:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:36:49 INFO - Downloaded 989 bytes. 18:36:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:36:49 INFO - Using the following test package requirements: 18:36:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:36:49 INFO - u'common': [u'target.common.tests.zip'], 18:36:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:36:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:36:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:36:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:36:49 INFO - u'mozbase': [u'target.common.tests.zip'], 18:36:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:36:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:36:49 INFO - u'web-platform': [u'target.common.tests.zip', 18:36:49 INFO - u'target.web-platform.tests.tar.gz'], 18:36:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:36:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:36:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip 18:36:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:36:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip into memory 18:36:51 INFO - Content-Length response header: 72760468 18:36:51 INFO - Bytes received: 72760468 18:37:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip 18:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip into memory 18:37:03 INFO - Content-Length response header: 72760468 18:37:03 INFO - Bytes received: 72760468 18:37:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip 18:37:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:37:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip into memory 18:37:16 INFO - Content-Length response header: 14498971 18:37:16 INFO - Bytes received: 14498971 18:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:17 INFO - trying https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:37:18 INFO - Downloaded 61946351 bytes. 18:37:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:18 INFO - mkdir: /builds/slave/test/properties 18:37:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:37:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:37:18 INFO - Contents: 18:37:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:18 INFO - Running post-action listener: _resource_record_post_action 18:37:18 INFO - Running post-action listener: set_extra_try_arguments 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.665824Z] Finished download-and-extract step (success) 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.665988Z] Running populate-webroot step. 18:37:18 INFO - Running pre-action listener: _resource_record_pre_action 18:37:18 INFO - Running main action method: populate_webroot 18:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:37:18 INFO - '--tppagecycles', 18:37:18 INFO - '7'], 18:37:18 INFO - 'tests': ['tsvgm']}}, 18:37:18 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:37:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['damp', 'tps']}, 18:37:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['damp', 'tps']}, 18:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['dromaeo_dom']}, 18:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:37:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 18:37:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:37:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:37:18 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:37:18 INFO - 'talos_options': ['--mitmproxy', 18:37:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:37:18 INFO - '--firstNonBlankPaint'], 18:37:18 INFO - 'tests': ['quantum_pageload_google', 18:37:18 INFO - 'quantum_pageload_youtube', 18:37:18 INFO - 'quantum_pageload_amazon', 18:37:18 INFO - 'quantum_pageload_facebook']}, 18:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tsvgx', 18:37:18 INFO - 'tsvgr_opacity', 18:37:18 INFO - 'tart', 18:37:18 INFO - 'tscrollx', 18:37:18 INFO - 'cart', 18:37:18 INFO - 'tsvg_static']}, 18:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:37:18 INFO - 'tsvgr_opacity', 18:37:18 INFO - 'tart', 18:37:18 INFO - 'tscrollx', 18:37:18 INFO - 'cart', 18:37:18 INFO - 'tsvg_static']}, 18:37:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tp5o']}, 18:37:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:37:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s', 18:37:18 INFO - '--xperf_path', 18:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:18 INFO - 'tests': ['tp5n']}, 18:37:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--xperf_path', 18:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:18 INFO - 'tests': ['tp5n']}}, 18:37:18 INFO - 'talos.zip': {'path': '', 18:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:37:18 INFO - Running post-action listener: _resource_record_post_action 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.684457Z] Finished populate-webroot step (success) 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.684548Z] Running create-virtualenv step. 18:37:18 INFO - Running pre-action listener: _resource_record_pre_action 18:37:18 INFO - Running main action method: create_virtualenv 18:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 18:37:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:37:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:37:18 INFO - Using real prefix '/usr' 18:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 18:37:21 INFO - Installing pip.................done. 18:37:21 INFO - Return code: 0 18:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:37:21 INFO - Reading from file tmpfile_stdout 18:37:21 INFO - Output received: 18:37:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37: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', 'pip>=1.5'] in /builds/slave/test/build 18:37: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 pip>=1.5 18:37:21 INFO - Using env: {'DISPLAY': ':0', 18:37:21 INFO - 'HOME': '/home/cltbld', 18:37:21 INFO - 'LANG': 'en_US.UTF-8', 18:37:21 INFO - 'LANGUAGE': 'en_US:en', 18:37:21 INFO - 'LOGNAME': 'cltbld', 18:37:21 INFO - 'MAIL': '/var/mail/cltbld', 18:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:21 INFO - 'MOZ_NO_REMOTE': '1', 18:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:21 INFO - 'NO_EM_RESTART': '1', 18:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:21 INFO - 'PWD': '/builds/slave/test', 18:37:21 INFO - 'SHELL': '/bin/bash', 18:37:21 INFO - 'SHLVL': '1', 18:37:21 INFO - 'TERM': 'linux', 18:37:21 INFO - 'TMOUT': '86400', 18:37:21 INFO - 'USER': 'cltbld', 18:37:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:21 INFO - '_': '/tools/buildbot/bin/python'} 18:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:37:21 INFO - Cleaning up... 18:37:21 INFO - Return code: 0 18:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:37:21 INFO - Using env: {'DISPLAY': ':0', 18:37:21 INFO - 'HOME': '/home/cltbld', 18:37:21 INFO - 'LANG': 'en_US.UTF-8', 18:37:21 INFO - 'LANGUAGE': 'en_US:en', 18:37:21 INFO - 'LOGNAME': 'cltbld', 18:37:21 INFO - 'MAIL': '/var/mail/cltbld', 18:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:21 INFO - 'MOZ_NO_REMOTE': '1', 18:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:21 INFO - 'NO_EM_RESTART': '1', 18:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:21 INFO - 'PWD': '/builds/slave/test', 18:37:21 INFO - 'SHELL': '/bin/bash', 18:37:21 INFO - 'SHLVL': '1', 18:37:21 INFO - 'TERM': 'linux', 18:37:21 INFO - 'TMOUT': '86400', 18:37:21 INFO - 'USER': 'cltbld', 18:37:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:21 INFO - '_': '/tools/buildbot/bin/python'} 18:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:21 INFO - Downloading/unpacking psutil>=3.1.1 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:23 INFO - Installing collected packages: psutil 18:37:23 INFO - Running setup.py install for psutil 18:37:23 INFO - building 'psutil._psutil_linux' extension 18:37:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:37:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:37:23 INFO - building 'psutil._psutil_posix' extension 18:37:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:37:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:23 INFO - Successfully installed psutil 18:37:23 INFO - Cleaning up... 18:37:23 INFO - Return code: 0 18:37:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:37:23 INFO - Using env: {'DISPLAY': ':0', 18:37:23 INFO - 'HOME': '/home/cltbld', 18:37:23 INFO - 'LANG': 'en_US.UTF-8', 18:37:23 INFO - 'LANGUAGE': 'en_US:en', 18:37:23 INFO - 'LOGNAME': 'cltbld', 18:37:23 INFO - 'MAIL': '/var/mail/cltbld', 18:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:23 INFO - 'MOZ_NO_REMOTE': '1', 18:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:23 INFO - 'NO_EM_RESTART': '1', 18:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:23 INFO - 'PWD': '/builds/slave/test', 18:37:23 INFO - 'SHELL': '/bin/bash', 18:37:23 INFO - 'SHLVL': '1', 18:37:23 INFO - 'TERM': 'linux', 18:37:23 INFO - 'TMOUT': '86400', 18:37:23 INFO - 'USER': 'cltbld', 18:37:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:23 INFO - '_': '/tools/buildbot/bin/python'} 18:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:37: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 18:37: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 18:37: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 18:37: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 18:37:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:37:24 INFO - Installing collected packages: mozsystemmonitor 18:37:24 INFO - Running setup.py install for mozsystemmonitor 18:37:25 INFO - Successfully installed mozsystemmonitor 18:37:25 INFO - Cleaning up... 18:37:25 INFO - Return code: 0 18:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:37:25 INFO - Using env: {'DISPLAY': ':0', 18:37:25 INFO - 'HOME': '/home/cltbld', 18:37:25 INFO - 'LANG': 'en_US.UTF-8', 18:37:25 INFO - 'LANGUAGE': 'en_US:en', 18:37:25 INFO - 'LOGNAME': 'cltbld', 18:37:25 INFO - 'MAIL': '/var/mail/cltbld', 18:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:25 INFO - 'MOZ_NO_REMOTE': '1', 18:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:25 INFO - 'NO_EM_RESTART': '1', 18:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:25 INFO - 'PWD': '/builds/slave/test', 18:37:25 INFO - 'SHELL': '/bin/bash', 18:37:25 INFO - 'SHLVL': '1', 18:37:25 INFO - 'TERM': 'linux', 18:37:25 INFO - 'TMOUT': '86400', 18:37:25 INFO - 'USER': 'cltbld', 18:37:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:25 INFO - '_': '/tools/buildbot/bin/python'} 18:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:37: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 18:37: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 18:37: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 18:37: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 18:37:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:37:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:37:26 INFO - warning: no files found matching '*.txt' 18:37:26 INFO - no previously-included directories found matching 'build' 18:37:26 INFO - no previously-included directories found matching 'dist' 18:37:26 INFO - no previously-included directories found matching '.git*' 18:37:26 INFO - Installing collected packages: jsonschema, functools32 18:37:26 INFO - Running setup.py install for functools32 18:37:26 INFO - warning: no files found matching '*.txt' 18:37:26 INFO - no previously-included directories found matching 'build' 18:37:26 INFO - no previously-included directories found matching 'dist' 18:37:26 INFO - no previously-included directories found matching '.git*' 18:37:26 INFO - Successfully installed jsonschema functools32 18:37:26 INFO - Cleaning up... 18:37:26 INFO - Return code: 0 18:37:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:37:26 INFO - Using env: {'DISPLAY': ':0', 18:37:26 INFO - 'HOME': '/home/cltbld', 18:37:26 INFO - 'LANG': 'en_US.UTF-8', 18:37:26 INFO - 'LANGUAGE': 'en_US:en', 18:37:26 INFO - 'LOGNAME': 'cltbld', 18:37:26 INFO - 'MAIL': '/var/mail/cltbld', 18:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:26 INFO - 'MOZ_NO_REMOTE': '1', 18:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:26 INFO - 'NO_EM_RESTART': '1', 18:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:26 INFO - 'PWD': '/builds/slave/test', 18:37:26 INFO - 'SHELL': '/bin/bash', 18:37:26 INFO - 'SHLVL': '1', 18:37:26 INFO - 'TERM': 'linux', 18:37:26 INFO - 'TMOUT': '86400', 18:37:26 INFO - 'USER': 'cltbld', 18:37:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:26 INFO - '_': '/tools/buildbot/bin/python'} 18:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:37:26 INFO - Cleaning up... 18:37:26 INFO - Return code: 0 18:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:37:27 INFO - Using env: {'DISPLAY': ':0', 18:37:27 INFO - 'HOME': '/home/cltbld', 18:37:27 INFO - 'LANG': 'en_US.UTF-8', 18:37:27 INFO - 'LANGUAGE': 'en_US:en', 18:37:27 INFO - 'LOGNAME': 'cltbld', 18:37:27 INFO - 'MAIL': '/var/mail/cltbld', 18:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:27 INFO - 'MOZ_NO_REMOTE': '1', 18:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:27 INFO - 'NO_EM_RESTART': '1', 18:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:27 INFO - 'PWD': '/builds/slave/test', 18:37:27 INFO - 'SHELL': '/bin/bash', 18:37:27 INFO - 'SHLVL': '1', 18:37:27 INFO - 'TERM': 'linux', 18:37:27 INFO - 'TMOUT': '86400', 18:37:27 INFO - 'USER': 'cltbld', 18:37:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:27 INFO - '_': '/tools/buildbot/bin/python'} 18:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:27 INFO - Downloading/unpacking blobuploader==1.2.4 18:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:37:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - Downloading docopt-0.6.1.tar.gz 18:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:37:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:37:28 INFO - Running setup.py install for blobuploader 18:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:37:28 INFO - Running setup.py install for requests 18:37:29 INFO - Running setup.py install for docopt 18:37:29 INFO - Successfully installed blobuploader requests docopt 18:37:29 INFO - Cleaning up... 18:37:29 INFO - Return code: 0 18:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:29 INFO - Using env: {'DISPLAY': ':0', 18:37:29 INFO - 'HOME': '/home/cltbld', 18:37:29 INFO - 'LANG': 'en_US.UTF-8', 18:37:29 INFO - 'LANGUAGE': 'en_US:en', 18:37:29 INFO - 'LOGNAME': 'cltbld', 18:37:29 INFO - 'MAIL': '/var/mail/cltbld', 18:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:29 INFO - 'MOZ_NO_REMOTE': '1', 18:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:29 INFO - 'NO_EM_RESTART': '1', 18:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:29 INFO - 'PWD': '/builds/slave/test', 18:37:29 INFO - 'SHELL': '/bin/bash', 18:37:29 INFO - 'SHLVL': '1', 18:37:29 INFO - 'TERM': 'linux', 18:37:29 INFO - 'TMOUT': '86400', 18:37:29 INFO - 'USER': 'cltbld', 18:37:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:29 INFO - '_': '/tools/buildbot/bin/python'} 18:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:29 INFO - Running setup.py (path:/tmp/pip-DUCk9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:29 INFO - Running setup.py (path:/tmp/pip-Jcbu4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:29 INFO - Running setup.py (path:/tmp/pip-O1NJOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:29 INFO - Running setup.py (path:/tmp/pip-OzPAuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:29 INFO - Running setup.py (path:/tmp/pip-bl1gM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:30 INFO - Running setup.py (path:/tmp/pip-MQm0NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:30 INFO - Running setup.py (path:/tmp/pip-29u2GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:30 INFO - Running setup.py (path:/tmp/pip-iJLHq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:30 INFO - Running setup.py (path:/tmp/pip-psLsHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:30 INFO - Running setup.py (path:/tmp/pip-V0tIZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:30 INFO - Running setup.py (path:/tmp/pip-9RL8D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:30 INFO - Running setup.py (path:/tmp/pip-H3WBs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:30 INFO - Running setup.py (path:/tmp/pip-mWeycy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:30 INFO - Running setup.py (path:/tmp/pip-IqCQCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:30 INFO - Running setup.py (path:/tmp/pip-7CbtOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:30 INFO - Running setup.py (path:/tmp/pip-kksCv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:30 INFO - Running setup.py (path:/tmp/pip-dgXP6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:37:30 INFO - Running setup.py install for manifestparser 18:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:37:30 INFO - Running setup.py install for mozcrash 18:37:31 INFO - Running setup.py install for mozdebug 18:37:31 INFO - Running setup.py install for mozdevice 18:37:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozfile 18:37:31 INFO - Running setup.py install for mozhttpd 18:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozinfo 18:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozInstall 18:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozleak 18:37:31 INFO - Running setup.py install for mozlog 18:37:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for moznetwork 18:37:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Running setup.py install for mozprocess 18:37:32 INFO - Running setup.py install for mozprofile 18:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Running setup.py install for mozrunner 18:37:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Running setup.py install for mozscreenshot 18:37:32 INFO - Running setup.py install for moztest 18:37:32 INFO - Running setup.py install for mozversion 18:37:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:37:32 INFO - Cleaning up... 18:37:32 INFO - Return code: 0 18:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37: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')]} 18:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:32 INFO - Using env: {'DISPLAY': ':0', 18:37:32 INFO - 'HOME': '/home/cltbld', 18:37:32 INFO - 'LANG': 'en_US.UTF-8', 18:37:32 INFO - 'LANGUAGE': 'en_US:en', 18:37:32 INFO - 'LOGNAME': 'cltbld', 18:37:32 INFO - 'MAIL': '/var/mail/cltbld', 18:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:32 INFO - 'MOZ_NO_REMOTE': '1', 18:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:32 INFO - 'NO_EM_RESTART': '1', 18:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:32 INFO - 'PWD': '/builds/slave/test', 18:37:32 INFO - 'SHELL': '/bin/bash', 18:37:32 INFO - 'SHLVL': '1', 18:37:32 INFO - 'TERM': 'linux', 18:37:32 INFO - 'TMOUT': '86400', 18:37:32 INFO - 'USER': 'cltbld', 18:37:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:32 INFO - '_': '/tools/buildbot/bin/python'} 18:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:32 INFO - Running setup.py (path:/tmp/pip-92ARBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:32 INFO - Running setup.py (path:/tmp/pip-JZxTNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:33 INFO - Running setup.py (path:/tmp/pip-6xNIF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:33 INFO - Running setup.py (path:/tmp/pip-pjnex8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:33 INFO - Running setup.py (path:/tmp/pip-suVw3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:33 INFO - Running setup.py (path:/tmp/pip-EMfxUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:33 INFO - Running setup.py (path:/tmp/pip-L20sHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:33 INFO - Running setup.py (path:/tmp/pip-qpOTzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:33 INFO - Running setup.py (path:/tmp/pip-H0lFYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:33 INFO - Running setup.py (path:/tmp/pip-u8XxDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:33 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)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:33 INFO - Running setup.py (path:/tmp/pip-vhJ83Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:33 INFO - Running setup.py (path:/tmp/pip-J6OL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:33 INFO - Running setup.py (path:/tmp/pip-nbOdUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:33 INFO - Running setup.py (path:/tmp/pip-gGRbT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:33 INFO - Running setup.py (path:/tmp/pip-gf_S5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:33 INFO - Running setup.py (path:/tmp/pip-4sTnWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:34 INFO - Running setup.py (path:/tmp/pip-RNlHL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:37:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:35 INFO - Downloading blessings-1.6.tar.gz 18:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:37:35 INFO - Installing collected packages: blessings 18:37:35 INFO - Running setup.py install for blessings 18:37:35 INFO - Successfully installed blessings 18:37:35 INFO - Cleaning up... 18:37:35 INFO - Return code: 0 18:37:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:35 INFO - Reading from file tmpfile_stdout 18:37:35 INFO - Current package versions: 18:37:35 INFO - argparse == 1.2.1 18:37:35 INFO - blessings == 1.6 18:37:35 INFO - blobuploader == 1.2.4 18:37:35 INFO - docopt == 0.6.1 18:37:35 INFO - functools32 == 3.2.3-2 18:37:35 INFO - jsonschema == 2.5.1 18:37:35 INFO - manifestparser == 1.1 18:37:35 INFO - mozInstall == 1.13 18:37:35 INFO - mozcrash == 1.0 18:37:35 INFO - mozdebug == 0.1 18:37:35 INFO - mozdevice == 0.51 18:37:35 INFO - mozfile == 1.2 18:37:35 INFO - mozhttpd == 0.7 18:37:35 INFO - mozinfo == 0.10 18:37:35 INFO - mozleak == 0.1 18:37:35 INFO - mozlog == 3.5 18:37:35 INFO - moznetwork == 0.27 18:37:35 INFO - mozprocess == 0.25 18:37:35 INFO - mozprofile == 0.28 18:37:35 INFO - mozrunner == 6.13 18:37:35 INFO - mozscreenshot == 0.1 18:37:35 INFO - mozsystemmonitor == 0.3 18:37:35 INFO - moztest == 0.8 18:37:35 INFO - mozversion == 1.4 18:37:35 INFO - psutil == 3.1.1 18:37:35 INFO - requests == 1.2.3 18:37:35 INFO - wsgiref == 0.1.2 18:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:35 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 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:35 INFO - Using env: {'DISPLAY': ':0', 18:37:35 INFO - 'HOME': '/home/cltbld', 18:37:35 INFO - 'LANG': 'en_US.UTF-8', 18:37:35 INFO - 'LANGUAGE': 'en_US:en', 18:37:35 INFO - 'LOGNAME': 'cltbld', 18:37:35 INFO - 'MAIL': '/var/mail/cltbld', 18:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:35 INFO - 'MOZ_NO_REMOTE': '1', 18:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:35 INFO - 'NO_EM_RESTART': '1', 18:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:35 INFO - 'PWD': '/builds/slave/test', 18:37:35 INFO - 'SHELL': '/bin/bash', 18:37:35 INFO - 'SHLVL': '1', 18:37:35 INFO - 'TERM': 'linux', 18:37:35 INFO - 'TMOUT': '86400', 18:37:35 INFO - 'USER': 'cltbld', 18:37:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:35 INFO - '_': '/tools/buildbot/bin/python'} 18:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:37:35 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:37 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:37:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:37:37 INFO - Installing collected packages: marionette-driver, simplejson 18:37:37 INFO - Running setup.py install for marionette-driver 18:37:37 INFO - Running setup.py install for simplejson 18:37:37 INFO - building 'simplejson._speedups' extension 18:37:37 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 18:37:38 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 18:37:38 INFO - Successfully installed marionette-driver simplejson 18:37:38 INFO - Cleaning up... 18:37:38 INFO - Return code: 0 18:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24dc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:37:38 INFO - Using env: {'DISPLAY': ':0', 18:37:38 INFO - 'HOME': '/home/cltbld', 18:37:38 INFO - 'LANG': 'en_US.UTF-8', 18:37:38 INFO - 'LANGUAGE': 'en_US:en', 18:37:38 INFO - 'LOGNAME': 'cltbld', 18:37:38 INFO - 'MAIL': '/var/mail/cltbld', 18:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:38 INFO - 'MOZ_NO_REMOTE': '1', 18:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:38 INFO - 'NO_EM_RESTART': '1', 18:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:38 INFO - 'PWD': '/builds/slave/test', 18:37:38 INFO - 'SHELL': '/bin/bash', 18:37:38 INFO - 'SHLVL': '1', 18:37:38 INFO - 'TERM': 'linux', 18:37:38 INFO - 'TMOUT': '86400', 18:37:38 INFO - 'USER': 'cltbld', 18:37:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:38 INFO - '_': '/tools/buildbot/bin/python'} 18:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:37:38 INFO - Cleaning up... 18:37:38 INFO - Return code: 0 18:37:38 INFO - Running post-action listener: _resource_record_post_action 18:37:38 INFO - Running post-action listener: _start_resource_monitoring 18:37:38 INFO - Starting resource monitoring. 18:37:38 INFO - [mozharness: 2017-07-22 01:37:38.921730Z] Finished create-virtualenv step (success) 18:37:38 INFO - [mozharness: 2017-07-22 01:37:38.922198Z] Running install step. 18:37:38 INFO - Running pre-action listener: _resource_record_pre_action 18:37:38 INFO - Running main action method: install 18:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:39 INFO - Reading from file tmpfile_stdout 18:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:37:39 INFO - Reading from file tmpfile_stdout 18:37:39 INFO - Output received: 18:37:39 INFO - Usage: mozinstall [options] installer 18:37:39 INFO - Options: 18:37:39 INFO - -h, --help show this help message and exit 18:37:39 INFO - -d DEST, --destination=DEST 18:37:39 INFO - Directory to install application into. [default: 18:37:39 INFO - "/builds/slave/test"] 18:37:39 INFO - --app=APP Application being installed. [default: firefox] 18:37:39 INFO - mkdir: /builds/slave/test/build/application 18:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:37:57 INFO - Reading from file tmpfile_stdout 18:37:57 INFO - Output received: 18:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 18:37:57 INFO - Running post-action listener: _resource_record_post_action 18:37:57 INFO - [mozharness: 2017-07-22 01:37:57.272353Z] Finished install step (success) 18:37:57 INFO - [mozharness: 2017-07-22 01:37:57.272608Z] Running setup-mitmproxy step. 18:37:57 INFO - Running pre-action listener: _resource_record_pre_action 18:37:57 INFO - Running main action method: setup_mitmproxy 18:37:57 INFO - Skipping: mitmproxy is not required 18:37:57 INFO - Running post-action listener: _resource_record_post_action 18:37:57 INFO - [mozharness: 2017-07-22 01:37:57.273825Z] Finished setup-mitmproxy step (success) 18:37:57 INFO - [mozharness: 2017-07-22 01:37:57.274047Z] Running run-tests step. 18:37:57 INFO - Running pre-action listener: _resource_record_pre_action 18:37:57 INFO - Running pre-action listener: _set_gcov_prefix 18:37:57 INFO - Running main action method: run_tests 18:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:37:57 INFO - Python 2.7.3 18:37:57 INFO - Return code: 0 18:37:57 INFO - grabbing minidump binary from tooltool 18:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2848eb0>, '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 0x2849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:37:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:37:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:37:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:37:57 INFO - Return code: 0 18:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - ENV: RUST_BACKTRACE is now 1 18:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:37:57 INFO - Using env: {'DISPLAY': ':0', 18:37:57 INFO - 'HOME': '/home/cltbld', 18:37:57 INFO - 'LANG': 'en_US.UTF-8', 18:37:57 INFO - 'LANGUAGE': 'en_US:en', 18:37:57 INFO - 'LOGNAME': 'cltbld', 18:37:57 INFO - 'MAIL': '/var/mail/cltbld', 18:37:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:37:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:57 INFO - 'MOZ_NO_REMOTE': '1', 18:37:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:57 INFO - 'NO_EM_RESTART': '1', 18:37:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:57 INFO - 'PWD': '/builds/slave/test', 18:37:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:37:57 INFO - 'RUST_BACKTRACE': '1', 18:37:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:37:57 INFO - 'SHELL': '/bin/bash', 18:37:57 INFO - 'SHLVL': '1', 18:37:57 INFO - 'STYLO_FORCE_ENABLED': '1', 18:37:57 INFO - 'TERM': 'linux', 18:37:57 INFO - 'TMOUT': '86400', 18:37:57 INFO - 'USER': 'cltbld', 18:37:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575', 18:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:57 INFO - '_': '/tools/buildbot/bin/python'} 18:37:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:37:57 INFO - mozversion application_buildid: 20170722005116 18:37:57 INFO - mozversion application_changeset: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 18:37:57 INFO - mozversion application_display_name: Nightly 18:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:37:57 INFO - mozversion application_name: Firefox 18:37:57 INFO - mozversion application_remotingname: firefox 18:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:37:57 INFO - mozversion application_vendor: Mozilla 18:37:57 INFO - mozversion application_version: 56.0a1 18:37:57 INFO - mozversion platform_buildid: 20170722005116 18:37:57 INFO - mozversion platform_changeset: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 18:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:37:57 INFO - mozversion platform_version: 56.0a1 18:37:57 INFO - using testdate: 1500687477 18:37:57 INFO - actual date: 1500687477 18:37:57 INFO - starting webserver on 'localhost:47296' 18:37:57 INFO - SUITE-START | Running 2 tests 18:37:57 INFO - TEST-START | dromaeo_css 18:37:57 INFO - Initialising browser for dromaeo_css test... 18:37:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47296/getInfo.html -profile /tmp/tmpbk2G55/profile 18:37:57 INFO - TEST-INFO | started process 25687 (/builds/slave/test/build/application/firefox/firefox http://localhost:47296/getInfo.html) 18:38:04 INFO - TEST-INFO | 25687: exit 0 18:38:04 INFO - Browser initialized. 18:38:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:04 INFO - TEST-INFO | started process 25919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbk2G55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:16 INFO - PID 25919 | RSS: Main: 177352704 18:38:16 INFO - PID 25919 | 18:41:15 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47296/tests/dromaeo/cssquery-ext.html) 18:41:16 INFO - PID 25919 | RSS: Main: 182063104 18:41:16 INFO - PID 25919 | 18:44:18 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-ext.html (next: http://localhost:47296/tests/dromaeo/cssquery-jquery.html) 18:44:19 INFO - PID 25919 | RSS: Main: 180060160 18:44:19 INFO - PID 25919 | 18:47:21 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47296/tests/dromaeo/cssquery-mootools.html) 18:47:21 INFO - PID 25919 | RSS: Main: 181764096 18:47:21 INFO - PID 25919 | 18:50:23 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47296/tests/dromaeo/cssquery-prototype.html) 18:50:24 INFO - PID 25919 | RSS: Main: 180355072 18:50:24 INFO - PID 25919 | 18:53:28 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47296/tests/dromaeo/cssquery-yui.html) 18:53:28 INFO - PID 25919 | RSS: Main: 182231040 18:53:28 INFO - PID 25919 | 18:56:30 INFO - PID 25919 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-yui.html (next: http://localhost:47296/tests/dromaeo/cssquery-dojo.html) 18:56:31 INFO - PID 25919 | RSS: Main: 184422400 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | __start_tp_report 18:56:31 INFO - PID 25919 | _x_x_mozilla_page_load 18:56:31 INFO - PID 25919 | _x_x_mozilla_page_load_details 18:56:31 INFO - PID 25919 | |i|pagename|runs| 18:56:31 INFO - PID 25919 | |0;dojo.html;3122.250659841637;3149.5118256670225;3159.0838656789533;3167.5407065975432;3171.0169847347324;6059.151718759377;6107.419795119462;6107.541934354925;6154.784582539612;6268.529860260487;6181.536384771138;6210.503159747221;6216.968915155429;6274.403931626488;6277.780277690282;5437.184422336662;5561.499465048145;5658.094704847225;5667.603267771257;5774.855628609276;5576.721163941807;5603.411641777616;5615.971920140393;5665.971670141664;5688.857778555528;5610.971945140269;5687.459691329317;5702.344230413514;5708.400617935098;5723.427657234285;5498.3127109111365;5595.076812325961;5615.382307946123;5662.065759149736;5679.318481782171;5513.365962914236;5515.338159420855;5591.245181900432;5610.831675049755;5618.943810561883;6095.481884039862;6122.877542449126;6124.081387791823;6133.447989680905;6136.355682653302;6558.80323590293;6639.170103737033;6646.10277612521;6646.833829154261;6666.333366663295;6631.801045968628;6702.698378572976;6727.831804204885;6738.561993470409;6761.8647627047185;6133.1413602095745;6141.477974372184;6233.657148856811;6239.126522286883;6245.344238854946;6534.607923524603;6679.198496180489;6690.832729181712;6775.457963362919;6924;6516.934830651728;6541.672916354163;6564.409203171737;6565.113709649137;6587.769428069994;6596.373344532261;6597.1423714916755;6686.5653732507235;6687.398134167851;6694.02936574194;6539.901901471481;6564.048213009087;6645.335466453316;6659.101021362151;6673.332666733288;6434.774782882577;6540.215174179129;6552.901706474407;6611.975143852711;6674.16572928384;5270.472952704776;5333;5335.626506144533;5337.412884582693;5340;4526.751028693454;4528.139653465831;4565.315202719618;4571.017231295221;4601.838935637304;5607.831765047055;5676.460736230051;5704.971475142598;5712.65724056558;5720.08478643415;6479.773207937699;6579.934200658028;6590;6694.732210711614;6747.898781518281;5741.425857414225;5762.135679648002;5778.884422311614;5787.88424231513;5795.710214489259;5706.771729130871;5783.2192653992015;5870.207521984477;5877.647341159544;5911.349751527328;6240.126382306572;6324.873502529832;6409.519286053564;6425.228972523327;6541.8364540885905;6574.967125164344;6652.966735166293;6656.23453302857;6683.231428385798;6687.565308254948;6354.841128971812;6435;6441.67791610427;6451.354864513699;6457.063725759833;6442.35576442352;6448.967755161194;6486.156799616208;6488.967555162383;6557.672116394257;6493.350664933469;6562.5406221565945;6583.913654246996;6584.703688333941;6602.40578347951;6443.097966284818;6451.870962580629;6479.935200647933;6490.610563366213;6501.44737697301;6402.455791257796;6437.002264648987;6497.415232629086;6507.642079685663;6509.121268628674;6332.588381755171;6351.650659213788;6405.2313722351755;6428.228612566522;6436.67816609177;6282;6366.840828979312;6421.839454013687;6492.675366231575;6492.837679058061;6225.346338634378;6274.717637706223;6276.435120839146;6295.92969195247;6304.873902521832 18:56:31 INFO - PID 25919 | |1;ext.html;687.456909041857;725.51753084199;742.888566714993;743.4721347843031;744.4639859301301;31440;31959;41081.79459102704;41449.75650730475;41555.58444415555;41404.17191656165;41979.79010104945;42049.15901681964;42172;42262.15475690484;7497.850042999136;7615.504992175519;7629.313361797437;7629.427792915526;7640.541567505968;7473.6263186840715;7565.2812982766545;7568.39452843774;7573.886391704129;7583.203763604824;7583.27958843909;7627.961860190691;7629.084509858797;7645.541267523939;7649.847003059936;7479.962600187018;7602.8479430411635;7604.201558836297;7611.467197296191;7617.542947423172;7393.149787774367;7455.701771929116;7473.925260747377;7475.962620186919;7477.513961592534;37415;37798.81100594507;37915.24169516594;37946.241075178616;37955.810220948995;3519.472079188117;3528.964710352889;3541.752077354586;3547.6984456321243;3547.8580856765698;29108.563371549444;29117;29193.708062919522;29220.853895730386;29239.122826315244;4723.622110231173;4763.523647635244;4794;4820.084184005028;4866.46468888422;177603;178519;180482;181454;182099;44778.55221447809;44885;45066.54933450689;45153;45221.738913054214;46176;46422.767886160356;46435;46465;46558.76720616375;15105.3202605883;15381.692366152614;15384.153871537173;15398.153101579297;15403.22983850803;12705.983521318272;12714.11001229905;12716.554920577735;12717.427715752814;12723.618291451086;13074.346282685829;13090.738185236432;13150.408231629599;13269.402876870565;13372.130811497416;5247.396549396868;5259.105951988171;5275.973620131875;5355.22349259363;5385.542228910508;972.1396564040733;985.551239677687;987.1461186073994;992.836182029957;1028.3829702178632;22720.886395567915;23230.3030909073;23442.296731097755;23610.111191104672;23686.881565592063;1096.5668560918393;1104.5747387255965;1114.3759494683004;1124.9493772780245;1126.3298337489182;11829.585964491374;12343.753124937452;12399.938000309941;12461.878430941077;12546.68633284157;225314;225504;225827;230313;233721;54283.45716542863;54285;54426.45573544293;54548.18177727258;54567.18149227765;1442.9855701443062;1482.3699927530972;1490.1878476230481;1496.0873866941158;1508.947186848477;26380.20859374222;27319.590206146528;27509.44981100327;27626.171214863585;27647.170584882486;37039.44440833336;37120.257594848496;37121;37188.44217336688;37197;192933;193549;194638;195511;196026;33356.332873342886;35885.820570896976;36959.63040369562;36972.26055478821;36982.63017369792;46567.53432465632;46626.76686616545;47031.29453058275;47183.528164717914;47549;33533.664663353054;33676.663233367355;34324;34344.82827585846;35208.823955880056;32058;32859.50710739293;34065.14837129092;34103.82948085244;34729.82635086808;35850.282994339446;36762.63237367592;37377.62622373742;37420;37518.624813751514;32384.190395240308;32534.186645334055;33063.17342066467;33107.50338744873;33250.667493324756;23769.762302376756;24619.015239390224;24693.135740249007;24911.252662420156;25318.620220697074 18:56:31 INFO - PID 25919 | |2;jquery.html;578.5545130249708;582.3332284534208;582.3937877995966;598.4703537369427;620.2959640807683;22394.77605223947;23232.88383558084;23331.533369332603;23343.649845252294;23360.76639233607;25574.232773016793;26555.336116597096;26640.733592664066;26659.86670066647;26665;6522.673866306677;6667.366600173;6687.06381106643;6701.229358623772;6710.563813352116;6498.155239818817;6592.241892182388;6667.566608170478;6963.825904352381;7041.049458323112;7009.579425234477;7021.087258656393;7027.156741191065;7043.084399028119;7045.89431158533;6986;6991.720331186746;7014.403775679073;7038.19060808006;7042.2957704229675;6830.521863469559;6865.107536020335;6865.9313406866295;6878.140232470942;6887.793366198972;30812;31088;31125.221869453217;31213.531797022835;31530.369392612018;1980.9702854457194;2033.8169564739244;2040.102354963826;2040.7653119891106;2044.1108117968583;19066.52333691655;19994.600107997903;20114.69827952582;20138;20150.29473968419;2380.940476488084;2463.334899577122;2531.4430825218424;2545.058328418497;2545.6945166579944;131652;135224;136325;136834;137115;20048.59902801936;21795.34613961584;21946.89026554857;22319.665205021938;22414;22869.19957801469;23775.52448951046;23847.569145851303;23876.64185037226;44554.33168502475;10385.169186465064;10595.94702026485;10611.469426528643;10650.201234907412;10889.83665245022;9761.463119528495;9893.505324733735;9894.55474503649;9996.300258981946;10044.447555384524;9197.172254497127;9338.252939764803;9345.579448924815;9379.906200937903;9670.323077384657;2741.684706258766;2762.748360086523;2821.4357128573956;2835.517961946474;2873.8988295774748;936.9390989585655;955.6129767444057;968.2350942755145;985.6303886042734;992.9900700993043;19655.312064077687;19676.70484942727;19724.30964916221;19751.209951601773;20168.89915550413;982.8181786369545;1011.8330475471612;1028.0695970147028;1049.5172220778527;1054.7679510507676;10295.433751143759;10444.112250458797;10526.842047374783;11032.172587056002;11063.778724425467;470458;474992;480879;498585;501863;119747;124226;125200;126491;127803;1235.7590269897464;1260.5336025670376;1286.5175559165314;1292.6602848843436;1294.087668193921;19993.400197994084;20207.898960505692;20700.792992069888;21135.78864211338;21345.35963921085;54681;55916.72041639766;57299.14051289151;57732;58453.415465844795;67659.32340676727;72275.63862180866;74709.25290747023;75351.62324188344;77174;14494.130352178903;15044.247787610357;15156.242187890783;15225.543233703007;15237.009594376774;23717.288481345586;23734.406639834142;23752.168674096323;23871.64192537148;24054;18612;18826.811731882506;18969.43091707251;19146.23415063382;19217.711734324275;15905;16189;16684.58288542796;17091.829081709024;17783.28866845312;18866.24535018584;19013.71479427782;19367.12847921875;19431.4170574883;19550.8044919549;14874.925625372236;14887.330070146652;14891.851081489047;14892.106473611619;14897.329620166902;18055.909720451313;18849.71725424147;18862.622747545247;19043;19082.61834763269 18:56:31 INFO - PID 25919 | |3;mootools.html;1318.9736205275894;1372.9063178652555;1386.2722070912773;1390.2492653966858;1391.770357890948;13296.46814127435;13298.867011329883;14042.508512202076;14055.437782488689;14083.295835208224;13522.391492382842;13743.725125497509;13761.311934403266;13790.655233619165;13832.861671383309;2645.7486538778835;2685.355514676483;2697.541417958942;2699.2442116207494;2704.148193319108;2597.1559243245924;2645.140329392945;2662.6671666041743;2663.400734834666;2715.904943326984;2658.3752818087733;2696.7842572594245;2698.892044318225;2704.2428120126397;2707.2149076767714;2556.5398228318895;2604.1536500637276;2648.430587423694;2694.0974773450916;2694.393761403688;2580.4194056337174;2586.7671909528044;2587.1591732686766;2604.231751633273;2612.6472926154916;13116.409761560753;13477.730445391036;13543.322833858367;13587.52443664477;13712.862871371259;7563.962180189119;7860.253275938834;7865.9606701966695;7874.763757087297;7878.4485086044;5171.948280517222;5329.946700532983;5343.679379237219;5470.972645136749;5471.234027236151;1787.731840223964;1814.9818501814946;1819.4541637508826;1865.7574515312922;1872.4008317338457;22087.779122208893;22682.54634907309;22733.318000460014;22749.43126421836;22831.31506054821;6797;6896.379325860697;7001.754938577125;7102.573845569283;7105.573665580082;17266.740998885027;17435.912820435817;17455.912720436318;17731.911340443214;17798.46604601838;7687.884681729778;7946.523208607502;7957.3634109271115;7962.084360298524;7971.960140199262;6737.225219099768;6931.930680693229;6966.512344135963;7104.751333703295;7123.82190445243;5363.19552067193;5467.152591348347;5515.338159420815;5525.723713814374;5562.666240025531;1583.6990971715338;1663.642316901872;1696.8897021693551;1704.5568152280248;1734.6357264974245;873.7073080518097;874.9387542871938;894.7226359828474;894.7539426657592;913.5660561233361;6688.3646053624825;7428.591427471541;7473.626318684044;7682.654280557388;7777.5722335270975;923.2567782934668;943.7357539888842;956.6556039825657;987.9703608891745;999.205631522941;4388.2320593896575;4553.886152846206;4617.8845528861375;5004.149294619923;5179.04187725272;18068.457946261635;18455.354062608014;18484;18773.81226187748;18826.152823122993;16991.660166796595;18068.548286292684;18073.45779626613;18158.364457243933;18417.723734143998;10232.53953572091;10474.319169253975;10498.527566259536;10520.473976301308;10539.736506587396;7330.560166390033;7385.372243359375;7478.4765066444825;7615.771526854203;8221.30118939873;15330.846691533388;15487.070775753491;15598.9220053899;15771.526854194393;15963.44127955516;15514.224288785741;15702.450414235447;15975.360985560448;16174.595635109217;16184.838151618333;10604.628837990633;10699.572017119228;10999.780004399707;11114.666560003212;11130.777384452427;12324.753504929671;12336.691582710504;12418.192817467198;12518.874811252135;12560.560380386643;9880.703578892644;10406.947965260428;10420;10436.16510679159;10605.946970265099;9814.214862810815;9876.753081173028;9919.553620086968;10108.292419530562;10120.240981926238;8816.779580510538;8837.204651581389;8882.333824963025;8896.065913079292;8914.242289405214;6427.421532062137;6808.659567021728;6882.4149947253045;6959.304069593;7083.504154709327;6224.9377506224355;6659.600423974577;6670.699818508082;6843.939189425647;6869.141357330333 18:56:31 INFO - PID 25919 | |4;prototype.html;475.69793181329845;491.3833139410041;516.0891027336754;522.9529342359189;523.6700878446578;5922.200502932103;6050.152978582996;6093.146959425684;6129.536811701391;6130.540209484284;5934;5938.792142275021;6075.665838378898;6089.6955152242435;6111.388861113886;5063.974680126595;5091.974540127313;5101.923471147936;5110.850058736792;5122.641415100945;5105.5660268877;5112.488751124895;5119.976004799055;5139.25480805283;5170.844874653766;4779.952200477986;4878.243872199815;4885.31605575218;4887.629499692646;4936.259561065851;4807.687500312503;4809.639277054217;4833.042617739803;4917.655764096515;4953.9504604953845;4423.225935461282;4424.911501769947;4429.291313389875;4437.29003359461;4444.35556844259;5959.970200148971;5961.254843144607;5977.402259774031;6006.969965150146;6052.243469566304;5653.632513886584;5668.093105103205;5678.801241956512;5695.658260504383;5705.5435565154685;6382.680865956683;6400.575692004755;6425.261094974091;6455.419012288917;6469.74121035158;4799.9760001199775;4801.447833499157;4803.951960480385;4825.155597770411;4825.252085926687;6758.121444212221;6780.694868730919;6842.726290948406;6843.520953533254;6880.8967865482055;4864.537868902448;4925.482824303396;4947.851564453073;4960.751962401865;4988.127077761377;4999.600031997432;5007.949920500749;5022.522860328263;5033.1695270280725;5051.3433253676785;5610.523105535994;5663.745131469093;5666.716664166857;5700.945325114867;5712.685802280831;6326.873462530723;6336.52476064297;6369.649669268235;6422;6466.579672321378;1644.1368281652228;1676.4467725650507;1699.5751062234442;1741.1207340293072;1759.8240175982298;1197.8083506638895;1209.8124790657462;1212.2241765270235;1214.1379620469565;1229.1334609100563;5579;5631.465010823965;5656.745446454919;5666.433356664301;5679.971600141973;6263.3736626337;6436.388543088399;6490.837729056811;6521.282658907517;6559.4752419807255;5596.188552659842;5636.915446268309;5647.604667673306;5666;5689.516391106802;3497.1082373994977;3504.2641045380246;3519.59524654668;3525.7355698322726;3533.593636731757;6399.872002559922;6442.291347951722;6458.483321334282;6460.967695161494;6503.577267477599;6811.318868113149;6821.181458224945;6830.556013859084;6837.623930683761;6845.247022827485;6369.172007638977;6415.230172379344;6432.35676432353;6437.130987316746;6462.192225971754;6474;6568.113304703995;6572.244191917799;6661.933380666132;6667.233268174028;6502.252240992347;6510.851419031803;6522.478201743944;6555.918718202437;6648.268690444144;6325.292171113865;6383.87232255343;6385.23377194721;6404.391582799627;6470.838229044311;4870.269459581091;4916.360873086476;4945.282933974626;4950.801967921243;4970.204767237225;6578.572392794453;6597.175353080865;6636;6679.664067186679;6686.498512611671;6327.303996560467;6360.332165122595;6392.9360706392345;6419.358064193543;6450.290468048604;6122.816315510542;6264.154339164154;6307.653079080695;6326.272478665012;6413.294537600954;6050.667213303311;6125.111858780363;6259.78090766821;6269.467095296951;6338.619682819046;6409.391107844747;6428.871422571616;6446.548741588232;6450.774222902176;6454.644994525346;6143.539234557336;6159.4456498915315;6166.4758495526585;6190.81427557174;6205.968970155121 18:56:31 INFO - PID 25919 | |5;yui.html;891.7904292491268;922.7139586728115;928.8374534456468;936.6815282803846;941.4022095969058;18277.360292389752;19253.614927701474;19268.99999999998;19280.228790848385;19325.420237392882;19836.60326793463;21733;21870.125194992223;21878.23426180084;21897.452563685914;1014.8274793285141;1034.9482525873714;1036.3937096798345;1039.1686650679426;1039.2569312941246;977.4037836919473;1054.7890421915608;1063.489525027987;1067.3542506783401;1068.0280944340652;1097.736543229623;1105.8894110588917;1111.3276467736985;1114;1116.1461481966303;1086.929349592278;1099.8515200447916;1099.8845121262232;1100.5927806711568;1101.0255923507752;794.2732399854126;802.4944285100349;809;812.7683610171073;812.8699408094676;19809;20206.393808185778;20369.5926081479;20455.2840650578;20478.795212047837;20600.072996715186;20710.896445517676;21003.369898903056;21106.78893211079;21871.781282187134;16092.114933678644;16395.180240988022;16462.588435289093;16621;16699.499015029567;3602.045457953618;3635.272945410902;3637.163452405935;3637.2725454909123;3640.981795091034;123824.38087809594;124923.3753831225;129456;129993.35003325017;130274.34862825625;16098.114603696675;16412;16661.750073748903;16790.244439000275;16863.494095177164;27987;28138;30520.847395762878;30795.538066929013;30842.53736193959;8197.549134797524;8232.794180145425;8313.33493320533;8328.791780205544;8332.458390204618;3824.2351529694174;3896.805159742058;3921.137349783043;3930.9975956131575;3932.390479475686;4983.401991760939;5123.257127716534;5150.871228219249;5172.663776854568;5183.611229157828;980.352967041749;1010.3129871687323;1017.5370206555999;1019.8215312320315;1027.0448482910965;677.1298880938069;697.6720941157648;708.8334241453255;710.9751158709421;719.70851805018;11064.557417703363;11124.888751112385;11347.886521134847;11382.430878456209;11454.541818327174;677.9661016949133;698.4238003647012;707.6532499075416;707.8690442268197;714.7677004973405;5012.924806127911;5839.503642190376;5891.05743081105;5995.400459953969;6335.936640633535;103923.4803825976;108529.45735271431;109420.4528977366;113665;118694.40652796681;93510;95373;97341.5132924345;97725.51137244268;100126;87251;87627.25564189468;89325.55337223402;91813;91994;11381;11939.164258501822;11998.520059197534;12416.317102559446;12491.687707807378;35740.82129589439;37331.440028399054;37636;38747.22505549929;39519;48335.27497087617;48842.26736598883;50032;68124;68747;16309.51071467858;17178.39875604348;17247.913760431118;18109.456716298533;18683.626327473645;20370.79629203748;20418.489537761674;20451.590968180255;21622.89188554047;22200.777992220515;18330.633387332444;19451.3192038278;19729.605407891475;19849.603007939473;20120.094595743518;17359.56601084983;17611.55971100733;17790;18368.17343219585;18909.338173163873;18090.819091808913;18408.907955460138;18487.90756046265;18560.907195463937;18602.534936626693;12632.242065475733;12728.490860365482;13078.215307081226;13685;13860.237686927316;13591.932040339734;13696.178229306273;13779.862201378259;14259.215743134228;14673 18:56:31 INFO - PID 25919 | __end_tp_report 18:56:31 INFO - PID 25919 | __start_cc_report 18:56:31 INFO - PID 25919 | _x_x_mozilla_cycle_collect,388 18:56:31 INFO - PID 25919 | __end_cc_report 18:56:31 INFO - PID 25919 | __startTimestamp1500688591107__endTimestamp 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | ------- Summary: start ------- 18:56:31 INFO - PID 25919 | Number of tests: 6 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#0] dojo.html Cycles:165 Average:6083.08 Median:6324.87 stddev:718.58 (11.4%) stddev-sans-first:682.21 18:56:31 INFO - PID 25919 | Values: 3122.3 3149.5 3159.1 3167.5 3171.0 6059.2 6107.4 6107.5 6154.8 6268.5 6181.5 6210.5 6217.0 6274.4 6277.8 5437.2 5561.5 5658.1 5667.6 5774.9 5576.7 5603.4 5616.0 5666.0 5688.9 5611.0 5687.5 5702.3 5708.4 5723.4 5498.3 5595.1 5615.4 5662.1 5679.3 5513.4 5515.3 5591.2 5610.8 5618.9 6095.5 6122.9 6124.1 6133.4 6136.4 6558.8 6639.2 6646.1 6646.8 6666.3 6631.8 6702.7 6727.8 6738.6 6761.9 6133.1 6141.5 6233.7 6239.1 6245.3 6534.6 6679.2 6690.8 6775.5 6924.0 6516.9 6541.7 6564.4 6565.1 6587.8 6596.4 6597.1 6686.6 6687.4 6694.0 6539.9 6564.0 6645.3 6659.1 6673.3 6434.8 6540.2 6552.9 6612.0 6674.2 5270.5 5333.0 5335.6 5337.4 5340.0 4526.8 4528.1 4565.3 4571.0 4601.8 5607.8 5676.5 5705.0 5712.7 5720.1 6479.8 6579.9 6590.0 6694.7 6747.9 5741.4 5762.1 5778.9 5787.9 5795.7 5706.8 5783.2 5870.2 5877.6 5911.3 6240.1 6324.9 6409.5 6425.2 6541.8 6575.0 6653.0 6656.2 6683.2 6687.6 6354.8 6435.0 6441.7 6451.4 6457.1 6442.4 6449.0 6486.2 6489.0 6557.7 6493.4 6562.5 6583.9 6584.7 6602.4 6443.1 6451.9 6479.9 6490.6 6501.4 6402.5 6437.0 6497.4 6507.6 6509.1 6332.6 6351.7 6405.2 6428.2 6436.7 6282.0 6366.8 6421.8 6492.7 6492.8 6225.3 6274.7 6276.4 6295.9 6304.9 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#1] ext.html Cycles:180 Average:37150.76 Median:36324.23 stddev:52281.27 (143.9%) stddev-sans-first:52356.24 18:56:31 INFO - PID 25919 | Values: 687.5 725.5 742.9 743.5 744.5 31440.0 31959.0 41081.8 41449.8 41555.6 41404.2 41979.8 42049.2 42172.0 42262.2 7497.9 7615.5 7629.3 7629.4 7640.5 7473.6 7565.3 7568.4 7573.9 7583.2 7583.3 7628.0 7629.1 7645.5 7649.8 7480.0 7602.8 7604.2 7611.5 7617.5 7393.1 7455.7 7473.9 7476.0 7477.5 37415.0 37798.8 37915.2 37946.2 37955.8 3519.5 3529.0 3541.8 3547.7 3547.9 29108.6 29117.0 29193.7 29220.9 29239.1 4723.6 4763.5 4794.0 4820.1 4866.5 177603.0 178519.0 180482.0 181454.0 182099.0 44778.6 44885.0 45066.5 45153.0 45221.7 46176.0 46422.8 46435.0 46465.0 46558.8 15105.3 15381.7 15384.2 15398.2 15403.2 12706.0 12714.1 12716.6 12717.4 12723.6 13074.3 13090.7 13150.4 13269.4 13372.1 5247.4 5259.1 5276.0 5355.2 5385.5 972.1 985.6 987.1 992.8 1028.4 22720.9 23230.3 23442.3 23610.1 23686.9 1096.6 1104.6 1114.4 1124.9 1126.3 11829.6 12343.8 12399.9 12461.9 12546.7 225314.0 225504.0 225827.0 230313.0 233721.0 54283.5 54285.0 54426.5 54548.2 54567.2 1443.0 1482.4 1490.2 1496.1 1508.9 26380.2 27319.6 27509.4 27626.2 27647.2 37039.4 37120.3 37121.0 37188.4 37197.0 192933.0 193549.0 194638.0 195511.0 196026.0 33356.3 35885.8 36959.6 36972.3 36982.6 46567.5 46626.8 47031.3 47183.5 47549.0 33533.7 33676.7 34324.0 34344.8 35208.8 32058.0 32859.5 34065.1 34103.8 34729.8 35850.3 36762.6 37377.6 37420.0 37518.6 32384.2 32534.2 33063.2 33107.5 33250.7 23769.8 24619.0 24693.1 24911.3 25318.6 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#2] jquery.html Cycles:180 Average:35551.55 Median:23539.03 stddev:81970.58 (348.2%) stddev-sans-first:82158.47 18:56:31 INFO - PID 25919 | Values: 578.6 582.3 582.4 598.5 620.3 22394.8 23232.9 23331.5 23343.6 23360.8 25574.2 26555.3 26640.7 26659.9 26665.0 6522.7 6667.4 6687.1 6701.2 6710.6 6498.2 6592.2 6667.6 6963.8 7041.0 7009.6 7021.1 7027.2 7043.1 7045.9 6986.0 6991.7 7014.4 7038.2 7042.3 6830.5 6865.1 6865.9 6878.1 6887.8 30812.0 31088.0 31125.2 31213.5 31530.4 1981.0 2033.8 2040.1 2040.8 2044.1 19066.5 19994.6 20114.7 20138.0 20150.3 2380.9 2463.3 2531.4 2545.1 2545.7 131652.0 135224.0 136325.0 136834.0 137115.0 20048.6 21795.3 21946.9 22319.7 22414.0 22869.2 23775.5 23847.6 23876.6 44554.3 10385.2 10595.9 10611.5 10650.2 10889.8 9761.5 9893.5 9894.6 9996.3 10044.4 9197.2 9338.3 9345.6 9379.9 9670.3 2741.7 2762.7 2821.4 2835.5 2873.9 936.9 955.6 968.2 985.6 993.0 19655.3 19676.7 19724.3 19751.2 20168.9 982.8 1011.8 1028.1 1049.5 1054.8 10295.4 10444.1 10526.8 11032.2 11063.8 470458.0 474992.0 480879.0 498585.0 501863.0 119747.0 124226.0 125200.0 126491.0 127803.0 1235.8 1260.5 1286.5 1292.7 1294.1 19993.4 20207.9 20700.8 21135.8 21345.4 54681.0 55916.7 57299.1 57732.0 58453.4 67659.3 72275.6 74709.3 75351.6 77174.0 14494.1 15044.2 15156.2 15225.5 15237.0 23717.3 23734.4 23752.2 23871.6 24054.0 18612.0 18826.8 18969.4 19146.2 19217.7 15905.0 16189.0 16684.6 17091.8 17783.3 18866.2 19013.7 19367.1 19431.4 19550.8 14874.9 14887.3 14891.9 14892.1 14897.3 18055.9 18849.7 18862.6 19043.0 19082.6 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#3] mootools.html Cycles:180 Average:8496.67 Median:2647.09 stddev:5698.36 (215.3%) stddev-sans-first:5688.82 18:56:31 INFO - PID 25919 | Values: 1319.0 1372.9 1386.3 1390.2 1391.8 13296.5 13298.9 14042.5 14055.4 14083.3 13522.4 13743.7 13761.3 13790.7 13832.9 2645.7 2685.4 2697.5 2699.2 2704.1 2597.2 2645.1 2662.7 2663.4 2715.9 2658.4 2696.8 2698.9 2704.2 2707.2 2556.5 2604.2 2648.4 2694.1 2694.4 2580.4 2586.8 2587.2 2604.2 2612.6 13116.4 13477.7 13543.3 13587.5 13712.9 7564.0 7860.3 7866.0 7874.8 7878.4 5171.9 5329.9 5343.7 5471.0 5471.2 1787.7 1815.0 1819.5 1865.8 1872.4 22087.8 22682.5 22733.3 22749.4 22831.3 6797.0 6896.4 7001.8 7102.6 7105.6 17266.7 17435.9 17455.9 17731.9 17798.5 7687.9 7946.5 7957.4 7962.1 7972.0 6737.2 6931.9 6966.5 7104.8 7123.8 5363.2 5467.2 5515.3 5525.7 5562.7 1583.7 1663.6 1696.9 1704.6 1734.6 873.7 874.9 894.7 894.8 913.6 6688.4 7428.6 7473.6 7682.7 7777.6 923.3 943.7 956.7 988.0 999.2 4388.2 4553.9 4617.9 5004.1 5179.0 18068.5 18455.4 18484.0 18773.8 18826.2 16991.7 18068.5 18073.5 18158.4 18417.7 10232.5 10474.3 10498.5 10520.5 10539.7 7330.6 7385.4 7478.5 7615.8 8221.3 15330.8 15487.1 15598.9 15771.5 15963.4 15514.2 15702.5 15975.4 16174.6 16184.8 10604.6 10699.6 10999.8 11114.7 11130.8 12324.8 12336.7 12418.2 12518.9 12560.6 9880.7 10406.9 10420.0 10436.2 10605.9 9814.2 9876.8 9919.6 10108.3 10120.2 8816.8 8837.2 8882.3 8896.1 8914.2 6427.4 6808.7 6882.4 6959.3 7083.5 6224.9 6659.6 6670.7 6843.9 6869.1 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#4] prototype.html Cycles:180 Average:5422.81 Median:5992.19 stddev:1508.85 (25.2%) stddev-sans-first:1466.68 18:56:31 INFO - PID 25919 | Values: 475.7 491.4 516.1 523.0 523.7 5922.2 6050.2 6093.1 6129.5 6130.5 5934.0 5938.8 6075.7 6089.7 6111.4 5064.0 5092.0 5101.9 5110.9 5122.6 5105.6 5112.5 5120.0 5139.3 5170.8 4780.0 4878.2 4885.3 4887.6 4936.3 4807.7 4809.6 4833.0 4917.7 4954.0 4423.2 4424.9 4429.3 4437.3 4444.4 5960.0 5961.3 5977.4 6007.0 6052.2 5653.6 5668.1 5678.8 5695.7 5705.5 6382.7 6400.6 6425.3 6455.4 6469.7 4800.0 4801.4 4804.0 4825.2 4825.3 6758.1 6780.7 6842.7 6843.5 6880.9 4864.5 4925.5 4947.9 4960.8 4988.1 4999.6 5007.9 5022.5 5033.2 5051.3 5610.5 5663.7 5666.7 5700.9 5712.7 6326.9 6336.5 6369.6 6422.0 6466.6 1644.1 1676.4 1699.6 1741.1 1759.8 1197.8 1209.8 1212.2 1214.1 1229.1 5579.0 5631.5 5656.7 5666.4 5680.0 6263.4 6436.4 6490.8 6521.3 6559.5 5596.2 5636.9 5647.6 5666.0 5689.5 3497.1 3504.3 3519.6 3525.7 3533.6 6399.9 6442.3 6458.5 6461.0 6503.6 6811.3 6821.2 6830.6 6837.6 6845.2 6369.2 6415.2 6432.4 6437.1 6462.2 6474.0 6568.1 6572.2 6661.9 6667.2 6502.3 6510.9 6522.5 6555.9 6648.3 6325.3 6383.9 6385.2 6404.4 6470.8 4870.3 4916.4 4945.3 4950.8 4970.2 6578.6 6597.2 6636.0 6679.7 6686.5 6327.3 6360.3 6392.9 6419.4 6450.3 6122.8 6264.2 6307.7 6326.3 6413.3 6050.7 6125.1 6259.8 6269.5 6338.6 6409.4 6428.9 6446.5 6450.8 6454.6 6143.5 6159.4 6166.5 6190.8 6206.0 18:56:31 INFO - PID 25919 | 18:56:31 INFO - PID 25919 | [#5] yui.html Cycles:180 Average:23451.21 Median:20163.24 stddev:32015.16 (158.8%) stddev-sans-first:32060.16 18:56:31 INFO - PID 25919 | Values: 891.8 922.7 928.8 936.7 941.4 18277.4 19253.6 19269.0 19280.2 19325.4 19836.6 21733.0 21870.1 21878.2 21897.5 1014.8 1034.9 1036.4 1039.2 1039.3 977.4 1054.8 1063.5 1067.4 1068.0 1097.7 1105.9 1111.3 1114.0 1116.1 1086.9 1099.9 1099.9 1100.6 1101.0 794.3 802.5 809.0 812.8 812.9 19809.0 20206.4 20369.6 20455.3 20478.8 20600.1 20710.9 21003.4 21106.8 21871.8 16092.1 16395.2 16462.6 16621.0 16699.5 3602.0 3635.3 3637.2 3637.3 3641.0 123824.4 124923.4 129456.0 129993.4 130274.3 16098.1 16412.0 16661.8 16790.2 16863.5 27987.0 28138.0 30520.8 30795.5 30842.5 8197.5 8232.8 8313.3 8328.8 8332.5 3824.2 3896.8 3921.1 3931.0 3932.4 4983.4 5123.3 5150.9 5172.7 5183.6 980.4 1010.3 1017.5 1019.8 1027.0 677.1 697.7 708.8 711.0 719.7 11064.6 11124.9 11347.9 11382.4 11454.5 678.0 698.4 707.7 707.9 714.8 5012.9 5839.5 5891.1 5995.4 6335.9 103923.5 108529.5 109420.5 113665.0 118694.4 93510.0 95373.0 97341.5 97725.5 100126.0 87251.0 87627.3 89325.6 91813.0 91994.0 11381.0 11939.2 11998.5 12416.3 12491.7 35740.8 37331.4 37636.0 38747.2 39519.0 48335.3 48842.3 50032.0 68124.0 68747.0 16309.5 17178.4 17247.9 18109.5 18683.6 20370.8 20418.5 20451.6 21622.9 22200.8 18330.6 19451.3 19729.6 19849.6 20120.1 17359.6 17611.6 17790.0 18368.2 18909.3 18090.8 18408.9 18487.9 18560.9 18602.5 12632.2 12728.5 13078.2 13685.0 13860.2 13591.9 13696.2 13779.9 14259.2 14673.0 18:56:31 INFO - PID 25919 | -------- Summary: end -------- 18:56:31 INFO - PID 25919 | 18:56:31 INFO - TEST-INFO | 25919: exit 0 18:56:31 INFO - TEST-OK | dromaeo_css | took 1114181ms 18:56:31 INFO - TEST-START | kraken 18:56:31 INFO - Initialising browser for kraken test... 18:56:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47296/getInfo.html -profile /tmp/tmpj6f7Sl/profile 18:56:31 INFO - TEST-INFO | started process 26297 (/builds/slave/test/build/application/firefox/firefox http://localhost:47296/getInfo.html) 18:56:38 INFO - TEST-INFO | 26297: exit 0 18:56:38 INFO - Browser initialized. 18:56:38 INFO - Running cycle 1/1 for kraken test... 18:56:38 INFO - TEST-INFO | started process 26528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6f7Sl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:49 INFO - PID 26528 | RSS: Main: 177131520 18:56:49 INFO - PID 26528 | 18:56:52 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection) 18:56:53 INFO - PID 26528 | RSS: Main: 181329920 18:56:53 INFO - PID 26528 | 18:56:56 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-dft) 18:56:56 INFO - PID 26528 | RSS: Main: 181911552 18:56:56 INFO - PID 26528 | 18:56:59 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-fft) 18:57:00 INFO - PID 26528 | RSS: Main: 176754688 18:57:00 INFO - PID 26528 | 18:57:02 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator) 18:57:03 INFO - PID 26528 | RSS: Main: 177565696 18:57:03 INFO - PID 26528 | 18:57:05 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:05 INFO - PID 26528 | RSS: Main: 177844224 18:57:05 INFO - PID 26528 | 18:57:09 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:09 INFO - PID 26528 | RSS: Main: 180289536 18:57:09 INFO - PID 26528 | 18:57:13 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:13 INFO - PID 26528 | RSS: Main: 180056064 18:57:13 INFO - PID 26528 | 18:57:16 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial) 18:57:17 INFO - PID 26528 | RSS: Main: 180805632 18:57:17 INFO - PID 26528 | 18:57:18 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:57:19 INFO - PID 26528 | RSS: Main: 180826112 18:57:19 INFO - PID 26528 | 18:57:21 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:57:22 INFO - PID 26528 | RSS: Main: 180494336 18:57:22 INFO - PID 26528 | 18:57:24 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:57:24 INFO - PID 26528 | RSS: Main: 180957184 18:57:24 INFO - PID 26528 | 18:57:27 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:57:28 INFO - PID 26528 | RSS: Main: 181194752 18:57:28 INFO - PID 26528 | 18:57:31 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:57:32 INFO - PID 26528 | RSS: Main: 181157888 18:57:32 INFO - PID 26528 | 18:57:33 INFO - PID 26528 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47296/tests/kraken/driver.html?testName=ai-astar) 18:57:34 INFO - PID 26528 | RSS: Main: 182808576 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | __start_tp_report 18:57:34 INFO - PID 26528 | _x_x_mozilla_page_load 18:57:34 INFO - PID 26528 | _x_x_mozilla_page_load_details 18:57:34 INFO - PID 26528 | |i|pagename|runs| 18:57:34 INFO - PID 26528 | |0;ai-astar;99;110;102;109;118;111;120;100;108;115 18:57:34 INFO - PID 26528 | |1;audio-beat-detection;154;118;142;171;130;145;147;127;176;118 18:57:34 INFO - PID 26528 | |2;audio-dft;163;163;164;163;173;163;168;168;162;165 18:57:34 INFO - PID 26528 | |3;audio-fft;79;77;75;172;78;77;76;77;173;75 18:57:34 INFO - PID 26528 | |4;audio-oscillator;81;84;136;83;80;81;133;81;81;136 18:57:34 INFO - PID 26528 | |5;imaging-gaussian-blur;118;117;116;115;113;114;114;115;114;114 18:57:34 INFO - PID 26528 | |6;imaging-darkroom;152;152;151;150;149;151;152;153;151;150 18:57:34 INFO - PID 26528 | |7;imaging-desaturate;96;95;94;95;93;94;95;94;95;94 18:57:34 INFO - PID 26528 | |8;json-parse-financial;54;54;55;56;56;58;56;55;55;55 18:57:34 INFO - PID 26528 | |9;json-stringify-tinderbox;54;55;54;55;54;54;54;55;54;57 18:57:34 INFO - PID 26528 | |10;stanford-crypto-aes;83;80;80;80;78;78;82;78;93;78 18:57:34 INFO - PID 26528 | |11;stanford-crypto-ccm;130;131;127;131;139;123;137;130;126;174 18:57:34 INFO - PID 26528 | |12;stanford-crypto-pbkdf2;179;186;183;176;184;177;185;195;184;185 18:57:34 INFO - PID 26528 | |13;stanford-crypto-sha256-iterative;71;69;69;74;68;71;68;69;68;67 18:57:34 INFO - PID 26528 | __end_tp_report 18:57:34 INFO - PID 26528 | __start_cc_report 18:57:34 INFO - PID 26528 | _x_x_mozilla_cycle_collect,969 18:57:34 INFO - PID 26528 | __end_cc_report 18:57:34 INFO - PID 26528 | __startTimestamp1500688654080__endTimestamp 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | ------- Summary: start ------- 18:57:34 INFO - PID 26528 | Number of tests: 14 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#0] ai-astar Cycles:10 Average:109.20 Median:113.00 stddev:7.25 (6.4%) stddev-sans-first:6.69 18:57:34 INFO - PID 26528 | Values: 99.0 110.0 102.0 109.0 118.0 111.0 120.0 100.0 108.0 115.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:146.00 stddev:20.25 (13.9%) stddev-sans-first:21.07 18:57:34 INFO - PID 26528 | Values: 154.0 118.0 142.0 171.0 130.0 145.0 147.0 127.0 176.0 118.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.46 (2.1%) stddev-sans-first:3.57 18:57:34 INFO - PID 26528 | Values: 163.0 163.0 164.0 163.0 173.0 163.0 168.0 168.0 162.0 165.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#3] audio-fft Cycles:10 Average:95.90 Median:77.00 stddev:40.39 (52.5%) stddev-sans-first:42.38 18:57:34 INFO - PID 26528 | Values: 79.0 77.0 75.0 172.0 78.0 77.0 76.0 77.0 173.0 75.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:81.00 stddev:25.85 (31.9%) stddev-sans-first:26.71 18:57:34 INFO - PID 26528 | Values: 81.0 84.0 136.0 83.0 80.0 81.0 133.0 81.0 81.0 136.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.56 (1.4%) stddev-sans-first:1.22 18:57:34 INFO - PID 26528 | Values: 118.0 117.0 116.0 115.0 113.0 114.0 114.0 115.0 114.0 114.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:1.20 (0.8%) stddev-sans-first:1.22 18:57:34 INFO - PID 26528 | Values: 152.0 152.0 151.0 150.0 149.0 151.0 152.0 153.0 151.0 150.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 18:57:34 INFO - PID 26528 | Values: 96.0 95.0 94.0 95.0 93.0 94.0 95.0 94.0 95.0 94.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.13 18:57:34 INFO - PID 26528 | Values: 54.0 54.0 55.0 56.0 56.0 58.0 56.0 55.0 55.0 55.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:1.00 18:57:34 INFO - PID 26528 | Values: 54.0 55.0 54.0 55.0 54.0 54.0 54.0 55.0 54.0 57.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:4.57 (5.7%) stddev-sans-first:4.79 18:57:34 INFO - PID 26528 | Values: 83.0 80.0 80.0 80.0 78.0 78.0 82.0 78.0 93.0 78.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:131.00 stddev:14.57 (11.1%) stddev-sans-first:15.35 18:57:34 INFO - PID 26528 | Values: 130.0 131.0 127.0 131.0 139.0 123.0 137.0 130.0 126.0 174.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:184.50 stddev:5.40 (2.9%) stddev-sans-first:5.49 18:57:34 INFO - PID 26528 | Values: 179.0 186.0 183.0 176.0 184.0 177.0 185.0 195.0 184.0 185.0 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:2.07 (3.0%) stddev-sans-first:2.11 18:57:34 INFO - PID 26528 | Values: 71.0 69.0 69.0 74.0 68.0 71.0 68.0 69.0 68.0 67.0 18:57:34 INFO - PID 26528 | -------- Summary: end -------- 18:57:34 INFO - PID 26528 | 18:57:34 INFO - PID 26528 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:57:34 INFO - TEST-INFO | 26528: exit 0 18:57:34 INFO - TEST-OK | kraken | took 62948ms 18:57:34 INFO - SUITE-END | took 1177s 18:57:35 INFO - Completed test suite (00:19:37) 18:57:35 INFO - javascript benchmark 18:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8459.192595379967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.250659841637, 3149.5118256670225, 3159.0838656789533, 3167.5407065975432, 3171.0169847347324, 6059.151718759377, 6107.419795119462, 6107.541934354925, 6154.784582539612, 6268.529860260487, 6181.536384771138, 6210.503159747221, 6216.968915155429, 6274.403931626488, 6277.780277690282, 5437.184422336662, 5561.499465048145, 5658.094704847225, 5667.603267771257, 5774.855628609276, 5576.721163941807, 5603.411641777616, 5615.971920140393, 5665.971670141664, 5688.857778555528, 5610.971945140269, 5687.459691329317, 5702.344230413514, 5708.400617935098, 5723.427657234285, 5498.3127109111365, 5595.076812325961, 5615.382307946123, 5662.065759149736, 5679.318481782171, 5513.365962914236, 5515.338159420855, 5591.245181900432, 5610.831675049755, 5618.943810561883, 6095.481884039862, 6122.877542449126, 6124.081387791823, 6133.447989680905, 6136.355682653302, 6558.80323590293, 6639.170103737033, 6646.10277612521, 6646.833829154261, 6666.333366663295, 6631.801045968628, 6702.698378572976, 6727.831804204885, 6738.561993470409, 6761.8647627047185, 6133.1413602095745, 6141.477974372184, 6233.657148856811, 6239.126522286883, 6245.344238854946, 6534.607923524603, 6679.198496180489, 6690.832729181712, 6775.457963362919, 6924.0, 6516.934830651728, 6541.672916354163, 6564.409203171737, 6565.113709649137, 6587.769428069994, 6596.373344532261, 6597.1423714916755, 6686.5653732507235, 6687.398134167851, 6694.02936574194, 6539.901901471481, 6564.048213009087, 6645.335466453316, 6659.101021362151, 6673.332666733288, 6434.774782882577, 6540.215174179129, 6552.901706474407, 6611.975143852711, 6674.16572928384, 5270.472952704776, 5333.0, 5335.626506144533, 5337.412884582693, 5340.0, 4526.751028693454, 4528.139653465831, 4565.315202719618, 4571.017231295221, 4601.838935637304, 5607.831765047055, 5676.460736230051, 5704.971475142598, 5712.65724056558, 5720.08478643415, 6479.773207937699, 6579.934200658028, 6590.0, 6694.732210711614, 6747.898781518281, 5741.425857414225, 5762.135679648002, 5778.884422311614, 5787.88424231513, 5795.710214489259, 5706.771729130871, 5783.2192653992015, 5870.207521984477, 5877.647341159544, 5911.349751527328, 6240.126382306572, 6324.873502529832, 6409.519286053564, 6425.228972523327, 6541.8364540885905, 6574.967125164344, 6652.966735166293, 6656.23453302857, 6683.231428385798, 6687.565308254948, 6354.841128971812, 6435.0, 6441.67791610427, 6451.354864513699, 6457.063725759833, 6442.35576442352, 6448.967755161194, 6486.156799616208, 6488.967555162383, 6557.672116394257, 6493.350664933469, 6562.5406221565945, 6583.913654246996, 6584.703688333941, 6602.40578347951, 6443.097966284818, 6451.870962580629, 6479.935200647933, 6490.610563366213, 6501.44737697301, 6402.455791257796, 6437.002264648987, 6497.415232629086, 6507.642079685663, 6509.121268628674, 6332.588381755171, 6351.650659213788, 6405.2313722351755, 6428.228612566522, 6436.67816609177, 6282.0, 6366.840828979312, 6421.839454013687, 6492.675366231575, 6492.837679058061, 6225.346338634378, 6274.717637706223, 6276.435120839146, 6295.92969195247, 6304.873902521832], "value": 6029.476200886318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.456909041857, 725.51753084199, 742.888566714993, 743.4721347843031, 744.4639859301301, 31440.0, 31959.0, 41081.79459102704, 41449.75650730475, 41555.58444415555, 41404.17191656165, 41979.79010104945, 42049.15901681964, 42172.0, 42262.15475690484, 7497.850042999136, 7615.504992175519, 7629.313361797437, 7629.427792915526, 7640.541567505968, 7473.6263186840715, 7565.2812982766545, 7568.39452843774, 7573.886391704129, 7583.203763604824, 7583.27958843909, 7627.961860190691, 7629.084509858797, 7645.541267523939, 7649.847003059936, 7479.962600187018, 7602.8479430411635, 7604.201558836297, 7611.467197296191, 7617.542947423172, 7393.149787774367, 7455.701771929116, 7473.925260747377, 7475.962620186919, 7477.513961592534, 37415.0, 37798.81100594507, 37915.24169516594, 37946.241075178616, 37955.810220948995, 3519.472079188117, 3528.964710352889, 3541.752077354586, 3547.6984456321243, 3547.8580856765698, 29108.563371549444, 29117.0, 29193.708062919522, 29220.853895730386, 29239.122826315244, 4723.622110231173, 4763.523647635244, 4794.0, 4820.084184005028, 4866.46468888422, 177603.0, 178519.0, 180482.0, 181454.0, 182099.0, 44778.55221447809, 44885.0, 45066.54933450689, 45153.0, 45221.738913054214, 46176.0, 46422.767886160356, 46435.0, 46465.0, 46558.76720616375, 15105.3202605883, 15381.692366152614, 15384.153871537173, 15398.153101579297, 15403.22983850803, 12705.983521318272, 12714.11001229905, 12716.554920577735, 12717.427715752814, 12723.618291451086, 13074.346282685829, 13090.738185236432, 13150.408231629599, 13269.402876870565, 13372.130811497416, 5247.396549396868, 5259.105951988171, 5275.973620131875, 5355.22349259363, 5385.542228910508, 972.1396564040733, 985.551239677687, 987.1461186073994, 992.836182029957, 1028.3829702178632, 22720.886395567915, 23230.3030909073, 23442.296731097755, 23610.111191104672, 23686.881565592063, 1096.5668560918393, 1104.5747387255965, 1114.3759494683004, 1124.9493772780245, 1126.3298337489182, 11829.585964491374, 12343.753124937452, 12399.938000309941, 12461.878430941077, 12546.68633284157, 225314.0, 225504.0, 225827.0, 230313.0, 233721.0, 54283.45716542863, 54285.0, 54426.45573544293, 54548.18177727258, 54567.18149227765, 1442.9855701443062, 1482.3699927530972, 1490.1878476230481, 1496.0873866941158, 1508.947186848477, 26380.20859374222, 27319.590206146528, 27509.44981100327, 27626.171214863585, 27647.170584882486, 37039.44440833336, 37120.257594848496, 37121.0, 37188.44217336688, 37197.0, 192933.0, 193549.0, 194638.0, 195511.0, 196026.0, 33356.332873342886, 35885.820570896976, 36959.63040369562, 36972.26055478821, 36982.63017369792, 46567.53432465632, 46626.76686616545, 47031.29453058275, 47183.528164717914, 47549.0, 33533.664663353054, 33676.663233367355, 34324.0, 34344.82827585846, 35208.823955880056, 32058.0, 32859.50710739293, 34065.14837129092, 34103.82948085244, 34729.82635086808, 35850.282994339446, 36762.63237367592, 37377.62622373742, 37420.0, 37518.624813751514, 32384.190395240308, 32534.186645334055, 33063.17342066467, 33107.50338744873, 33250.667493324756, 23769.762302376756, 24619.015239390224, 24693.135740249007, 24911.252662420156, 25318.620220697074], "value": 16966.634198286898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5545130249708, 582.3332284534208, 582.3937877995966, 598.4703537369427, 620.2959640807683, 22394.77605223947, 23232.88383558084, 23331.533369332603, 23343.649845252294, 23360.76639233607, 25574.232773016793, 26555.336116597096, 26640.733592664066, 26659.86670066647, 26665.0, 6522.673866306677, 6667.366600173, 6687.06381106643, 6701.229358623772, 6710.563813352116, 6498.155239818817, 6592.241892182388, 6667.566608170478, 6963.825904352381, 7041.049458323112, 7009.579425234477, 7021.087258656393, 7027.156741191065, 7043.084399028119, 7045.89431158533, 6986.0, 6991.720331186746, 7014.403775679073, 7038.19060808006, 7042.2957704229675, 6830.521863469559, 6865.107536020335, 6865.9313406866295, 6878.140232470942, 6887.793366198972, 30812.0, 31088.0, 31125.221869453217, 31213.531797022835, 31530.369392612018, 1980.9702854457194, 2033.8169564739244, 2040.102354963826, 2040.7653119891106, 2044.1108117968583, 19066.52333691655, 19994.600107997903, 20114.69827952582, 20138.0, 20150.29473968419, 2380.940476488084, 2463.334899577122, 2531.4430825218424, 2545.058328418497, 2545.6945166579944, 131652.0, 135224.0, 136325.0, 136834.0, 137115.0, 20048.59902801936, 21795.34613961584, 21946.89026554857, 22319.665205021938, 22414.0, 22869.19957801469, 23775.52448951046, 23847.569145851303, 23876.64185037226, 44554.33168502475, 10385.169186465064, 10595.94702026485, 10611.469426528643, 10650.201234907412, 10889.83665245022, 9761.463119528495, 9893.505324733735, 9894.55474503649, 9996.300258981946, 10044.447555384524, 9197.172254497127, 9338.252939764803, 9345.579448924815, 9379.906200937903, 9670.323077384657, 2741.684706258766, 2762.748360086523, 2821.4357128573956, 2835.517961946474, 2873.8988295774748, 936.9390989585655, 955.6129767444057, 968.2350942755145, 985.6303886042734, 992.9900700993043, 19655.312064077687, 19676.70484942727, 19724.30964916221, 19751.209951601773, 20168.89915550413, 982.8181786369545, 1011.8330475471612, 1028.0695970147028, 1049.5172220778527, 1054.7679510507676, 10295.433751143759, 10444.112250458797, 10526.842047374783, 11032.172587056002, 11063.778724425467, 470458.0, 474992.0, 480879.0, 498585.0, 501863.0, 119747.0, 124226.0, 125200.0, 126491.0, 127803.0, 1235.7590269897464, 1260.5336025670376, 1286.5175559165314, 1292.6602848843436, 1294.087668193921, 19993.400197994084, 20207.898960505692, 20700.792992069888, 21135.78864211338, 21345.35963921085, 54681.0, 55916.72041639766, 57299.14051289151, 57732.0, 58453.415465844795, 67659.32340676727, 72275.63862180866, 74709.25290747023, 75351.62324188344, 77174.0, 14494.130352178903, 15044.247787610357, 15156.242187890783, 15225.543233703007, 15237.009594376774, 23717.288481345586, 23734.406639834142, 23752.168674096323, 23871.64192537148, 24054.0, 18612.0, 18826.811731882506, 18969.43091707251, 19146.23415063382, 19217.711734324275, 15905.0, 16189.0, 16684.58288542796, 17091.829081709024, 17783.28866845312, 18866.24535018584, 19013.71479427782, 19367.12847921875, 19431.4170574883, 19550.8044919549, 14874.925625372236, 14887.330070146652, 14891.851081489047, 14892.106473611619, 14897.329620166902, 18055.909720451313, 18849.71725424147, 18862.622747545247, 19043.0, 19082.61834763269], "value": 12529.385550974519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.9736205275894, 1372.9063178652555, 1386.2722070912773, 1390.2492653966858, 1391.770357890948, 13296.46814127435, 13298.867011329883, 14042.508512202076, 14055.437782488689, 14083.295835208224, 13522.391492382842, 13743.725125497509, 13761.311934403266, 13790.655233619165, 13832.861671383309, 2645.7486538778835, 2685.355514676483, 2697.541417958942, 2699.2442116207494, 2704.148193319108, 2597.1559243245924, 2645.140329392945, 2662.6671666041743, 2663.400734834666, 2715.904943326984, 2658.3752818087733, 2696.7842572594245, 2698.892044318225, 2704.2428120126397, 2707.2149076767714, 2556.5398228318895, 2604.1536500637276, 2648.430587423694, 2694.0974773450916, 2694.393761403688, 2580.4194056337174, 2586.7671909528044, 2587.1591732686766, 2604.231751633273, 2612.6472926154916, 13116.409761560753, 13477.730445391036, 13543.322833858367, 13587.52443664477, 13712.862871371259, 7563.962180189119, 7860.253275938834, 7865.9606701966695, 7874.763757087297, 7878.4485086044, 5171.948280517222, 5329.946700532983, 5343.679379237219, 5470.972645136749, 5471.234027236151, 1787.731840223964, 1814.9818501814946, 1819.4541637508826, 1865.7574515312922, 1872.4008317338457, 22087.779122208893, 22682.54634907309, 22733.318000460014, 22749.43126421836, 22831.31506054821, 6797.0, 6896.379325860697, 7001.754938577125, 7102.573845569283, 7105.573665580082, 17266.740998885027, 17435.912820435817, 17455.912720436318, 17731.911340443214, 17798.46604601838, 7687.884681729778, 7946.523208607502, 7957.3634109271115, 7962.084360298524, 7971.960140199262, 6737.225219099768, 6931.930680693229, 6966.512344135963, 7104.751333703295, 7123.82190445243, 5363.19552067193, 5467.152591348347, 5515.338159420815, 5525.723713814374, 5562.666240025531, 1583.6990971715338, 1663.642316901872, 1696.8897021693551, 1704.5568152280248, 1734.6357264974245, 873.7073080518097, 874.9387542871938, 894.7226359828474, 894.7539426657592, 913.5660561233361, 6688.3646053624825, 7428.591427471541, 7473.626318684044, 7682.654280557388, 7777.5722335270975, 923.2567782934668, 943.7357539888842, 956.6556039825657, 987.9703608891745, 999.205631522941, 4388.2320593896575, 4553.886152846206, 4617.8845528861375, 5004.149294619923, 5179.04187725272, 18068.457946261635, 18455.354062608014, 18484.0, 18773.81226187748, 18826.152823122993, 16991.660166796595, 18068.548286292684, 18073.45779626613, 18158.364457243933, 18417.723734143998, 10232.53953572091, 10474.319169253975, 10498.527566259536, 10520.473976301308, 10539.736506587396, 7330.560166390033, 7385.372243359375, 7478.4765066444825, 7615.771526854203, 8221.30118939873, 15330.846691533388, 15487.070775753491, 15598.9220053899, 15771.526854194393, 15963.44127955516, 15514.224288785741, 15702.450414235447, 15975.360985560448, 16174.595635109217, 16184.838151618333, 10604.628837990633, 10699.572017119228, 10999.780004399707, 11114.666560003212, 11130.777384452427, 12324.753504929671, 12336.691582710504, 12418.192817467198, 12518.874811252135, 12560.560380386643, 9880.703578892644, 10406.947965260428, 10420.0, 10436.16510679159, 10605.946970265099, 9814.214862810815, 9876.753081173028, 9919.553620086968, 10108.292419530562, 10120.240981926238, 8816.779580510538, 8837.204651581389, 8882.333824963025, 8896.065913079292, 8914.242289405214, 6427.421532062137, 6808.659567021728, 6882.4149947253045, 6959.304069593, 7083.504154709327, 6224.9377506224355, 6659.600423974577, 6670.699818508082, 6843.939189425647, 6869.141357330333], "value": 6287.089141043175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.69793181329845, 491.3833139410041, 516.0891027336754, 522.9529342359189, 523.6700878446578, 5922.200502932103, 6050.152978582996, 6093.146959425684, 6129.536811701391, 6130.540209484284, 5934.0, 5938.792142275021, 6075.665838378898, 6089.6955152242435, 6111.388861113886, 5063.974680126595, 5091.974540127313, 5101.923471147936, 5110.850058736792, 5122.641415100945, 5105.5660268877, 5112.488751124895, 5119.976004799055, 5139.25480805283, 5170.844874653766, 4779.952200477986, 4878.243872199815, 4885.31605575218, 4887.629499692646, 4936.259561065851, 4807.687500312503, 4809.639277054217, 4833.042617739803, 4917.655764096515, 4953.9504604953845, 4423.225935461282, 4424.911501769947, 4429.291313389875, 4437.29003359461, 4444.35556844259, 5959.970200148971, 5961.254843144607, 5977.402259774031, 6006.969965150146, 6052.243469566304, 5653.632513886584, 5668.093105103205, 5678.801241956512, 5695.658260504383, 5705.5435565154685, 6382.680865956683, 6400.575692004755, 6425.261094974091, 6455.419012288917, 6469.74121035158, 4799.9760001199775, 4801.447833499157, 4803.951960480385, 4825.155597770411, 4825.252085926687, 6758.121444212221, 6780.694868730919, 6842.726290948406, 6843.520953533254, 6880.8967865482055, 4864.537868902448, 4925.482824303396, 4947.851564453073, 4960.751962401865, 4988.127077761377, 4999.600031997432, 5007.949920500749, 5022.522860328263, 5033.1695270280725, 5051.3433253676785, 5610.523105535994, 5663.745131469093, 5666.716664166857, 5700.945325114867, 5712.685802280831, 6326.873462530723, 6336.52476064297, 6369.649669268235, 6422.0, 6466.579672321378, 1644.1368281652228, 1676.4467725650507, 1699.5751062234442, 1741.1207340293072, 1759.8240175982298, 1197.8083506638895, 1209.8124790657462, 1212.2241765270235, 1214.1379620469565, 1229.1334609100563, 5579.0, 5631.465010823965, 5656.745446454919, 5666.433356664301, 5679.971600141973, 6263.3736626337, 6436.388543088399, 6490.837729056811, 6521.282658907517, 6559.4752419807255, 5596.188552659842, 5636.915446268309, 5647.604667673306, 5666.0, 5689.516391106802, 3497.1082373994977, 3504.2641045380246, 3519.59524654668, 3525.7355698322726, 3533.593636731757, 6399.872002559922, 6442.291347951722, 6458.483321334282, 6460.967695161494, 6503.577267477599, 6811.318868113149, 6821.181458224945, 6830.556013859084, 6837.623930683761, 6845.247022827485, 6369.172007638977, 6415.230172379344, 6432.35676432353, 6437.130987316746, 6462.192225971754, 6474.0, 6568.113304703995, 6572.244191917799, 6661.933380666132, 6667.233268174028, 6502.252240992347, 6510.851419031803, 6522.478201743944, 6555.918718202437, 6648.268690444144, 6325.292171113865, 6383.87232255343, 6385.23377194721, 6404.391582799627, 6470.838229044311, 4870.269459581091, 4916.360873086476, 4945.282933974626, 4950.801967921243, 4970.204767237225, 6578.572392794453, 6597.175353080865, 6636.0, 6679.664067186679, 6686.498512611671, 6327.303996560467, 6360.332165122595, 6392.9360706392345, 6419.358064193543, 6450.290468048604, 6122.816315510542, 6264.154339164154, 6307.653079080695, 6326.272478665012, 6413.294537600954, 6050.667213303311, 6125.111858780363, 6259.78090766821, 6269.467095296951, 6338.619682819046, 6409.391107844747, 6428.871422571616, 6446.548741588232, 6450.774222902176, 6454.644994525346, 6143.539234557336, 6159.4456498915315, 6166.4758495526585, 6190.81427557174, 6205.968970155121], "value": 4978.113258728669, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.7904292491268, 922.7139586728115, 928.8374534456468, 936.6815282803846, 941.4022095969058, 18277.360292389752, 19253.614927701474, 19268.99999999998, 19280.228790848385, 19325.420237392882, 19836.60326793463, 21733.0, 21870.125194992223, 21878.23426180084, 21897.452563685914, 1014.8274793285141, 1034.9482525873714, 1036.3937096798345, 1039.1686650679426, 1039.2569312941246, 977.4037836919473, 1054.7890421915608, 1063.489525027987, 1067.3542506783401, 1068.0280944340652, 1097.736543229623, 1105.8894110588917, 1111.3276467736985, 1114.0, 1116.1461481966303, 1086.929349592278, 1099.8515200447916, 1099.8845121262232, 1100.5927806711568, 1101.0255923507752, 794.2732399854126, 802.4944285100349, 809.0, 812.7683610171073, 812.8699408094676, 19809.0, 20206.393808185778, 20369.5926081479, 20455.2840650578, 20478.795212047837, 20600.072996715186, 20710.896445517676, 21003.369898903056, 21106.78893211079, 21871.781282187134, 16092.114933678644, 16395.180240988022, 16462.588435289093, 16621.0, 16699.499015029567, 3602.045457953618, 3635.272945410902, 3637.163452405935, 3637.2725454909123, 3640.981795091034, 123824.38087809594, 124923.3753831225, 129456.0, 129993.35003325017, 130274.34862825625, 16098.114603696675, 16412.0, 16661.750073748903, 16790.244439000275, 16863.494095177164, 27987.0, 28138.0, 30520.847395762878, 30795.538066929013, 30842.53736193959, 8197.549134797524, 8232.794180145425, 8313.33493320533, 8328.791780205544, 8332.458390204618, 3824.2351529694174, 3896.805159742058, 3921.137349783043, 3930.9975956131575, 3932.390479475686, 4983.401991760939, 5123.257127716534, 5150.871228219249, 5172.663776854568, 5183.611229157828, 980.352967041749, 1010.3129871687323, 1017.5370206555999, 1019.8215312320315, 1027.0448482910965, 677.1298880938069, 697.6720941157648, 708.8334241453255, 710.9751158709421, 719.70851805018, 11064.557417703363, 11124.888751112385, 11347.886521134847, 11382.430878456209, 11454.541818327174, 677.9661016949133, 698.4238003647012, 707.6532499075416, 707.8690442268197, 714.7677004973405, 5012.924806127911, 5839.503642190376, 5891.05743081105, 5995.400459953969, 6335.936640633535, 103923.4803825976, 108529.45735271431, 109420.4528977366, 113665.0, 118694.40652796681, 93510.0, 95373.0, 97341.5132924345, 97725.51137244268, 100126.0, 87251.0, 87627.25564189468, 89325.55337223402, 91813.0, 91994.0, 11381.0, 11939.164258501822, 11998.520059197534, 12416.317102559446, 12491.687707807378, 35740.82129589439, 37331.440028399054, 37636.0, 38747.22505549929, 39519.0, 48335.27497087617, 48842.26736598883, 50032.0, 68124.0, 68747.0, 16309.51071467858, 17178.39875604348, 17247.913760431118, 18109.456716298533, 18683.626327473645, 20370.79629203748, 20418.489537761674, 20451.590968180255, 21622.89188554047, 22200.777992220515, 18330.633387332444, 19451.3192038278, 19729.605407891475, 19849.603007939473, 20120.094595743518, 17359.56601084983, 17611.55971100733, 17790.0, 18368.17343219585, 18909.338173163873, 18090.819091808913, 18408.907955460138, 18487.90756046265, 18560.907195463937, 18602.534936626693, 12632.242065475733, 12728.490860365482, 13078.215307081226, 13685.0, 13860.237686927316, 13591.932040339734, 13696.178229306273, 13779.862201378259, 14259.215743134228, 14673.0], "value": 9133.262102349416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 102.0, 109.0, 118.0, 111.0, 120.0, 100.0, 108.0, 115.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 118.0, 142.0, 171.0, 130.0, 145.0, 147.0, 127.0, 176.0, 118.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 173.0, 163.0, 168.0, 168.0, 162.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 75.0, 172.0, 78.0, 77.0, 76.0, 77.0, 173.0, 75.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 136.0, 83.0, 80.0, 81.0, 133.0, 81.0, 81.0, 136.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 150.0, 149.0, 151.0, 152.0, 153.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 93.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 56.0, 56.0, 58.0, 56.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 57.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 80.0, 78.0, 78.0, 82.0, 78.0, 93.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 127.0, 131.0, 139.0, 123.0, 137.0, 130.0, 126.0, 174.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 186.0, 183.0, 176.0, 184.0, 177.0, 185.0, 195.0, 184.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 74.0, 68.0, 71.0, 68.0, 69.0, 68.0, 67.0], "value": 69.4, "unit": "score"}]}]} 18:57:35 INFO - Return code: 0 18:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:57:35 INFO - # TBPL SUCCESS # 18:57:35 INFO - Running post-action listener: _package_coverage_data 18:57:35 INFO - Running post-action listener: _resource_record_post_action 18:57:35 INFO - [mozharness: 2017-07-22 01:57:35.361932Z] Finished run-tests step (success) 18:57:35 INFO - Running post-run listener: _resource_record_post_run 18:57:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436457472; Read time: 16; Write time: 356352 18:57:35 INFO - TinderboxPrint: CPU usage
13.1% 18:57:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:57:35 INFO - TinderboxPrint: I/O write bytes / time
436,457,472 / 356,352 18:57:35 INFO - TinderboxPrint: CPU idle
8,280.6 (86.8%) 18:57:35 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 18:57:35 INFO - TinderboxPrint: Swap in / out
0 / 0 18:57:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107372544; Read time: 0; Write time: 101432 18:57:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:57:35 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 329084928; Read time: 0; Write time: 254920 18:57:35 INFO - Running post-run listener: _upload_blobber_files 18:57:35 INFO - Blob upload gear active. 18:57:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:57:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:57:36 INFO - (blobuploader) - INFO - Open directory for files ... 18:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:37 INFO - (blobuploader) - INFO - Done attempting. 18:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:38 INFO - (blobuploader) - INFO - Done attempting. 18:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:38 INFO - (blobuploader) - INFO - Done attempting. 18:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:42 INFO - (blobuploader) - INFO - Done attempting. 18:57:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:57:42 INFO - Return code: 0 18:57:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:57:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:57:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9233df178bc9049f0719efada9c337c7186455a4d22761bd63829223311cf1a45faaba1334e80539af436f2d2391a65d0fb5c59f95e294304b24ada2e22a6871", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17580421ec7476088d809093c690b880f7476b0735934ab677f6803361ee7fb156fd274408f6d308784139dc5f418b83272f379f23fa579a2a0b1c0370ce44ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8df619ceafd745bdfa6a678c575cbd774625190ccce4567c38019649c5e6f0d8a15e5310cb980cf9274b62033863e800e37a6eea40e437f22b6e1188b6ea876", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d20a6a1a7e7a526523464901ba1b1bd06df39ff0d05e6c33d255f64a46e4be3daff9a49cf4bcc5b9956086f6542bc58a9ee00f1b0f833fe9ffd6fc534a05b4df"} 18:57:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:57:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:57:42 INFO - Contents: 18:57:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9233df178bc9049f0719efada9c337c7186455a4d22761bd63829223311cf1a45faaba1334e80539af436f2d2391a65d0fb5c59f95e294304b24ada2e22a6871", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17580421ec7476088d809093c690b880f7476b0735934ab677f6803361ee7fb156fd274408f6d308784139dc5f418b83272f379f23fa579a2a0b1c0370ce44ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8df619ceafd745bdfa6a678c575cbd774625190ccce4567c38019649c5e6f0d8a15e5310cb980cf9274b62033863e800e37a6eea40e437f22b6e1188b6ea876", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d20a6a1a7e7a526523464901ba1b1bd06df39ff0d05e6c33d255f64a46e4be3daff9a49cf4bcc5b9956086f6542bc58a9ee00f1b0f833fe9ffd6fc534a05b4df"} 18:57:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:57:42 INFO - Copying logs to upload dir... 18:57:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:57:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.172924 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-21 18:57:42.364808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:42.372362) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9233df178bc9049f0719efada9c337c7186455a4d22761bd63829223311cf1a45faaba1334e80539af436f2d2391a65d0fb5c59f95e294304b24ada2e22a6871", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17580421ec7476088d809093c690b880f7476b0735934ab677f6803361ee7fb156fd274408f6d308784139dc5f418b83272f379f23fa579a2a0b1c0370ce44ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8df619ceafd745bdfa6a678c575cbd774625190ccce4567c38019649c5e6f0d8a15e5310cb980cf9274b62033863e800e37a6eea40e437f22b6e1188b6ea876", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d20a6a1a7e7a526523464901ba1b1bd06df39ff0d05e6c33d255f64a46e4be3daff9a49cf4bcc5b9956086f6542bc58a9ee00f1b0f833fe9ffd6fc534a05b4df"} build_url:https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9233df178bc9049f0719efada9c337c7186455a4d22761bd63829223311cf1a45faaba1334e80539af436f2d2391a65d0fb5c59f95e294304b24ada2e22a6871", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17580421ec7476088d809093c690b880f7476b0735934ab677f6803361ee7fb156fd274408f6d308784139dc5f418b83272f379f23fa579a2a0b1c0370ce44ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8df619ceafd745bdfa6a678c575cbd774625190ccce4567c38019649c5e6f0d8a15e5310cb980cf9274b62033863e800e37a6eea40e437f22b6e1188b6ea876", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d20a6a1a7e7a526523464901ba1b1bd06df39ff0d05e6c33d255f64a46e4be3daff9a49cf4bcc5b9956086f6542bc58a9ee00f1b0f833fe9ffd6fc534a05b4df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:42.404215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:42.404597) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1500686786.437168-1735265575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:42.486227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-21 18:57:42.486614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-21 18:57:42.487006) ========= ========= Total master_lag: 0.39 =========