builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1496773435.93 results: success (0) revision: fe438f1ec216c0269d353df141ea376055f6130c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:55.931142) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:55.931549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:55.931909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:56.031478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:56.031806) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 11:23:56-- 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% 80.2M=0s 2017-06-06 11:23:56 (80.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126479 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:56.188240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:56.188607) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019324 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:56.244194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 11:23:56.244505) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe438f1ec216c0269d353df141ea376055f6130c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe438f1ec216c0269d353df141ea376055f6130c --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=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 11:23:56,569 truncating revision to first 12 chars 2017-06-06 11:23:56,569 Setting DEBUG logging. 2017-06-06 11:23:56,569 attempt 1/10 2017-06-06 11:23:56,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fe438f1ec216?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 11:23:57,336 unpacking tar archive at: mozilla-beta-fe438f1ec216/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 11:23:57.316351) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:57.316735) ========= script_repo_revision: fe438f1ec216c0269d353df141ea376055f6130c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:57.317166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:57.317448) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 11:23:57.330233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-06-06 11:23:57.330632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:23:57 INFO - MultiFileLogger online at 20170606 11:23:57 in /builds/slave/test 11:23:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:23:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:57 INFO - {'append_to_log': False, 11:23:57 INFO - 'base_work_dir': '/builds/slave/test', 11:23:57 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:23:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:57 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:23:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:57 INFO - 'config_files': ('talos/linux_config.py',), 11:23:57 INFO - 'default_actions': ('clobber', 11:23:57 INFO - 'read-buildbot-config', 11:23:57 INFO - 'download-and-extract', 11:23:57 INFO - 'populate-webroot', 11:23:57 INFO - 'create-virtualenv', 11:23:57 INFO - 'install', 11:23:57 INFO - 'run-tests'), 11:23:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:57 INFO - 'download_minidump_stackwalk': True, 11:23:57 INFO - 'download_symbols': 'ondemand', 11:23:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:57 INFO - 'gecko_profile': False, 11:23:57 INFO - 'gecko_profile_interval': 0, 11:23:57 INFO - 'installer_path': 'installer.exe', 11:23:57 INFO - 'log_level': 'info', 11:23:57 INFO - 'log_name': 'talos', 11:23:57 INFO - 'log_to_console': True, 11:23:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:23:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:23:57 INFO - 'opt_config_files': (), 11:23:57 INFO - 'pip_index': False, 11:23:57 INFO - 'suite': 'dromaeojs', 11:23:57 INFO - 'system_bits': '32', 11:23:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:57 INFO - 'title': 'talos-linux64-ix-041', 11:23:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:57 INFO - 'use_talos_json': True, 11:23:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:57 INFO - 'work_dir': 'build'} 11:23:57 INFO - [mozharness: 2017-06-06 18:23:57.752279Z] Running clobber step. 11:23:57 INFO - Running pre-action listener: _resource_record_pre_action 11:23:57 INFO - Running main action method: clobber 11:23:57 INFO - rmtree: /builds/slave/test/build 11:23:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:58 INFO - Running post-action listener: _resource_record_post_action 11:23:58 INFO - [mozharness: 2017-06-06 18:23:58.790356Z] Finished clobber step (success) 11:23:58 INFO - [mozharness: 2017-06-06 18:23:58.790455Z] Running read-buildbot-config step. 11:23:58 INFO - Running pre-action listener: _resource_record_pre_action 11:23:58 INFO - Running main action method: read_buildbot_config 11:23:58 INFO - Using buildbot properties: 11:23:58 INFO - { 11:23:58 INFO - "project": "", 11:23:58 INFO - "product": "firefox", 11:23:58 INFO - "who": "ffxbld@noreply.mozilla.org", 11:23:58 INFO - "installer_path": "public/build/target.tar.bz2", 11:23:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:23:58 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 11:23:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 11:23:58 INFO - "stage_platform": "linux64", 11:23:58 INFO - "basedir": "/builds/slave/test", 11:23:58 INFO - "buildnumber": 58, 11:23:58 INFO - "platform": "ubuntu64_hw", 11:23:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:23:58 INFO - "slavebuilddir": "test", 11:23:58 INFO - "taskId": "MdMpwwYsScWueNtnIvxspw", 11:23:58 INFO - "branch": "mozilla-beta", 11:23:58 INFO - "script_repo_revision": "production", 11:23:58 INFO - "revision": "fe438f1ec216c0269d353df141ea376055f6130c", 11:23:58 INFO - "slavename": "talos-linux64-ix-041", 11:23:58 INFO - "repo_path": "releases/mozilla-beta" 11:23:58 INFO - } 11:23:58 INFO - Finding installer, test and symbols from parent task. 11:23:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdMpwwYsScWueNtnIvxspw'}, attempt #1 11:23:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdMpwwYsScWueNtnIvxspw'}, attempt #1 11:23:59 INFO - Task dependencies: RvrhZSBBQo-QgUQgAmhEqA 11:23:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA'}, attempt #1 11:24:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 11:24:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/test_packages.json 11:24:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.crashreporter-symbols.zip 11:24:00 INFO - Running post-action listener: _resource_record_post_action 11:24:00 INFO - [mozharness: 2017-06-06 18:24:00.140028Z] Finished read-buildbot-config step (success) 11:24:00 INFO - [mozharness: 2017-06-06 18:24:00.140246Z] Running download-and-extract step. 11:24:00 INFO - Running pre-action listener: _resource_record_pre_action 11:24:00 INFO - Running main action method: download_and_extract 11:24:00 INFO - mkdir: /builds/slave/test/build/tests 11:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:00 INFO - trying https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.test_packages.json 11:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:00 INFO - Downloaded 986 bytes. 11:24:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:00 INFO - Using the following test package requirements: 11:24:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:00 INFO - u'common': [u'target.common.tests.zip'], 11:24:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:00 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:00 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:00 INFO - u'target.web-platform.tests.zip'], 11:24:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip 11:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip into memory 11:24:03 INFO - Expected file size: 59712905 11:24:03 INFO - Obtained file size: 59712905 11:24:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip 11:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.common.tests.zip into memory 11:24:14 INFO - Expected file size: 59712905 11:24:14 INFO - Obtained file size: 59712905 11:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.talos.tests.zip 11:24:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:25 INFO - Fetch https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.talos.tests.zip into memory 11:24:26 INFO - Expected file size: 14404461 11:24:26 INFO - Obtained file size: 14404461 11:24: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')]} 11:24:26 INFO - trying https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 11:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:30 INFO - Downloaded 59752675 bytes. 11:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 11:24:30 INFO - mkdir: /builds/slave/test/properties 11:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:30 INFO - Contents: 11:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 11:24:30 INFO - Running post-action listener: _resource_record_post_action 11:24:30 INFO - Running post-action listener: set_extra_try_arguments 11:24:30 INFO - [mozharness: 2017-06-06 18:24:30.133503Z] Finished download-and-extract step (success) 11:24:30 INFO - [mozharness: 2017-06-06 18:24:30.133599Z] Running populate-webroot step. 11:24:30 INFO - Running pre-action listener: _resource_record_pre_action 11:24:30 INFO - Running main action method: populate_webroot 11:24:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:30 INFO - '--tppagecycles', 11:24:30 INFO - '7'], 11:24:30 INFO - 'tests': ['tsvgm']}}, 11:24:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['damp', 'tps']}, 11:24:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'tests': ['damp', 'tps']}, 11:24:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['dromaeo_dom']}, 11:24:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['basic_compositor_video']}, 11:24:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:24:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['a11yr', 11:24:30 INFO - 'ts_paint', 11:24:30 INFO - 'tpaint', 11:24:30 INFO - 'sessionrestore', 11:24:30 INFO - 'sessionrestore_no_auto_restore', 11:24:30 INFO - 'tabpaint']}, 11:24:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['tsvgx', 11:24:30 INFO - 'tsvgr_opacity', 11:24:30 INFO - 'tart', 11:24:30 INFO - 'tscrollx', 11:24:30 INFO - 'cart', 11:24:30 INFO - 'tsvg_static']}, 11:24:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:30 INFO - 'tsvgr_opacity', 11:24:30 INFO - 'tart', 11:24:30 INFO - 'tscrollx', 11:24:30 INFO - 'cart', 11:24:30 INFO - 'tsvg_static']}, 11:24:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'talos_options': ['--disable-e10s'], 11:24:30 INFO - 'tests': ['tp5o']}, 11:24:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'talos_options': ['--disable-e10s', 11:24:30 INFO - '--xperf_path', 11:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:30 INFO - 'tests': ['tp5n']}, 11:24:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:30 INFO - 'talos_options': ['--xperf_path', 11:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:30 INFO - 'tests': ['tp5n']}}, 11:24:30 INFO - 'talos.zip': {'path': '', 11:24:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:30 INFO - Running post-action listener: _resource_record_post_action 11:24:30 INFO - [mozharness: 2017-06-06 18:24:30.154212Z] Finished populate-webroot step (success) 11:24:30 INFO - [mozharness: 2017-06-06 18:24:30.154302Z] Running create-virtualenv step. 11:24:30 INFO - Running pre-action listener: _resource_record_pre_action 11:24:30 INFO - Running main action method: create_virtualenv 11:24:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:30 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 11:24:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:30 INFO - Using real prefix '/usr' 11:24:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:32 INFO - Installing pip.................done. 11:24:32 INFO - Return code: 0 11:24:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:32 INFO - Reading from file tmpfile_stdout 11:24:32 INFO - Output received: 11:24:32 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) 11:24:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:32 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:32 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 11:24:32 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 11:24:32 INFO - Using env: {'DISPLAY': ':0', 11:24:32 INFO - 'HOME': '/home/cltbld', 11:24:32 INFO - 'LANG': 'en_US.UTF-8', 11:24:32 INFO - 'LANGUAGE': 'en_US:en', 11:24:32 INFO - 'LOGNAME': 'cltbld', 11:24:32 INFO - 'MAIL': '/var/mail/cltbld', 11:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:32 INFO - 'MOZ_NO_REMOTE': '1', 11:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:32 INFO - 'NO_EM_RESTART': '1', 11:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:32 INFO - 'PWD': '/builds/slave/test', 11:24:32 INFO - 'SHELL': '/bin/bash', 11:24:32 INFO - 'SHLVL': '1', 11:24:32 INFO - 'TERM': 'linux', 11:24:32 INFO - 'TMOUT': '86400', 11:24:32 INFO - 'USER': 'cltbld', 11:24:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:32 INFO - '_': '/tools/buildbot/bin/python'} 11:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:33 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 11:24:33 INFO - Cleaning up... 11:24:33 INFO - Return code: 0 11:24:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:33 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')]} 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:33 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')]} 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:33 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:33 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 11:24:33 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 11:24:33 INFO - Using env: {'DISPLAY': ':0', 11:24:33 INFO - 'HOME': '/home/cltbld', 11:24:33 INFO - 'LANG': 'en_US.UTF-8', 11:24:33 INFO - 'LANGUAGE': 'en_US:en', 11:24:33 INFO - 'LOGNAME': 'cltbld', 11:24:33 INFO - 'MAIL': '/var/mail/cltbld', 11:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:33 INFO - 'MOZ_NO_REMOTE': '1', 11:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:33 INFO - 'NO_EM_RESTART': '1', 11:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:33 INFO - 'PWD': '/builds/slave/test', 11:24:33 INFO - 'SHELL': '/bin/bash', 11:24:33 INFO - 'SHLVL': '1', 11:24:33 INFO - 'TERM': 'linux', 11:24:33 INFO - 'TMOUT': '86400', 11:24:33 INFO - 'USER': 'cltbld', 11:24:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:33 INFO - '_': '/tools/buildbot/bin/python'} 11:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:33 INFO - Downloading/unpacking psutil>=3.1.1 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:34 INFO - Installing collected packages: psutil 11:24:34 INFO - Running setup.py install for psutil 11:24:34 INFO - building 'psutil._psutil_linux' extension 11:24:34 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 11:24:34 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 11:24:34 INFO - building 'psutil._psutil_posix' extension 11:24:34 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 11:24:34 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 11:24:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:35 INFO - Successfully installed psutil 11:24:35 INFO - Cleaning up... 11:24:35 INFO - Return code: 0 11:24:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:24:35 INFO - Using env: {'DISPLAY': ':0', 11:24:35 INFO - 'HOME': '/home/cltbld', 11:24:35 INFO - 'LANG': 'en_US.UTF-8', 11:24:35 INFO - 'LANGUAGE': 'en_US:en', 11:24:35 INFO - 'LOGNAME': 'cltbld', 11:24:35 INFO - 'MAIL': '/var/mail/cltbld', 11:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:35 INFO - 'MOZ_NO_REMOTE': '1', 11:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:35 INFO - 'NO_EM_RESTART': '1', 11:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:35 INFO - 'PWD': '/builds/slave/test', 11:24:35 INFO - 'SHELL': '/bin/bash', 11:24:35 INFO - 'SHLVL': '1', 11:24:35 INFO - 'TERM': 'linux', 11:24:35 INFO - 'TMOUT': '86400', 11:24:35 INFO - 'USER': 'cltbld', 11:24:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:35 INFO - '_': '/tools/buildbot/bin/python'} 11:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24: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 11:24: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 11:24: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 11:24: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 11:24:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:36 INFO - Installing collected packages: mozsystemmonitor 11:24:36 INFO - Running setup.py install for mozsystemmonitor 11:24:36 INFO - Successfully installed mozsystemmonitor 11:24:36 INFO - Cleaning up... 11:24:36 INFO - Return code: 0 11:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:36 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:36 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 11:24:36 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 11:24:36 INFO - Using env: {'DISPLAY': ':0', 11:24:36 INFO - 'HOME': '/home/cltbld', 11:24:36 INFO - 'LANG': 'en_US.UTF-8', 11:24:36 INFO - 'LANGUAGE': 'en_US:en', 11:24:36 INFO - 'LOGNAME': 'cltbld', 11:24:36 INFO - 'MAIL': '/var/mail/cltbld', 11:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:36 INFO - 'MOZ_NO_REMOTE': '1', 11:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:36 INFO - 'NO_EM_RESTART': '1', 11:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:36 INFO - 'PWD': '/builds/slave/test', 11:24:36 INFO - 'SHELL': '/bin/bash', 11:24:36 INFO - 'SHLVL': '1', 11:24:36 INFO - 'TERM': 'linux', 11:24:36 INFO - 'TMOUT': '86400', 11:24:36 INFO - 'USER': 'cltbld', 11:24:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:36 INFO - '_': '/tools/buildbot/bin/python'} 11:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24: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 11:24: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 11:24: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 11:24: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 11:24:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:38 INFO - warning: no files found matching '*.txt' 11:24:38 INFO - no previously-included directories found matching 'build' 11:24:38 INFO - no previously-included directories found matching 'dist' 11:24:38 INFO - no previously-included directories found matching '.git*' 11:24:38 INFO - Installing collected packages: jsonschema, functools32 11:24:38 INFO - Running setup.py install for functools32 11:24:38 INFO - warning: no files found matching '*.txt' 11:24:38 INFO - no previously-included directories found matching 'build' 11:24:38 INFO - no previously-included directories found matching 'dist' 11:24:38 INFO - no previously-included directories found matching '.git*' 11:24:38 INFO - Successfully installed jsonschema functools32 11:24:38 INFO - Cleaning up... 11:24:38 INFO - Return code: 0 11:24:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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', '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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24: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 functools32==3.2.3-2 11:24:38 INFO - Using env: {'DISPLAY': ':0', 11:24:38 INFO - 'HOME': '/home/cltbld', 11:24:38 INFO - 'LANG': 'en_US.UTF-8', 11:24:38 INFO - 'LANGUAGE': 'en_US:en', 11:24:38 INFO - 'LOGNAME': 'cltbld', 11:24:38 INFO - 'MAIL': '/var/mail/cltbld', 11:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:38 INFO - 'MOZ_NO_REMOTE': '1', 11:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:38 INFO - 'NO_EM_RESTART': '1', 11:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:38 INFO - 'PWD': '/builds/slave/test', 11:24:38 INFO - 'SHELL': '/bin/bash', 11:24:38 INFO - 'SHLVL': '1', 11:24:38 INFO - 'TERM': 'linux', 11:24:38 INFO - 'TMOUT': '86400', 11:24:38 INFO - 'USER': 'cltbld', 11:24:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:38 INFO - '_': '/tools/buildbot/bin/python'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:38 INFO - Cleaning up... 11:24:38 INFO - Return code: 0 11:24:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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', '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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24: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 blobuploader==1.2.4 11:24:38 INFO - Using env: {'DISPLAY': ':0', 11:24:38 INFO - 'HOME': '/home/cltbld', 11:24:38 INFO - 'LANG': 'en_US.UTF-8', 11:24:38 INFO - 'LANGUAGE': 'en_US:en', 11:24:38 INFO - 'LOGNAME': 'cltbld', 11:24:38 INFO - 'MAIL': '/var/mail/cltbld', 11:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:38 INFO - 'MOZ_NO_REMOTE': '1', 11:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:38 INFO - 'NO_EM_RESTART': '1', 11:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:38 INFO - 'PWD': '/builds/slave/test', 11:24:38 INFO - 'SHELL': '/bin/bash', 11:24:38 INFO - 'SHLVL': '1', 11:24:38 INFO - 'TERM': 'linux', 11:24:38 INFO - 'TMOUT': '86400', 11:24:38 INFO - 'USER': 'cltbld', 11:24:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:38 INFO - '_': '/tools/buildbot/bin/python'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 INFO - Downloading docopt-0.6.1.tar.gz 11:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:40 INFO - Running setup.py install for blobuploader 11:24:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:40 INFO - Running setup.py install for requests 11:24:41 INFO - Running setup.py install for docopt 11:24:41 INFO - Successfully installed blobuploader requests docopt 11:24:41 INFO - Cleaning up... 11:24:41 INFO - Return code: 0 11:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:41 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:41 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 11:24:41 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 11:24:41 INFO - Using env: {'DISPLAY': ':0', 11:24:41 INFO - 'HOME': '/home/cltbld', 11:24:41 INFO - 'LANG': 'en_US.UTF-8', 11:24:41 INFO - 'LANGUAGE': 'en_US:en', 11:24:41 INFO - 'LOGNAME': 'cltbld', 11:24:41 INFO - 'MAIL': '/var/mail/cltbld', 11:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:41 INFO - 'MOZ_NO_REMOTE': '1', 11:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:41 INFO - 'NO_EM_RESTART': '1', 11:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:41 INFO - 'PWD': '/builds/slave/test', 11:24:41 INFO - 'SHELL': '/bin/bash', 11:24:41 INFO - 'SHLVL': '1', 11:24:41 INFO - 'TERM': 'linux', 11:24:41 INFO - 'TMOUT': '86400', 11:24:41 INFO - 'USER': 'cltbld', 11:24:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:41 INFO - '_': '/tools/buildbot/bin/python'} 11:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:41 INFO - Running setup.py (path:/tmp/pip-c_CcXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:41 INFO - Running setup.py (path:/tmp/pip-VbC9fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:41 INFO - Running setup.py (path:/tmp/pip-6gqkU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:41 INFO - Running setup.py (path:/tmp/pip-zTlJDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:41 INFO - Running setup.py (path:/tmp/pip-9pDUjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:41 INFO - Running setup.py (path:/tmp/pip-W0u21F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:41 INFO - Running setup.py (path:/tmp/pip-uX5Sn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:41 INFO - Running setup.py (path:/tmp/pip-CBWJtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:41 INFO - Running setup.py (path:/tmp/pip-ARGa9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:42 INFO - Running setup.py (path:/tmp/pip-Se6VDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:42 INFO - Running setup.py (path:/tmp/pip-mzP7cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:42 INFO - Running setup.py (path:/tmp/pip-q7OELG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:42 INFO - Running setup.py (path:/tmp/pip-vOmJMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:42 INFO - Running setup.py (path:/tmp/pip-EI8VlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:42 INFO - Running setup.py (path:/tmp/pip-0htECT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:42 INFO - Running setup.py (path:/tmp/pip-mPfUET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:42 INFO - Running setup.py (path:/tmp/pip-E9GuIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:42 INFO - Running setup.py install for manifestparser 11:24:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:42 INFO - Running setup.py install for mozcrash 11:24:42 INFO - Running setup.py install for mozdebug 11:24:42 INFO - Running setup.py install for mozdevice 11:24:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozfile 11:24:43 INFO - Running setup.py install for mozhttpd 11:24:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozinfo 11:24:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozInstall 11:24:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozleak 11:24:43 INFO - Running setup.py install for mozlog 11:24:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for moznetwork 11:24:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozprocess 11:24:43 INFO - Running setup.py install for mozprofile 11:24:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:43 INFO - Running setup.py install for mozrunner 11:24:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:44 INFO - Running setup.py install for mozscreenshot 11:24:44 INFO - Running setup.py install for moztest 11:24:44 INFO - Running setup.py install for mozversion 11:24:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:44 INFO - Cleaning up... 11:24:44 INFO - Return code: 0 11:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:44 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:44 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 11:24:44 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 11:24:44 INFO - Using env: {'DISPLAY': ':0', 11:24:44 INFO - 'HOME': '/home/cltbld', 11:24:44 INFO - 'LANG': 'en_US.UTF-8', 11:24:44 INFO - 'LANGUAGE': 'en_US:en', 11:24:44 INFO - 'LOGNAME': 'cltbld', 11:24:44 INFO - 'MAIL': '/var/mail/cltbld', 11:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:44 INFO - 'MOZ_NO_REMOTE': '1', 11:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:44 INFO - 'NO_EM_RESTART': '1', 11:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:44 INFO - 'PWD': '/builds/slave/test', 11:24:44 INFO - 'SHELL': '/bin/bash', 11:24:44 INFO - 'SHLVL': '1', 11:24:44 INFO - 'TERM': 'linux', 11:24:44 INFO - 'TMOUT': '86400', 11:24:44 INFO - 'USER': 'cltbld', 11:24:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:44 INFO - '_': '/tools/buildbot/bin/python'} 11:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:44 INFO - Running setup.py (path:/tmp/pip-zeavo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:44 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)) 11:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:44 INFO - Running setup.py (path:/tmp/pip-dYbKnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:44 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)) 11:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:44 INFO - Running setup.py (path:/tmp/pip-WGOHNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:44 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)) 11:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:44 INFO - Running setup.py (path:/tmp/pip-5349cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:44 INFO - Running setup.py (path:/tmp/pip-JedmHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:45 INFO - Running setup.py (path:/tmp/pip-0_NuMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:45 INFO - Running setup.py (path:/tmp/pip-qmw6Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:45 INFO - Running setup.py (path:/tmp/pip-8mBEOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:45 INFO - Running setup.py (path:/tmp/pip-qoGcBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:45 INFO - Running setup.py (path:/tmp/pip-dOAWrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:45 INFO - Running setup.py (path:/tmp/pip-EP72P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:45 INFO - Running setup.py (path:/tmp/pip-x7rfTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:45 INFO - Running setup.py (path:/tmp/pip-bVhvvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:45 INFO - Running setup.py (path:/tmp/pip-lp8c9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:45 INFO - Running setup.py (path:/tmp/pip-7lra7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:45 INFO - Running setup.py (path:/tmp/pip-XTdzwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:45 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)) 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:45 INFO - Running setup.py (path:/tmp/pip-atkBCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:46 INFO - Downloading blessings-1.6.tar.gz 11:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:47 INFO - Installing collected packages: blessings 11:24:47 INFO - Running setup.py install for blessings 11:24:47 INFO - Successfully installed blessings 11:24:47 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:47 INFO - Reading from file tmpfile_stdout 11:24:47 INFO - Current package versions: 11:24:47 INFO - argparse == 1.2.1 11:24:47 INFO - blessings == 1.6 11:24:47 INFO - blobuploader == 1.2.4 11:24:47 INFO - docopt == 0.6.1 11:24:47 INFO - functools32 == 3.2.3-2 11:24:47 INFO - jsonschema == 2.5.1 11:24:47 INFO - manifestparser == 1.1 11:24:47 INFO - mozInstall == 1.12 11:24:47 INFO - mozcrash == 1.0 11:24:47 INFO - mozdebug == 0.1 11:24:47 INFO - mozdevice == 0.49 11:24:47 INFO - mozfile == 1.2 11:24:47 INFO - mozhttpd == 0.7 11:24:47 INFO - mozinfo == 0.9 11:24:47 INFO - mozleak == 0.1 11:24:47 INFO - mozlog == 3.4 11:24:47 INFO - moznetwork == 0.27 11:24:47 INFO - mozprocess == 0.25 11:24:47 INFO - mozprofile == 0.28 11:24:47 INFO - mozrunner == 6.13 11:24:47 INFO - mozscreenshot == 0.1 11:24:47 INFO - mozsystemmonitor == 0.3 11:24:47 INFO - moztest == 0.8 11:24:47 INFO - mozversion == 1.4 11:24:47 INFO - psutil == 3.1.1 11:24:47 INFO - requests == 1.2.3 11:24:47 INFO - wsgiref == 0.1.2 11:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'DISPLAY': ':0', 11:24:47 INFO - 'HOME': '/home/cltbld', 11:24:47 INFO - 'LANG': 'en_US.UTF-8', 11:24:47 INFO - 'LANGUAGE': 'en_US:en', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MAIL': '/var/mail/cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SHLVL': '1', 11:24:47 INFO - 'TERM': 'linux', 11:24:47 INFO - 'TMOUT': '86400', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - '_': '/tools/buildbot/bin/python'} 11:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 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)) 11:24:47 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 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 0x212b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', '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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'DISPLAY': ':0', 11:24:47 INFO - 'HOME': '/home/cltbld', 11:24:47 INFO - 'LANG': 'en_US.UTF-8', 11:24:47 INFO - 'LANGUAGE': 'en_US:en', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MAIL': '/var/mail/cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SHLVL': '1', 11:24:47 INFO - 'TERM': 'linux', 11:24:47 INFO - 'TMOUT': '86400', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - '_': '/tools/buildbot/bin/python'} 11:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:47 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Running post-action listener: _resource_record_post_action 11:24:47 INFO - Running post-action listener: _start_resource_monitoring 11:24:47 INFO - Starting resource monitoring. 11:24:47 INFO - [mozharness: 2017-06-06 18:24:47.942570Z] Finished create-virtualenv step (success) 11:24:47 INFO - [mozharness: 2017-06-06 18:24:47.943091Z] Running install step. 11:24:47 INFO - Running pre-action listener: _resource_record_pre_action 11:24:47 INFO - Running main action method: install 11:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:48 INFO - Reading from file tmpfile_stdout 11:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:48 INFO - Reading from file tmpfile_stdout 11:24:48 INFO - Output received: 11:24:48 INFO - Usage: mozinstall [options] installer 11:24:48 INFO - Options: 11:24:48 INFO - -h, --help show this help message and exit 11:24:48 INFO - -d DEST, --destination=DEST 11:24:48 INFO - Directory to install application into. [default: 11:24:48 INFO - "/builds/slave/test"] 11:24:48 INFO - --app=APP Application being installed. [default: firefox] 11:24:48 INFO - mkdir: /builds/slave/test/build/application 11:24:48 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'] 11:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:02 INFO - Reading from file tmpfile_stdout 11:25:02 INFO - Output received: 11:25:02 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:02 INFO - Running post-action listener: _resource_record_post_action 11:25:02 INFO - [mozharness: 2017-06-06 18:25:02.310409Z] Finished install step (success) 11:25:02 INFO - [mozharness: 2017-06-06 18:25:02.310514Z] Running run-tests step. 11:25:02 INFO - Running pre-action listener: _resource_record_pre_action 11:25:02 INFO - Running main action method: run_tests 11:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:02 INFO - Python 2.7.3 11:25:02 INFO - Return code: 0 11:25:02 INFO - grabbing minidump binary from tooltool 11:25:02 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')]} 11:25:02 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 0x23c6400>, '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 0x23c73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c7840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:02 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 11:25:02 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 11:25:02 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 11:25:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:02 INFO - Return code: 0 11:25:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:02 INFO - ENV: RUST_BACKTRACE is now 1 11:25:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:25:02 INFO - Using env: {'DISPLAY': ':0', 11:25:02 INFO - 'HOME': '/home/cltbld', 11:25:02 INFO - 'LANG': 'en_US.UTF-8', 11:25:02 INFO - 'LANGUAGE': 'en_US:en', 11:25:02 INFO - 'LOGNAME': 'cltbld', 11:25:02 INFO - 'MAIL': '/var/mail/cltbld', 11:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:02 INFO - 'MOZ_NO_REMOTE': '1', 11:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:02 INFO - 'NO_EM_RESTART': '1', 11:25:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:02 INFO - 'PWD': '/builds/slave/test', 11:25:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:02 INFO - 'RUST_BACKTRACE': '1', 11:25:02 INFO - 'SHELL': '/bin/bash', 11:25:02 INFO - 'SHLVL': '1', 11:25:02 INFO - 'TERM': 'linux', 11:25:02 INFO - 'TMOUT': '86400', 11:25:02 INFO - 'USER': 'cltbld', 11:25:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994', 11:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:02 INFO - '_': '/tools/buildbot/bin/python'} 11:25:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:25:02 INFO - mozversion application_buildid: 20170606151421 11:25:02 INFO - mozversion application_changeset: fe438f1ec216c0269d353df141ea376055f6130c 11:25:02 INFO - mozversion application_display_name: Firefox 11:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:02 INFO - mozversion application_name: Firefox 11:25:02 INFO - mozversion application_remotingname: firefox 11:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:02 INFO - mozversion application_vendor: Mozilla 11:25:02 INFO - mozversion application_version: 54.0 11:25:02 INFO - mozversion platform_buildid: 20170606151421 11:25:02 INFO - mozversion platform_changeset: fe438f1ec216c0269d353df141ea376055f6130c 11:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:02 INFO - mozversion platform_version: 54.0 11:25:02 INFO - using testdate: 1496773502 11:25:02 INFO - actual date: 1496773502 11:25:02 INFO - starting webserver on 'localhost:56653' 11:25:02 INFO - SUITE-START | Running 2 tests 11:25:02 INFO - TEST-START | dromaeo_css 11:25:02 INFO - operating with platform_type : linux_ 11:25:02 INFO - Initialising browser for dromaeo_css test... 11:25:02 INFO - TEST-INFO | started process 4955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd08JHb/profile http://localhost:56653/getInfo.html) 11:25:06 INFO - PROCESS | 4955 | __metrics Screen width/height:1600/1200 11:25:06 INFO - PROCESS | 4955 | colorDepth:24 11:25:06 INFO - PROCESS | 4955 | Browser inner width/height: 1024/697 11:25:06 INFO - PROCESS | 4955 | __metrics 11:25:07 INFO - PROCESS | 4955 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:07 INFO - PROCESS | 4955 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:08 INFO - TEST-INFO | 4955: exit 0 11:25:08 INFO - Browser initialized. 11:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:08 INFO - TEST-INFO | started process 5049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd08JHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:20 INFO - PROCESS | 5049 | RSS: Main: 140947456 11:25:20 INFO - PROCESS | 5049 | 11:28:21 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56653/tests/dromaeo/cssquery-ext.html) 11:28:23 INFO - PROCESS | 5049 | RSS: Main: 268808192 11:28:23 INFO - PROCESS | 5049 | 11:31:25 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-ext.html (next: http://localhost:56653/tests/dromaeo/cssquery-jquery.html) 11:31:25 INFO - PROCESS | 5049 | RSS: Main: 224997376 11:31:25 INFO - PROCESS | 5049 | 11:34:27 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56653/tests/dromaeo/cssquery-mootools.html) 11:34:28 INFO - PROCESS | 5049 | RSS: Main: 171700224 11:34:28 INFO - PROCESS | 5049 | 11:37:29 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56653/tests/dromaeo/cssquery-prototype.html) 11:37:30 INFO - PROCESS | 5049 | RSS: Main: 227454976 11:37:30 INFO - PROCESS | 5049 | 11:40:33 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56653/tests/dromaeo/cssquery-yui.html) 11:40:34 INFO - PROCESS | 5049 | RSS: Main: 171864064 11:40:34 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | Cycle 1(1): loaded http://localhost:56653/tests/dromaeo/cssquery-yui.html (next: http://localhost:56653/tests/dromaeo/cssquery-dojo.html) 11:43:36 INFO - PROCESS | 5049 | RSS: Main: 263651328 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | __start_tp_report 11:43:36 INFO - PROCESS | 5049 | _x_x_mozilla_page_load 11:43:36 INFO - PROCESS | 5049 | _x_x_mozilla_page_load_details 11:43:36 INFO - PROCESS | 5049 | |i|pagename|runs| 11:43:36 INFO - PROCESS | 5049 | |0;dojo.html;3290.555774970379;3376.8480418381173;3424.79451232926;3450.8619655213793;3471.3925063113966;5664.716764161791;5708.600397972144;5736.741846616902;5741.024025915604;5765.192872997778;5724.284464441945;5802.912956305649;5808.41915808419;5808.82573522794;5819.418058194178;5157.71632560209;5170.560502357304;5173.715445650488;5189.481051894818;5223.843284701465;4959.305697202394;4982.277569752384;5253.44838791927;5258.47415258473;5284.841454756363;5118.872028199287;5148.253503242027;5151.587872970172;5170.405403378622;5172.612054095939;5224.869378265555;5237.816676416345;5238.292830467876;5238.528532432061;5260.815871444481;4954.628402869763;5090.058339207221;5151.304573882553;5187.403448603422;5191.480851914816;5599.944000560024;5610.326760788691;5660.179274005287;5685.715714214272;5689.7439615217;6095.329513753483;6123.877522449526;6156.415140561639;6160.8767824643255;6166.599171053912;6157.3534778848025;6211;6216.160818289518;6216.378362163793;6216.968915155395;5541.085720856054;5562.471565201299;5728.169415434781;5748.511376533042;5764.365919748824;6290.056491526216;6303.9684801575695;6306.24325080984;6308.463780578611;6308.968455157787;6013.037913933749;6059.787907423219;6062.090686397076;6063.818085457443;6075.513958883279;5852.473277405054;5874.559408044413;6085.4523092921845;6182.28903676074;6183.227096612924;6107.328193898667;6119.634116586723;6122.550631082941;6139.324674285825;6139.47814435769;5903.203067585821;5951.404859514014;5952.0476723724;5953.226080609493;6145.324014358417;4560.771961401917;4654.557817007379;4655.068986202773;4666.416697912761;4667.323238130452;4190.573207696041;4206.8737937861915;4216.009237829107;4221.97889010553;4228.70399072062;5499.917501237404;5592.86017849557;5685.317761868602;5753.309602847685;5924.674142922095;6173.59871608344;6204.627722336674;6207.255129384503;6207.937920620736;6211.9689401553605;5880.94119058804;5891.941080589139;5895.263092113486;5899.351071382144;5929.644221346733;5058.089543882063;5092;5193.350831146106;5223.242629818655;5230.63385563007;6483;6484.935150648433;6485.156929599122;6487.643179625166;6492.448141907991;6111.724972376165;6214.9067763982675;6221.3156552778255;6222.066689996536;6223.875522489616;6133.365267548864;6191.442770150708;6492.091107245084;6492.5455218134275;6502.674866256573;6022.759089636365;6044.7279872406725;6114.449440885012;6124.136831511461;6126.3955342902;6172.537059720449;6173.629582225081;6178.969105154445;6179.443850053337;6181.320054794059;5742.885142297047;5979.133025711334;6028.909566356596;6032.638041717511;6074.271087469532;5808.5643576732755;5942.762289508371;5949.791757288647;6006.669633170218;6090.817275481742;6003.6998150093195;6008.188894499187;6009.87980240384;6009.939900600938;6022.307434644897;5814.73833677494;5848.122781582797;5861.179434879035;6038.63768173911;6048.6975651218145;5761.078227483583;5857.765689372377;5890.293164820249;5902.144189092472;5910.408959104056 11:43:36 INFO - PROCESS | 5049 | |1;ext.html;775.1163673412311;838.2790799912076;862.9093945135762;907.0113576201943;916.4272329793879;31851.36297274053;44009.33985990209;44323.77838110813;44478;44482.777586112024;40154;40315.395269070985;40344.59655403445;45298.547014529846;45412.54587454125;7776.183500732426;9087.136722011415;9214.953925230364;9215.308851836106;9219.95390023049;7745.1093124290865;10556.049955504002;10769.246152769309;10773.676789696283;10776.73058173548;10814.837777433344;10845.945770271137;10856.565737370496;10859.294145880533;10866.565337386495;10679.252452328341;10737.516811743451;10759.193060520493;10765.569377224901;10780.73048173794;10548.156147508258;10565.841512377321;10579.259451838374;10610.893891061069;10611.204159688054;42136.36795448071;42269.57730422687;42449.36325955113;42456.57543424557;42560.78719606413;4301.548337424588;4330.415393921843;4398.8900277493;4491.865244042684;4493.460784705856;30700.38599228003;31094.84452577745;31117;31198.22004449884;32559.83720081408;4315.4821421429315;4352.925973419196;4366.978165109186;4383.189110014658;4461.754603496806;242173.99999999822;242437;242515;243020;244146;53724.46275537195;53934;54032.189517157276;54182.7290863551;54195.729021354644;56369.43630563642;56470.717646411504;56478;56492;56499.71750141223;15082.396704131932;15440;15447.845521544865;15466.690666186612;15471.845281547265;10990.615328463466;11096.1123110151;13484.865151348557;13500.32498375097;13500.662483437993;13271.336433178303;13405.329733513481;13803.861961380258;13826.446942122202;13952;5592.217089607459;5593.216949627055;5614.6631202128;5629.577781666391;5650.886982260414;1003.4380746781826;1008.5174793054199;1012.9949350253349;1018.7045756730613;1032.7521394865178;28773.712262877103;28845.423091538472;28966;29237.41525169527;29424.411511769646;1082.9241953063367;1083.544911137324;1101.2841652925663;1114.4650567727535;1129.971750706239;14826.443223461381;15360.769588456182;15367.769483457758;15428.614284642748;15462.613434664223;291064;293282;293679;295402;297698;55927.440725593035;56123;56177;56211.43788562144;56570;1504.5711972087902;1530.8469153084602;1538.907665540071;1570;1587.103286643066;27728.445431090862;28962.710372896003;29000.709992900644;29537.34163925257;29911.700882990892;37695.246095078495;37826.24347512979;37900;37928.62071379251;37934;282667;283630;283926;284246;284914;29721.702782971894;29947;30037;30375.848120759256;30577.388452230385;40635.796821015705;40663.1867362657;40826;40956.18087638171;41075.794621026704;30914;31194.532082018333;31512.684873150974;31637.20906977344;31765.841170794924;31413.21466963253;31537.21156971094;31573.210669733442;31720.36559268848;31781;36188.63811361853;36428.81785591055;36826.8158659205;36963.07592310214;37071.62928370682;29780.851095744383;29862.954796582017;29962.79208215491;30185.849070754506;30196.5470517938;24772;24827.255182344557;24943.750562494144;25010.124645637316;25253.747462525138 11:43:36 INFO - PROCESS | 5049 | |2;jquery.html;467.37371921625015;476.16433159804535;481.6652426563539;486.4405933176844;501.1605560685851;20228;21459.67810482842;21700.782992170072;21831.781682183173;21909.780902190974;21926.342209733695;22330.106795728152;22640.20759273426;22778.88610556949;22803.429914252152;6541.378569035934;6686.465082793377;6783.7625683101105;6812.489063320246;6845.726170953156;6744.325567443266;6750.459963202957;6804.18349798025;7196.8200794980285;7463.626818659072;7640.5482958238035;7650.273224043707;7661.502002369856;7663.080430348338;7666.693332266703;7486.288802563748;7613.8477230455355;7658.502197357154;7659.387249020093;7661.272179142972;7220.3140701633265;7424.517406368569;7447.813804654873;7468.4025277977635;7470.626468676599;25496.49007019849;25606.87196564024;25897.741022589722;25995.870020649774;26038.86980565104;3085.197848559368;3155.4477966356026;3170.6670799566173;3285.1130194847497;3290.457074582691;15764.921175394164;16076.75884861728;16301.59246018847;16334.673306533921;16460.917695411565;2282.372347604422;2339.6724458575814;2347.8591284522813;2384.666146739458;2403.110848985869;72238;103862;118034;118359;121480;17206.827931720774;17700.822991769917;17791.377301794375;18288.81711182871;18315.267389304547;31433.528497072562;31645.36709265848;31715.52426713601;31786.841065794986;31818.522722159185;10540.578376864993;10599.205059620559;10787.734575739183;10789.46052697362;10959.945200274107;9074.637014519478;9183.441542399241;9186.356955013085;9396.483193424427;9411;8623.525706086226;8978.685745998859;9127.26981841451;9233.815323693489;9291.349605527548;3531.7351198660203;3586.6234045425376;3663.578688450862;3723.4414837774552;3735.0849041984343;934.621478301289;976.023976023976;1146.4554336690005;1180.1974657233163;1214.9817752733716;20283.290084846958;20332.593348132956;20400.59198816045;20503.589928201352;20603;1174.6358628825092;1185.4606154199819;1189.3755778216332;1206.6259459567561;1225.1301575881225;10848.620298289521;11120.277181983145;11207.271527350696;11243.83134252987;11246.943765281285;660844;672883;686697;689191;705113;78373.68779619408;98422.5078874601;101835.49082254541;111214.44392777984;127603;1254.85569159546;1280.3918138884142;1318.8878945289757;1326.7014921642747;1343.355189509041;18747.53131171677;18957.715634265773;19049.142788574823;19087.713684294467;19201.903990479957;54166.458335416144;54336.728316359746;54599.72700136633;55051.17423238575;56082.71958640181;64747.676261620276;67111.32888671051;73014.26985730288;74191.25808741844;77594.6120269395;12372.938135309267;12906.612801615967;13028;13191.406386712813;13338.866611334151;11701.824472633087;14583.343749531508;14918.32867520986;15073.547793565773;15409.460668876536;7296.854062918818;12489.313087779896;12778.105532612628;13105.2136871788;13589.45642174302;12068.336241506802;12186.895491295216;12250.448729807358;12364.62906112818;12525.185862918881;11945.641630751092;12685;13167.73664526685;13617.25105119228;13758.449662013407;12864.356782160667;13150.276734779296;13159.144655597356;13173.934130329288;13238.933805330911;12764.489420423079;12795.168314059556;12843.614691559269;12886.548970785978;13150.21098734079 11:43:36 INFO - PROCESS | 5049 | |3;mootools.html;1525.1382968622727;1548.798656174697;1569.5605230535439;1578.4554328756583;1583.0976343484213;11033.613823516178;11846.7630647387;11848.881511184885;11854.3480108594;11867.991220746237;11502.884971150286;11579.65261042168;11760.353180575064;11765.117616178799;11766.235194712337;2461.544614246361;2499;2501.9249422517264;2505.3987043109614;2507.699076110869;2400.3639035655565;2445.5475736988624;2472.678551788265;2484.527939691462;2485.2420011896365;2332.4402143485527;2358.3160883343808;2476.8885400157037;2536.644869718241;2548.2610043087484;2423.842450240729;2425.866577338246;2444.1567659157563;2445.8532488050687;2471.2339174855674;2383.9642405363934;2404.158544509425;2411.397150712322;2417.528581926525;2420.649005894153;11192.66422007333;11355.772884542263;11369.886301136965;11379.317240965569;11381.260218085798;5861.88276234473;6008.699565021731;6018.398160183947;6020.006698894677;6021.187139736167;3496.4755286706945;3527.206378564828;3596.9677132420097;3604.3151801157696;3654.4701018352457;1418.581518452059;1425.1947649577955;1472.8158980127484;1472.8600782925605;1500.6623509710337;17949.282028718837;17988.640227195512;18104;18146.818531814777;18151.818481815146;4451.532589078165;4626;4672.5327467253;4710.128626204095;4715.575598196178;13419.798703019462;13424.530141445002;13424.865751342362;13429.059965802495;13436.596902092953;5773.711314434261;5827.650340979555;5872.911906321408;5877.23595932526;5883.0881213411985;5435.510804027656;5467.316585426822;5480.972595136999;5560.277163968658;5566.276384070045;4128.525219599725;4155.79481950231;4180.331147016463;4236.491621005437;4247.256730072287;1036.875574931013;1037.123630532214;1049.7690508088208;1050.6742909698019;1056.815057364958;1066.8719753629614;1070.55571937645;1078.8759292681443;1081.324172392255;1082.5345101606385;7054;7166.104236970379;7200;7302.671379787922;7332.450066245053;1095.0856035210688;1104.3484344236938;1105.2318638546133;1112.3659514076899;1115.8437818705388;4595.346699374006;4619.376384188159;4732.858014259577;4909.656324057281;4922.409310882717;14332.068415552956;14494.710105797825;14650.413983440756;14817.77773333401;14866.405343786128;14121.152730836182;14326.355314010894;14475.493357732428;14752.778708319383;14764.926175369055;10438.478076096164;10521.31611445269;10676.145908327315;10682.62610808618;10804.243702940876;7199.928000720135;7420.480566360519;7545.283198096172;7576;7702.345300649507;13037.15258508194;13275.668108296983;13379.130356527185;13392.330383480592;13435;13403.664908377368;13548.187108773505;13573.86426135726;13586.116902401312;13722.794158087836;9994.900050999397;10242.436665983145;10251.026152515498;10282.742931426774;10287.074163325336;10443.425611591436;10647.148228141885;10715.946420267848;10736.141108711441;10740.570377184826;9436.386634868712;9616.567254473706;9674.9032509674;9785.657501987396;9808.313418060667;9055.637774488947;9059.411138275991;9074.591643375932;9208.585613647536;9265.119813617695;8684.782880427787;8689.782755431164;8693.608787604446;8793.91206087931;8800.867986980329;6274.874502510015;6357.110004599453;6378.266499352634;6469.126667899962;6536.542442029012;6318.810435686937;6495.350464953467;6516.609003459807;6566.573172743948;6628.2921693179815 11:43:36 INFO - PROCESS | 5049 | |4;prototype.html;380.96571308582224;436.66595054783096;444.200439209423;448.5268042215461;456.94745104313006;5168.302279192308;5272.340957380327;5396.406395296524;5431.456854314567;5455.18172274159;5088.821891233808;5272;5294.52349288564;5341.679499230049;5348.866278343044;4439.889002774924;4440.755758433284;4444.666650001247;4446.533114023029;4454.53227411122;4279.2083464559;4312.835534405708;4340.348947657861;4378.912421751579;4446.688731788776;4321.373400856874;4355.477342718878;4376.168527979674;4388.97805510972;4394.40675508807;4337.891552711176;4340.500842403132;4381.978090109545;4402.3176407656865;4407.052483715985;3963.286608410485;4118.691098167619;4141.1426115979875;4148.465067924857;4177.164567086565;5053.67151135175;5063.873403164914;5109.591232701375;5129.692218466904;5152.355955505562;5142.948570514284;5149.201873709581;5150.038727731569;5157.510036546522;5171.405288391846;5334.306540149756;5515.773272635513;5556.638818476786;5574.247476590649;5637.210790489335;4628.95848434103;4629.3750343703505;4660.580547750718;4661.277501987163;4671.906561868777;5843.298804143487;5852.209951656514;5864.530837532987;5869.677167755772;5911.704414779287;4572.353952577069;4756.6432517561325;4788.95211047892;4799.472058073609;4885.511448855086;4617.8383756568355;4792.95207047932;4818.807247710122;4830.758462076882;4884.902301953941;5016.44819069902;5036.924446133311;5059.215821547666;5118.515630467123;5161.27742116104;5490.396056433789;5527.683389966069;5528.778848846001;5552.500824777288;5554.1946417769195;1593.0441734958931;1659.5436255029963;1661.5015495351347;1669.273865868351;1675.9832401676072;1255.5480027190204;1289.2586762611536;1292.1213574769247;1298.8701129886936;1300.2133709106045;5303.257543943851;5429.972850135724;5434.3207099112615;5468.179773034077;5474.39781624021;5664.612170018372;5665.442003449084;5686.232358631614;5688.037627018672;5688.687122208318;5250.868728281747;5345.705986170798;5400.729963501809;5421.647592906448;5448.42791506894;3003.9098827035223;3006.7444267237092;3009.6689364169924;3010.3828715113787;3012.5932999045285;5723.627964182315;5943.821685349447;5950.940490595125;5983.790567330209;5999.340072592011;5754.625949313281;5840.795572155039;5871.238628411459;5888.941110588839;5913.793017244376;5981.401859813984;5995.280566332068;5999.160117583542;6008.429199226067;6015.488683461955;5413.945860541344;5717.685527296038;5726.914096288476;5735.254416925773;5756.740946657326;5604.551635869202;5608.46719561641;5634.098544232903;5660.377358490645;5683.204351390726;5722.828315150552;5908.645481271137;5979.282486101695;5998.580099393175;6026.15633811258;4730.574248317668;4774.618030557477;4820.180569303297;4829.9275510868065;4842.951570484391;5551.417845914057;5595.468430499259;5604.355499117653;5632.070708333079;5690.634247780586;5517.282753242052;5522.889542209214;5538.873539213312;5543.25166102571;5560.582956278215;5209.348831396075;5494.697791621499;5509.807156749494;5515.531179849758;5574.16387541872;5495.505404513453;5517.282753242052;5522.658791431127;5527.778888844401;5555.583331250254;5588.842304098172;5641.435856414326;5644.294463192101;5655.830325090254;5673.574481913791;5293;5466.945330546644;5480.369757477941;5515.779368825362;5527.972360138335 11:43:36 INFO - PROCESS | 5049 | |5;yui.html;807.83439394924;825.7068740597088;902.5532361481066;929.3355250995539;939.2016785732133;16142.19289035548;16692.91653541732;16709.83290167098;16733.58166045848;16753.413630522904;15589.142597157152;17361.305547778105;17599;17607.031613261264;17609.7358539622;838.4256784102894;862.1507814802414;865.5758678247645;865.6580650642992;866.4324867211955;877.2324216310728;881.2597418168737;882.2016075451727;883.3463237204487;884.4693184089527;914.0676509959837;921.3136213520936;922.7785331520421;923.4044041593169;923.9722808315761;910.8952470465915;911.8586619073988;913.2009491694768;913.9405938614002;914.8261830252264;674.723363420995;677.190757045331;679.9830004249884;680.1124532485105;681.8465845184843;15242.771358429522;15270.770938435933;16285.51143465686;16744.58138546534;16880.409185678564;13821.861781382158;13968.860311396958;14453.927730361385;14489.782653260105;14489.78265326021;12818.935905320506;12851.742965140738;12870.29213393263;12925.54760583375;13167.473301067947;3906.1211227473877;3919.1573811630637;3939.3500072488005;3981.820818063194;3997.520297564311;49621;59062.40937590612;60672.69663651698;65314.3468565313;82038;13454.461821527226;13486.797698034537;13617.591472255848;13667;13740.450381984609;25020;25101.748982510308;25272.494550108895;25425.74574254271;25596.616050759254;9094.136057074567;9123.498207598514;9232.630694772268;9344.486053267136;9363.485008324607;4819.6867203631655;4919.508049195123;4968.925466118011;4974.37820272466;4984.501549845059;3748.231612519427;3792.943105853414;3822.560405553397;3822.636849499293;3829.349010668193;630.1776182082426;633.2401118657538;638.0684201066402;641.9261784894703;653.1541653558653;808.3371635259031;821.4291067708006;845.5349557743217;861.1388611388611;868.3400615532115;10747.892521074846;10862.402567858686;11085.612003579836;11283.943580282046;11400.828987565194;812.0580127052591;815.1644564321617;832.3382910586099;840.7057529864499;844.995775021121;5336.226247194213;5503.147012213113;5577.553795696334;5618.101103823368;5685;81052;81802;83077;83336;83820;47792.76103619529;59450.70274648599;71144;71365;72470;62357;62369.37630623636;63042.36957630457;63382.366176337644;63433.36566634367;11750.412479375826;11903.345316007702;12140.089493288215;12337.938310308391;12392.81410778857;41628.1674366517;41635;42078;42250;42857;49735.50264497309;51023.48976510336;51063.489365105874;51205.48794512007;51331.48668513267;15094.54716358511;15194.544163675107;15241.6189595261;15384.153871537173;15542.30059647296;15784.684306314039;15959.122248275991;16134.67730645357;16199.43301984425;17052.48842534726;15134.394624214909;15159.317830697866;15529.45646902353;16041.358345666044;16091.275892584628;14537;14567.635809104857;15696.372145114068;15957.760633590273;16262.10558419251;14848.62878428048;15327.157006364758;15685.686286274438;16039.198040098181;16210.27053782559;10545.841812372973;10704.35980172315;10836.458177091272;10992.835107473555;11072.224944253825;12792.296423696785;12963.933607887184;13084.214947103204;13257.602271931857;13268.336583170996 11:43:36 INFO - PROCESS | 5049 | __end_tp_report 11:43:36 INFO - PROCESS | 5049 | __start_cc_report 11:43:36 INFO - PROCESS | 5049 | _x_x_mozilla_cycle_collect,1271 11:43:36 INFO - PROCESS | 5049 | __end_cc_report 11:43:36 INFO - PROCESS | 5049 | __startTimestamp1496774616809__endTimestamp 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | ------- Summary: start ------- 11:43:36 INFO - PROCESS | 5049 | Number of tests: 6 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#0] dojo.html Cycles:165 Average:5689.85 Median:5899.35 stddev:655.86 (11.1%) stddev-sans-first:630.28 11:43:36 INFO - PROCESS | 5049 | Values: 3290.6 3376.8 3424.8 3450.9 3471.4 5664.7 5708.6 5736.7 5741.0 5765.2 5724.3 5802.9 5808.4 5808.8 5819.4 5157.7 5170.6 5173.7 5189.5 5223.8 4959.3 4982.3 5253.4 5258.5 5284.8 5118.9 5148.3 5151.6 5170.4 5172.6 5224.9 5237.8 5238.3 5238.5 5260.8 4954.6 5090.1 5151.3 5187.4 5191.5 5599.9 5610.3 5660.2 5685.7 5689.7 6095.3 6123.9 6156.4 6160.9 6166.6 6157.4 6211.0 6216.2 6216.4 6217.0 5541.1 5562.5 5728.2 5748.5 5764.4 6290.1 6304.0 6306.2 6308.5 6309.0 6013.0 6059.8 6062.1 6063.8 6075.5 5852.5 5874.6 6085.5 6182.3 6183.2 6107.3 6119.6 6122.6 6139.3 6139.5 5903.2 5951.4 5952.0 5953.2 6145.3 4560.8 4654.6 4655.1 4666.4 4667.3 4190.6 4206.9 4216.0 4222.0 4228.7 5499.9 5592.9 5685.3 5753.3 5924.7 6173.6 6204.6 6207.3 6207.9 6212.0 5880.9 5891.9 5895.3 5899.4 5929.6 5058.1 5092.0 5193.4 5223.2 5230.6 6483.0 6484.9 6485.2 6487.6 6492.4 6111.7 6214.9 6221.3 6222.1 6223.9 6133.4 6191.4 6492.1 6492.5 6502.7 6022.8 6044.7 6114.4 6124.1 6126.4 6172.5 6173.6 6179.0 6179.4 6181.3 5742.9 5979.1 6028.9 6032.6 6074.3 5808.6 5942.8 5949.8 6006.7 6090.8 6003.7 6008.2 6009.9 6009.9 6022.3 5814.7 5848.1 5861.2 6038.6 6048.7 5761.1 5857.8 5890.3 5902.1 5910.4 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#1] ext.html Cycles:180 Average:44277.84 Median:30191.20 stddev:71524.40 (236.9%) stddev-sans-first:71650.46 11:43:36 INFO - PROCESS | 5049 | Values: 775.1 838.3 862.9 907.0 916.4 31851.4 44009.3 44323.8 44478.0 44482.8 40154.0 40315.4 40344.6 45298.5 45412.5 7776.2 9087.1 9215.0 9215.3 9220.0 7745.1 10556.0 10769.2 10773.7 10776.7 10814.8 10845.9 10856.6 10859.3 10866.6 10679.3 10737.5 10759.2 10765.6 10780.7 10548.2 10565.8 10579.3 10610.9 10611.2 42136.4 42269.6 42449.4 42456.6 42560.8 4301.5 4330.4 4398.9 4491.9 4493.5 30700.4 31094.8 31117.0 31198.2 32559.8 4315.5 4352.9 4367.0 4383.2 4461.8 242174.0 242437.0 242515.0 243020.0 244146.0 53724.5 53934.0 54032.2 54182.7 54195.7 56369.4 56470.7 56478.0 56492.0 56499.7 15082.4 15440.0 15447.8 15466.7 15471.8 10990.6 11096.1 13484.9 13500.3 13500.7 13271.3 13405.3 13803.9 13826.4 13952.0 5592.2 5593.2 5614.7 5629.6 5650.9 1003.4 1008.5 1013.0 1018.7 1032.8 28773.7 28845.4 28966.0 29237.4 29424.4 1082.9 1083.5 1101.3 1114.5 1130.0 14826.4 15360.8 15367.8 15428.6 15462.6 291064.0 293282.0 293679.0 295402.0 297698.0 55927.4 56123.0 56177.0 56211.4 56570.0 1504.6 1530.8 1538.9 1570.0 1587.1 27728.4 28962.7 29000.7 29537.3 29911.7 37695.2 37826.2 37900.0 37928.6 37934.0 282667.0 283630.0 283926.0 284246.0 284914.0 29721.7 29947.0 30037.0 30375.8 30577.4 40635.8 40663.2 40826.0 40956.2 41075.8 30914.0 31194.5 31512.7 31637.2 31765.8 31413.2 31537.2 31573.2 31720.4 31781.0 36188.6 36428.8 36826.8 36963.1 37071.6 29780.9 29863.0 29962.8 30185.8 30196.5 24772.0 24827.3 24943.8 25010.1 25253.7 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#2] jquery.html Cycles:180 Average:38183.93 Median:22485.16 stddev:112223.02 (499.1%) stddev-sans-first:112502.11 11:43:36 INFO - PROCESS | 5049 | Values: 467.4 476.2 481.7 486.4 501.2 20228.0 21459.7 21700.8 21831.8 21909.8 21926.3 22330.1 22640.2 22778.9 22803.4 6541.4 6686.5 6783.8 6812.5 6845.7 6744.3 6750.5 6804.2 7196.8 7463.6 7640.5 7650.3 7661.5 7663.1 7666.7 7486.3 7613.8 7658.5 7659.4 7661.3 7220.3 7424.5 7447.8 7468.4 7470.6 25496.5 25606.9 25897.7 25995.9 26038.9 3085.2 3155.4 3170.7 3285.1 3290.5 15764.9 16076.8 16301.6 16334.7 16460.9 2282.4 2339.7 2347.9 2384.7 2403.1 72238.0 103862.0 118034.0 118359.0 121480.0 17206.8 17700.8 17791.4 18288.8 18315.3 31433.5 31645.4 31715.5 31786.8 31818.5 10540.6 10599.2 10787.7 10789.5 10959.9 9074.6 9183.4 9186.4 9396.5 9411.0 8623.5 8978.7 9127.3 9233.8 9291.3 3531.7 3586.6 3663.6 3723.4 3735.1 934.6 976.0 1146.5 1180.2 1215.0 20283.3 20332.6 20400.6 20503.6 20603.0 1174.6 1185.5 1189.4 1206.6 1225.1 10848.6 11120.3 11207.3 11243.8 11246.9 660844.0 672883.0 686697.0 689191.0 705113.0 78373.7 98422.5 101835.5 111214.4 127603.0 1254.9 1280.4 1318.9 1326.7 1343.4 18747.5 18957.7 19049.1 19087.7 19201.9 54166.5 54336.7 54599.7 55051.2 56082.7 64747.7 67111.3 73014.3 74191.3 77594.6 12372.9 12906.6 13028.0 13191.4 13338.9 11701.8 14583.3 14918.3 15073.5 15409.5 7296.9 12489.3 12778.1 13105.2 13589.5 12068.3 12186.9 12250.4 12364.6 12525.2 11945.6 12685.0 13167.7 13617.3 13758.4 12864.4 13150.3 13159.1 13173.9 13238.9 12764.5 12795.2 12843.6 12886.5 13150.2 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#3] mootools.html Cycles:180 Average:7272.51 Median:2419.09 stddev:4660.81 (192.7%) stddev-sans-first:4653.88 11:43:36 INFO - PROCESS | 5049 | Values: 1525.1 1548.8 1569.6 1578.5 1583.1 11033.6 11846.8 11848.9 11854.3 11868.0 11502.9 11579.7 11760.4 11765.1 11766.2 2461.5 2499.0 2501.9 2505.4 2507.7 2400.4 2445.5 2472.7 2484.5 2485.2 2332.4 2358.3 2476.9 2536.6 2548.3 2423.8 2425.9 2444.2 2445.9 2471.2 2384.0 2404.2 2411.4 2417.5 2420.6 11192.7 11355.8 11369.9 11379.3 11381.3 5861.9 6008.7 6018.4 6020.0 6021.2 3496.5 3527.2 3597.0 3604.3 3654.5 1418.6 1425.2 1472.8 1472.9 1500.7 17949.3 17988.6 18104.0 18146.8 18151.8 4451.5 4626.0 4672.5 4710.1 4715.6 13419.8 13424.5 13424.9 13429.1 13436.6 5773.7 5827.7 5872.9 5877.2 5883.1 5435.5 5467.3 5481.0 5560.3 5566.3 4128.5 4155.8 4180.3 4236.5 4247.3 1036.9 1037.1 1049.8 1050.7 1056.8 1066.9 1070.6 1078.9 1081.3 1082.5 7054.0 7166.1 7200.0 7302.7 7332.5 1095.1 1104.3 1105.2 1112.4 1115.8 4595.3 4619.4 4732.9 4909.7 4922.4 14332.1 14494.7 14650.4 14817.8 14866.4 14121.2 14326.4 14475.5 14752.8 14764.9 10438.5 10521.3 10676.1 10682.6 10804.2 7199.9 7420.5 7545.3 7576.0 7702.3 13037.2 13275.7 13379.1 13392.3 13435.0 13403.7 13548.2 13573.9 13586.1 13722.8 9994.9 10242.4 10251.0 10282.7 10287.1 10443.4 10647.1 10715.9 10736.1 10740.6 9436.4 9616.6 9674.9 9785.7 9808.3 9055.6 9059.4 9074.6 9208.6 9265.1 8684.8 8689.8 8693.6 8793.9 8800.9 6274.9 6357.1 6378.3 6469.1 6536.5 6318.8 6495.4 6516.6 6566.6 6628.3 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#4] prototype.html Cycles:180 Average:4850.47 Median:5343.69 stddev:1295.86 (24.3%) stddev-sans-first:1255.33 11:43:36 INFO - PROCESS | 5049 | Values: 381.0 436.7 444.2 448.5 456.9 5168.3 5272.3 5396.4 5431.5 5455.2 5088.8 5272.0 5294.5 5341.7 5348.9 4439.9 4440.8 4444.7 4446.5 4454.5 4279.2 4312.8 4340.3 4378.9 4446.7 4321.4 4355.5 4376.2 4389.0 4394.4 4337.9 4340.5 4382.0 4402.3 4407.1 3963.3 4118.7 4141.1 4148.5 4177.2 5053.7 5063.9 5109.6 5129.7 5152.4 5142.9 5149.2 5150.0 5157.5 5171.4 5334.3 5515.8 5556.6 5574.2 5637.2 4629.0 4629.4 4660.6 4661.3 4671.9 5843.3 5852.2 5864.5 5869.7 5911.7 4572.4 4756.6 4789.0 4799.5 4885.5 4617.8 4793.0 4818.8 4830.8 4884.9 5016.4 5036.9 5059.2 5118.5 5161.3 5490.4 5527.7 5528.8 5552.5 5554.2 1593.0 1659.5 1661.5 1669.3 1676.0 1255.5 1289.3 1292.1 1298.9 1300.2 5303.3 5430.0 5434.3 5468.2 5474.4 5664.6 5665.4 5686.2 5688.0 5688.7 5250.9 5345.7 5400.7 5421.6 5448.4 3003.9 3006.7 3009.7 3010.4 3012.6 5723.6 5943.8 5950.9 5983.8 5999.3 5754.6 5840.8 5871.2 5888.9 5913.8 5981.4 5995.3 5999.2 6008.4 6015.5 5413.9 5717.7 5726.9 5735.3 5756.7 5604.6 5608.5 5634.1 5660.4 5683.2 5722.8 5908.6 5979.3 5998.6 6026.2 4730.6 4774.6 4820.2 4829.9 4843.0 5551.4 5595.5 5604.4 5632.1 5690.6 5517.3 5522.9 5538.9 5543.3 5560.6 5209.3 5494.7 5509.8 5515.5 5574.2 5495.5 5517.3 5522.7 5527.8 5555.6 5588.8 5641.4 5644.3 5655.8 5673.6 5293.0 5466.9 5480.4 5515.8 5528.0 11:43:36 INFO - PROCESS | 5049 | 11:43:36 INFO - PROCESS | 5049 | [#5] yui.html Cycles:180 Average:17841.66 Median:41631.58 stddev:21165.33 (50.8%) stddev-sans-first:21186.05 11:43:36 INFO - PROCESS | 5049 | Values: 807.8 825.7 902.6 929.3 939.2 16142.2 16692.9 16709.8 16733.6 16753.4 15589.1 17361.3 17599.0 17607.0 17609.7 838.4 862.2 865.6 865.7 866.4 877.2 881.3 882.2 883.3 884.5 914.1 921.3 922.8 923.4 924.0 910.9 911.9 913.2 913.9 914.8 674.7 677.2 680.0 680.1 681.8 15242.8 15270.8 16285.5 16744.6 16880.4 13821.9 13968.9 14453.9 14489.8 14489.8 12818.9 12851.7 12870.3 12925.5 13167.5 3906.1 3919.2 3939.4 3981.8 3997.5 49621.0 59062.4 60672.7 65314.3 82038.0 13454.5 13486.8 13617.6 13667.0 13740.5 25020.0 25101.7 25272.5 25425.7 25596.6 9094.1 9123.5 9232.6 9344.5 9363.5 4819.7 4919.5 4968.9 4974.4 4984.5 3748.2 3792.9 3822.6 3822.6 3829.3 630.2 633.2 638.1 641.9 653.2 808.3 821.4 845.5 861.1 868.3 10747.9 10862.4 11085.6 11283.9 11400.8 812.1 815.2 832.3 840.7 845.0 5336.2 5503.1 5577.6 5618.1 5685.0 81052.0 81802.0 83077.0 83336.0 83820.0 47792.8 59450.7 71144.0 71365.0 72470.0 62357.0 62369.4 63042.4 63382.4 63433.4 11750.4 11903.3 12140.1 12337.9 12392.8 41628.2 41635.0 42078.0 42250.0 42857.0 49735.5 51023.5 51063.5 51205.5 51331.5 15094.5 15194.5 15241.6 15384.2 15542.3 15784.7 15959.1 16134.7 16199.4 17052.5 15134.4 15159.3 15529.5 16041.4 16091.3 14537.0 14567.6 15696.4 15957.8 16262.1 14848.6 15327.2 15685.7 16039.2 16210.3 10545.8 10704.4 10836.5 10992.8 11072.2 12792.3 12963.9 13084.2 13257.6 13268.3 11:43:36 INFO - PROCESS | 5049 | -------- Summary: end -------- 11:43:36 INFO - PROCESS | 5049 | 11:43:37 INFO - TEST-INFO | 5049: exit 0 11:43:37 INFO - TEST-OK | dromaeo_css | took 1114967ms 11:43:37 INFO - TEST-START | kraken 11:43:37 INFO - operating with platform_type : linux_ 11:43:37 INFO - Initialising browser for kraken test... 11:43:37 INFO - TEST-INFO | started process 5354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrCFvB/profile http://localhost:56653/getInfo.html) 11:43:41 INFO - PROCESS | 5354 | __metrics Screen width/height:1600/1200 11:43:41 INFO - PROCESS | 5354 | colorDepth:24 11:43:41 INFO - PROCESS | 5354 | Browser inner width/height: 1024/697 11:43:41 INFO - PROCESS | 5354 | __metrics 11:43:42 INFO - PROCESS | 5354 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:43:42 INFO - PROCESS | 5354 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:42 INFO - PROCESS | 5354 | console.error: PushService: 11:43:42 INFO - PROCESS | 5354 | stateChangeProcessEnqueue: Error transitioning state 11:43:42 INFO - PROCESS | 5354 | UnknownError 11:43:43 INFO - TEST-INFO | 5354: exit 0 11:43:43 INFO - Browser initialized. 11:43:43 INFO - Running cycle 1/1 for kraken test... 11:43:43 INFO - TEST-INFO | started process 5447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrCFvB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:55 INFO - PROCESS | 5447 | RSS: Main: 141697024 11:43:55 INFO - PROCESS | 5447 | 11:43:57 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56653/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:58 INFO - PROCESS | 5447 | RSS: Main: 184012800 11:43:58 INFO - PROCESS | 5447 | 11:44:00 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56653/tests/kraken/driver.html?testName=audio-dft) 11:44:01 INFO - PROCESS | 5447 | RSS: Main: 173957120 11:44:01 INFO - PROCESS | 5447 | 11:44:04 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56653/tests/kraken/driver.html?testName=audio-fft) 11:44:04 INFO - PROCESS | 5447 | RSS: Main: 265932800 11:44:04 INFO - PROCESS | 5447 | 11:44:06 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56653/tests/kraken/driver.html?testName=audio-oscillator) 11:44:07 INFO - PROCESS | 5447 | RSS: Main: 172519424 11:44:07 INFO - PROCESS | 5447 | 11:44:09 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:10 INFO - PROCESS | 5447 | RSS: Main: 175194112 11:44:10 INFO - PROCESS | 5447 | 11:44:13 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56653/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:13 INFO - PROCESS | 5447 | RSS: Main: 212148224 11:44:13 INFO - PROCESS | 5447 | 11:44:17 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56653/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:17 INFO - PROCESS | 5447 | RSS: Main: 213299200 11:44:17 INFO - PROCESS | 5447 | 11:44:20 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56653/tests/kraken/driver.html?testName=json-parse-financial) 11:44:21 INFO - PROCESS | 5447 | RSS: Main: 211922944 11:44:21 INFO - PROCESS | 5447 | 11:44:22 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:23 INFO - PROCESS | 5447 | RSS: Main: 174444544 11:44:23 INFO - PROCESS | 5447 | 11:44:24 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:25 INFO - PROCESS | 5447 | RSS: Main: 180867072 11:44:25 INFO - PROCESS | 5447 | 11:44:27 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:28 INFO - PROCESS | 5447 | RSS: Main: 190545920 11:44:28 INFO - PROCESS | 5447 | 11:44:30 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:31 INFO - PROCESS | 5447 | RSS: Main: 199729152 11:44:31 INFO - PROCESS | 5447 | 11:44:33 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:34 INFO - PROCESS | 5447 | RSS: Main: 195584000 11:44:34 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | Cycle 1(1): loaded http://localhost:56653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56653/tests/kraken/driver.html?testName=ai-astar) 11:44:36 INFO - PROCESS | 5447 | RSS: Main: 246882304 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | __start_tp_report 11:44:36 INFO - PROCESS | 5447 | _x_x_mozilla_page_load 11:44:36 INFO - PROCESS | 5447 | _x_x_mozilla_page_load_details 11:44:36 INFO - PROCESS | 5447 | |i|pagename|runs| 11:44:36 INFO - PROCESS | 5447 | |0;ai-astar;105;110;113;112;127;113;113;112;113;111 11:44:36 INFO - PROCESS | 5447 | |1;audio-beat-detection;146;114;121;154;115;120;114;115;141;115 11:44:36 INFO - PROCESS | 5447 | |2;audio-dft;160;163;162;163;163;160;160;160;162;161 11:44:36 INFO - PROCESS | 5447 | |3;audio-fft;73;75;76;110;76;75;76;76;92;76 11:44:36 INFO - PROCESS | 5447 | |4;audio-oscillator;82;82;110;82;82;83;94;82;82;96 11:44:36 INFO - PROCESS | 5447 | |5;imaging-gaussian-blur;113;112;112;113;114;112;113;113;113;113 11:44:36 INFO - PROCESS | 5447 | |6;imaging-darkroom;148;147;146;147;146;147;145;146;146;146 11:44:36 INFO - PROCESS | 5447 | |7;imaging-desaturate;94;94;94;95;94;94;94;96;94;94 11:44:36 INFO - PROCESS | 5447 | |8;json-parse-financial;53;55;54;53;55;56;54;55;55;53 11:44:36 INFO - PROCESS | 5447 | |9;json-stringify-tinderbox;54;53;53;54;53;56;53;53;54;53 11:44:36 INFO - PROCESS | 5447 | |10;stanford-crypto-aes;79;78;75;81;74;77;76;79;78;78 11:44:36 INFO - PROCESS | 5447 | |11;stanford-crypto-ccm;122;131;121;127;120;127;118;119;156;118 11:44:36 INFO - PROCESS | 5447 | |12;stanford-crypto-pbkdf2;160;159;158;157;157;156;158;161;158;159 11:44:36 INFO - PROCESS | 5447 | |13;stanford-crypto-sha256-iterative;63;64;61;60;64;60;60;69;60;61 11:44:36 INFO - PROCESS | 5447 | __end_tp_report 11:44:36 INFO - PROCESS | 5447 | __start_cc_report 11:44:36 INFO - PROCESS | 5447 | _x_x_mozilla_cycle_collect,1663 11:44:36 INFO - PROCESS | 5447 | __end_cc_report 11:44:36 INFO - PROCESS | 5447 | __startTimestamp1496774676440__endTimestamp 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | ------- Summary: start ------- 11:44:36 INFO - PROCESS | 5447 | Number of tests: 14 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:5.53 (4.9%) stddev-sans-first:5.07 11:44:36 INFO - PROCESS | 5447 | Values: 105.0 110.0 113.0 112.0 127.0 113.0 113.0 112.0 113.0 111.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:120.50 stddev:15.34 (12.7%) stddev-sans-first:14.37 11:44:36 INFO - PROCESS | 5447 | Values: 146.0 114.0 121.0 154.0 115.0 120.0 114.0 115.0 141.0 115.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.33 11:44:36 INFO - PROCESS | 5447 | Values: 160.0 163.0 162.0 163.0 163.0 160.0 160.0 160.0 162.0 161.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.03 11:44:36 INFO - PROCESS | 5447 | Values: 73.0 75.0 76.0 110.0 76.0 75.0 76.0 76.0 92.0 76.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:82.00 stddev:9.56 (11.7%) stddev-sans-first:9.93 11:44:36 INFO - PROCESS | 5447 | Values: 82.0 82.0 110.0 82.0 82.0 83.0 94.0 82.0 82.0 96.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 11:44:36 INFO - PROCESS | 5447 | Values: 113.0 112.0 112.0 113.0 114.0 112.0 113.0 113.0 113.0 113.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 11:44:36 INFO - PROCESS | 5447 | Values: 148.0 147.0 146.0 147.0 146.0 147.0 145.0 146.0 146.0 146.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:44:36 INFO - PROCESS | 5447 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 96.0 94.0 94.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 11:44:36 INFO - PROCESS | 5447 | Values: 53.0 55.0 54.0 53.0 55.0 56.0 54.0 55.0 55.0 53.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:53.50 stddev:0.97 (1.8%) stddev-sans-first:1.01 11:44:36 INFO - PROCESS | 5447 | Values: 54.0 53.0 53.0 54.0 53.0 56.0 53.0 53.0 54.0 53.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:2.07 (2.7%) stddev-sans-first:2.12 11:44:36 INFO - PROCESS | 5447 | Values: 79.0 78.0 75.0 81.0 74.0 77.0 76.0 79.0 78.0 78.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.50 stddev:11.45 (9.2%) stddev-sans-first:12.06 11:44:36 INFO - PROCESS | 5447 | Values: 122.0 131.0 121.0 127.0 120.0 127.0 118.0 119.0 156.0 118.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.50 stddev:1.49 (0.9%) stddev-sans-first:1.45 11:44:36 INFO - PROCESS | 5447 | Values: 160.0 159.0 158.0 157.0 157.0 156.0 158.0 161.0 158.0 159.0 11:44:36 INFO - PROCESS | 5447 | 11:44:36 INFO - PROCESS | 5447 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:2.90 (4.7%) stddev-sans-first:3.06 11:44:36 INFO - PROCESS | 5447 | Values: 63.0 64.0 61.0 60.0 64.0 60.0 60.0 69.0 60.0 61.0 11:44:36 INFO - PROCESS | 5447 | -------- Summary: end -------- 11:44:36 INFO - PROCESS | 5447 | 11:44:37 INFO - TEST-INFO | 5447: exit 0 11:44:37 INFO - TEST-OK | kraken | took 59998ms 11:44:37 INFO - SUITE-END | took 1174s 11:44:37 INFO - Completed test suite (00:19:35) 11:44:37 INFO - javascript benchmark 11:44:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7884.021288657297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.555774970379, 3376.8480418381173, 3424.79451232926, 3450.8619655213793, 3471.3925063113966, 5664.716764161791, 5708.600397972144, 5736.741846616902, 5741.024025915604, 5765.192872997778, 5724.284464441945, 5802.912956305649, 5808.41915808419, 5808.82573522794, 5819.418058194178, 5157.71632560209, 5170.560502357304, 5173.715445650488, 5189.481051894818, 5223.843284701465, 4959.305697202394, 4982.277569752384, 5253.44838791927, 5258.47415258473, 5284.841454756363, 5118.872028199287, 5148.253503242027, 5151.587872970172, 5170.405403378622, 5172.612054095939, 5224.869378265555, 5237.816676416345, 5238.292830467876, 5238.528532432061, 5260.815871444481, 4954.628402869763, 5090.058339207221, 5151.304573882553, 5187.403448603422, 5191.480851914816, 5599.944000560024, 5610.326760788691, 5660.179274005287, 5685.715714214272, 5689.7439615217, 6095.329513753483, 6123.877522449526, 6156.415140561639, 6160.8767824643255, 6166.599171053912, 6157.3534778848025, 6211.0, 6216.160818289518, 6216.378362163793, 6216.968915155395, 5541.085720856054, 5562.471565201299, 5728.169415434781, 5748.511376533042, 5764.365919748824, 6290.056491526216, 6303.9684801575695, 6306.24325080984, 6308.463780578611, 6308.968455157787, 6013.037913933749, 6059.787907423219, 6062.090686397076, 6063.818085457443, 6075.513958883279, 5852.473277405054, 5874.559408044413, 6085.4523092921845, 6182.28903676074, 6183.227096612924, 6107.328193898667, 6119.634116586723, 6122.550631082941, 6139.324674285825, 6139.47814435769, 5903.203067585821, 5951.404859514014, 5952.0476723724, 5953.226080609493, 6145.324014358417, 4560.771961401917, 4654.557817007379, 4655.068986202773, 4666.416697912761, 4667.323238130452, 4190.573207696041, 4206.8737937861915, 4216.009237829107, 4221.97889010553, 4228.70399072062, 5499.917501237404, 5592.86017849557, 5685.317761868602, 5753.309602847685, 5924.674142922095, 6173.59871608344, 6204.627722336674, 6207.255129384503, 6207.937920620736, 6211.9689401553605, 5880.94119058804, 5891.941080589139, 5895.263092113486, 5899.351071382144, 5929.644221346733, 5058.089543882063, 5092.0, 5193.350831146106, 5223.242629818655, 5230.63385563007, 6483.0, 6484.935150648433, 6485.156929599122, 6487.643179625166, 6492.448141907991, 6111.724972376165, 6214.9067763982675, 6221.3156552778255, 6222.066689996536, 6223.875522489616, 6133.365267548864, 6191.442770150708, 6492.091107245084, 6492.5455218134275, 6502.674866256573, 6022.759089636365, 6044.7279872406725, 6114.449440885012, 6124.136831511461, 6126.3955342902, 6172.537059720449, 6173.629582225081, 6178.969105154445, 6179.443850053337, 6181.320054794059, 5742.885142297047, 5979.133025711334, 6028.909566356596, 6032.638041717511, 6074.271087469532, 5808.5643576732755, 5942.762289508371, 5949.791757288647, 6006.669633170218, 6090.817275481742, 6003.6998150093195, 6008.188894499187, 6009.87980240384, 6009.939900600938, 6022.307434644897, 5814.73833677494, 5848.122781582797, 5861.179434879035, 6038.63768173911, 6048.6975651218145, 5761.078227483583, 5857.765689372377, 5890.293164820249, 5902.144189092472, 5910.408959104056], "value": 5646.129557902594, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1163673412311, 838.2790799912076, 862.9093945135762, 907.0113576201943, 916.4272329793879, 31851.36297274053, 44009.33985990209, 44323.77838110813, 44478.0, 44482.777586112024, 40154.0, 40315.395269070985, 40344.59655403445, 45298.547014529846, 45412.54587454125, 7776.183500732426, 9087.136722011415, 9214.953925230364, 9215.308851836106, 9219.95390023049, 7745.1093124290865, 10556.049955504002, 10769.246152769309, 10773.676789696283, 10776.73058173548, 10814.837777433344, 10845.945770271137, 10856.565737370496, 10859.294145880533, 10866.565337386495, 10679.252452328341, 10737.516811743451, 10759.193060520493, 10765.569377224901, 10780.73048173794, 10548.156147508258, 10565.841512377321, 10579.259451838374, 10610.893891061069, 10611.204159688054, 42136.36795448071, 42269.57730422687, 42449.36325955113, 42456.57543424557, 42560.78719606413, 4301.548337424588, 4330.415393921843, 4398.8900277493, 4491.865244042684, 4493.460784705856, 30700.38599228003, 31094.84452577745, 31117.0, 31198.22004449884, 32559.83720081408, 4315.4821421429315, 4352.925973419196, 4366.978165109186, 4383.189110014658, 4461.754603496806, 242173.99999999822, 242437.0, 242515.0, 243020.0, 244146.0, 53724.46275537195, 53934.0, 54032.189517157276, 54182.7290863551, 54195.729021354644, 56369.43630563642, 56470.717646411504, 56478.0, 56492.0, 56499.71750141223, 15082.396704131932, 15440.0, 15447.845521544865, 15466.690666186612, 15471.845281547265, 10990.615328463466, 11096.1123110151, 13484.865151348557, 13500.32498375097, 13500.662483437993, 13271.336433178303, 13405.329733513481, 13803.861961380258, 13826.446942122202, 13952.0, 5592.217089607459, 5593.216949627055, 5614.6631202128, 5629.577781666391, 5650.886982260414, 1003.4380746781826, 1008.5174793054199, 1012.9949350253349, 1018.7045756730613, 1032.7521394865178, 28773.712262877103, 28845.423091538472, 28966.0, 29237.41525169527, 29424.411511769646, 1082.9241953063367, 1083.544911137324, 1101.2841652925663, 1114.4650567727535, 1129.971750706239, 14826.443223461381, 15360.769588456182, 15367.769483457758, 15428.614284642748, 15462.613434664223, 291064.0, 293282.0, 293679.0, 295402.0, 297698.0, 55927.440725593035, 56123.0, 56177.0, 56211.43788562144, 56570.0, 1504.5711972087902, 1530.8469153084602, 1538.907665540071, 1570.0, 1587.103286643066, 27728.445431090862, 28962.710372896003, 29000.709992900644, 29537.34163925257, 29911.700882990892, 37695.246095078495, 37826.24347512979, 37900.0, 37928.62071379251, 37934.0, 282667.0, 283630.0, 283926.0, 284246.0, 284914.0, 29721.702782971894, 29947.0, 30037.0, 30375.848120759256, 30577.388452230385, 40635.796821015705, 40663.1867362657, 40826.0, 40956.18087638171, 41075.794621026704, 30914.0, 31194.532082018333, 31512.684873150974, 31637.20906977344, 31765.841170794924, 31413.21466963253, 31537.21156971094, 31573.210669733442, 31720.36559268848, 31781.0, 36188.63811361853, 36428.81785591055, 36826.8158659205, 36963.07592310214, 37071.62928370682, 29780.851095744383, 29862.954796582017, 29962.79208215491, 30185.849070754506, 30196.5470517938, 24772.0, 24827.255182344557, 24943.750562494144, 25010.124645637316, 25253.747462525138], "value": 18717.171863973388, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.37371921625015, 476.16433159804535, 481.6652426563539, 486.4405933176844, 501.1605560685851, 20228.0, 21459.67810482842, 21700.782992170072, 21831.781682183173, 21909.780902190974, 21926.342209733695, 22330.106795728152, 22640.20759273426, 22778.88610556949, 22803.429914252152, 6541.378569035934, 6686.465082793377, 6783.7625683101105, 6812.489063320246, 6845.726170953156, 6744.325567443266, 6750.459963202957, 6804.18349798025, 7196.8200794980285, 7463.626818659072, 7640.5482958238035, 7650.273224043707, 7661.502002369856, 7663.080430348338, 7666.693332266703, 7486.288802563748, 7613.8477230455355, 7658.502197357154, 7659.387249020093, 7661.272179142972, 7220.3140701633265, 7424.517406368569, 7447.813804654873, 7468.4025277977635, 7470.626468676599, 25496.49007019849, 25606.87196564024, 25897.741022589722, 25995.870020649774, 26038.86980565104, 3085.197848559368, 3155.4477966356026, 3170.6670799566173, 3285.1130194847497, 3290.457074582691, 15764.921175394164, 16076.75884861728, 16301.59246018847, 16334.673306533921, 16460.917695411565, 2282.372347604422, 2339.6724458575814, 2347.8591284522813, 2384.666146739458, 2403.110848985869, 72238.0, 103862.0, 118034.0, 118359.0, 121480.0, 17206.827931720774, 17700.822991769917, 17791.377301794375, 18288.81711182871, 18315.267389304547, 31433.528497072562, 31645.36709265848, 31715.52426713601, 31786.841065794986, 31818.522722159185, 10540.578376864993, 10599.205059620559, 10787.734575739183, 10789.46052697362, 10959.945200274107, 9074.637014519478, 9183.441542399241, 9186.356955013085, 9396.483193424427, 9411.0, 8623.525706086226, 8978.685745998859, 9127.26981841451, 9233.815323693489, 9291.349605527548, 3531.7351198660203, 3586.6234045425376, 3663.578688450862, 3723.4414837774552, 3735.0849041984343, 934.621478301289, 976.023976023976, 1146.4554336690005, 1180.1974657233163, 1214.9817752733716, 20283.290084846958, 20332.593348132956, 20400.59198816045, 20503.589928201352, 20603.0, 1174.6358628825092, 1185.4606154199819, 1189.3755778216332, 1206.6259459567561, 1225.1301575881225, 10848.620298289521, 11120.277181983145, 11207.271527350696, 11243.83134252987, 11246.943765281285, 660844.0, 672883.0, 686697.0, 689191.0, 705113.0, 78373.68779619408, 98422.5078874601, 101835.49082254541, 111214.44392777984, 127603.0, 1254.85569159546, 1280.3918138884142, 1318.8878945289757, 1326.7014921642747, 1343.355189509041, 18747.53131171677, 18957.715634265773, 19049.142788574823, 19087.713684294467, 19201.903990479957, 54166.458335416144, 54336.728316359746, 54599.72700136633, 55051.17423238575, 56082.71958640181, 64747.676261620276, 67111.32888671051, 73014.26985730288, 74191.25808741844, 77594.6120269395, 12372.938135309267, 12906.612801615967, 13028.0, 13191.406386712813, 13338.866611334151, 11701.824472633087, 14583.343749531508, 14918.32867520986, 15073.547793565773, 15409.460668876536, 7296.854062918818, 12489.313087779896, 12778.105532612628, 13105.2136871788, 13589.45642174302, 12068.336241506802, 12186.895491295216, 12250.448729807358, 12364.62906112818, 12525.185862918881, 11945.641630751092, 12685.0, 13167.73664526685, 13617.25105119228, 13758.449662013407, 12864.356782160667, 13150.276734779296, 13159.144655597356, 13173.934130329288, 13238.933805330911, 12764.489420423079, 12795.168314059556, 12843.614691559269, 12886.548970785978, 13150.21098734079], "value": 11775.084980954536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.1382968622727, 1548.798656174697, 1569.5605230535439, 1578.4554328756583, 1583.0976343484213, 11033.613823516178, 11846.7630647387, 11848.881511184885, 11854.3480108594, 11867.991220746237, 11502.884971150286, 11579.65261042168, 11760.353180575064, 11765.117616178799, 11766.235194712337, 2461.544614246361, 2499.0, 2501.9249422517264, 2505.3987043109614, 2507.699076110869, 2400.3639035655565, 2445.5475736988624, 2472.678551788265, 2484.527939691462, 2485.2420011896365, 2332.4402143485527, 2358.3160883343808, 2476.8885400157037, 2536.644869718241, 2548.2610043087484, 2423.842450240729, 2425.866577338246, 2444.1567659157563, 2445.8532488050687, 2471.2339174855674, 2383.9642405363934, 2404.158544509425, 2411.397150712322, 2417.528581926525, 2420.649005894153, 11192.66422007333, 11355.772884542263, 11369.886301136965, 11379.317240965569, 11381.260218085798, 5861.88276234473, 6008.699565021731, 6018.398160183947, 6020.006698894677, 6021.187139736167, 3496.4755286706945, 3527.206378564828, 3596.9677132420097, 3604.3151801157696, 3654.4701018352457, 1418.581518452059, 1425.1947649577955, 1472.8158980127484, 1472.8600782925605, 1500.6623509710337, 17949.282028718837, 17988.640227195512, 18104.0, 18146.818531814777, 18151.818481815146, 4451.532589078165, 4626.0, 4672.5327467253, 4710.128626204095, 4715.575598196178, 13419.798703019462, 13424.530141445002, 13424.865751342362, 13429.059965802495, 13436.596902092953, 5773.711314434261, 5827.650340979555, 5872.911906321408, 5877.23595932526, 5883.0881213411985, 5435.510804027656, 5467.316585426822, 5480.972595136999, 5560.277163968658, 5566.276384070045, 4128.525219599725, 4155.79481950231, 4180.331147016463, 4236.491621005437, 4247.256730072287, 1036.875574931013, 1037.123630532214, 1049.7690508088208, 1050.6742909698019, 1056.815057364958, 1066.8719753629614, 1070.55571937645, 1078.8759292681443, 1081.324172392255, 1082.5345101606385, 7054.0, 7166.104236970379, 7200.0, 7302.671379787922, 7332.450066245053, 1095.0856035210688, 1104.3484344236938, 1105.2318638546133, 1112.3659514076899, 1115.8437818705388, 4595.346699374006, 4619.376384188159, 4732.858014259577, 4909.656324057281, 4922.409310882717, 14332.068415552956, 14494.710105797825, 14650.413983440756, 14817.77773333401, 14866.405343786128, 14121.152730836182, 14326.355314010894, 14475.493357732428, 14752.778708319383, 14764.926175369055, 10438.478076096164, 10521.31611445269, 10676.145908327315, 10682.62610808618, 10804.243702940876, 7199.928000720135, 7420.480566360519, 7545.283198096172, 7576.0, 7702.345300649507, 13037.15258508194, 13275.668108296983, 13379.130356527185, 13392.330383480592, 13435.0, 13403.664908377368, 13548.187108773505, 13573.86426135726, 13586.116902401312, 13722.794158087836, 9994.900050999397, 10242.436665983145, 10251.026152515498, 10282.742931426774, 10287.074163325336, 10443.425611591436, 10647.148228141885, 10715.946420267848, 10736.141108711441, 10740.570377184826, 9436.386634868712, 9616.567254473706, 9674.9032509674, 9785.657501987396, 9808.313418060667, 9055.637774488947, 9059.411138275991, 9074.591643375932, 9208.585613647536, 9265.119813617695, 8684.782880427787, 8689.782755431164, 8693.608787604446, 8793.91206087931, 8800.867986980329, 6274.874502510015, 6357.110004599453, 6378.266499352634, 6469.126667899962, 6536.542442029012, 6318.810435686937, 6495.350464953467, 6516.609003459807, 6566.573172743948, 6628.2921693179815], "value": 5503.42158686841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.96571308582224, 436.66595054783096, 444.200439209423, 448.5268042215461, 456.94745104313006, 5168.302279192308, 5272.340957380327, 5396.406395296524, 5431.456854314567, 5455.18172274159, 5088.821891233808, 5272.0, 5294.52349288564, 5341.679499230049, 5348.866278343044, 4439.889002774924, 4440.755758433284, 4444.666650001247, 4446.533114023029, 4454.53227411122, 4279.2083464559, 4312.835534405708, 4340.348947657861, 4378.912421751579, 4446.688731788776, 4321.373400856874, 4355.477342718878, 4376.168527979674, 4388.97805510972, 4394.40675508807, 4337.891552711176, 4340.500842403132, 4381.978090109545, 4402.3176407656865, 4407.052483715985, 3963.286608410485, 4118.691098167619, 4141.1426115979875, 4148.465067924857, 4177.164567086565, 5053.67151135175, 5063.873403164914, 5109.591232701375, 5129.692218466904, 5152.355955505562, 5142.948570514284, 5149.201873709581, 5150.038727731569, 5157.510036546522, 5171.405288391846, 5334.306540149756, 5515.773272635513, 5556.638818476786, 5574.247476590649, 5637.210790489335, 4628.95848434103, 4629.3750343703505, 4660.580547750718, 4661.277501987163, 4671.906561868777, 5843.298804143487, 5852.209951656514, 5864.530837532987, 5869.677167755772, 5911.704414779287, 4572.353952577069, 4756.6432517561325, 4788.95211047892, 4799.472058073609, 4885.511448855086, 4617.8383756568355, 4792.95207047932, 4818.807247710122, 4830.758462076882, 4884.902301953941, 5016.44819069902, 5036.924446133311, 5059.215821547666, 5118.515630467123, 5161.27742116104, 5490.396056433789, 5527.683389966069, 5528.778848846001, 5552.500824777288, 5554.1946417769195, 1593.0441734958931, 1659.5436255029963, 1661.5015495351347, 1669.273865868351, 1675.9832401676072, 1255.5480027190204, 1289.2586762611536, 1292.1213574769247, 1298.8701129886936, 1300.2133709106045, 5303.257543943851, 5429.972850135724, 5434.3207099112615, 5468.179773034077, 5474.39781624021, 5664.612170018372, 5665.442003449084, 5686.232358631614, 5688.037627018672, 5688.687122208318, 5250.868728281747, 5345.705986170798, 5400.729963501809, 5421.647592906448, 5448.42791506894, 3003.9098827035223, 3006.7444267237092, 3009.6689364169924, 3010.3828715113787, 3012.5932999045285, 5723.627964182315, 5943.821685349447, 5950.940490595125, 5983.790567330209, 5999.340072592011, 5754.625949313281, 5840.795572155039, 5871.238628411459, 5888.941110588839, 5913.793017244376, 5981.401859813984, 5995.280566332068, 5999.160117583542, 6008.429199226067, 6015.488683461955, 5413.945860541344, 5717.685527296038, 5726.914096288476, 5735.254416925773, 5756.740946657326, 5604.551635869202, 5608.46719561641, 5634.098544232903, 5660.377358490645, 5683.204351390726, 5722.828315150552, 5908.645481271137, 5979.282486101695, 5998.580099393175, 6026.15633811258, 4730.574248317668, 4774.618030557477, 4820.180569303297, 4829.9275510868065, 4842.951570484391, 5551.417845914057, 5595.468430499259, 5604.355499117653, 5632.070708333079, 5690.634247780586, 5517.282753242052, 5522.889542209214, 5538.873539213312, 5543.25166102571, 5560.582956278215, 5209.348831396075, 5494.697791621499, 5509.807156749494, 5515.531179849758, 5574.16387541872, 5495.505404513453, 5517.282753242052, 5522.658791431127, 5527.778888844401, 5555.583331250254, 5588.842304098172, 5641.435856414326, 5644.294463192101, 5655.830325090254, 5673.574481913791, 5293.0, 5466.945330546644, 5480.369757477941, 5515.779368825362, 5527.972360138335], "value": 4476.915798003536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.83439394924, 825.7068740597088, 902.5532361481066, 929.3355250995539, 939.2016785732133, 16142.19289035548, 16692.91653541732, 16709.83290167098, 16733.58166045848, 16753.413630522904, 15589.142597157152, 17361.305547778105, 17599.0, 17607.031613261264, 17609.7358539622, 838.4256784102894, 862.1507814802414, 865.5758678247645, 865.6580650642992, 866.4324867211955, 877.2324216310728, 881.2597418168737, 882.2016075451727, 883.3463237204487, 884.4693184089527, 914.0676509959837, 921.3136213520936, 922.7785331520421, 923.4044041593169, 923.9722808315761, 910.8952470465915, 911.8586619073988, 913.2009491694768, 913.9405938614002, 914.8261830252264, 674.723363420995, 677.190757045331, 679.9830004249884, 680.1124532485105, 681.8465845184843, 15242.771358429522, 15270.770938435933, 16285.51143465686, 16744.58138546534, 16880.409185678564, 13821.861781382158, 13968.860311396958, 14453.927730361385, 14489.782653260105, 14489.78265326021, 12818.935905320506, 12851.742965140738, 12870.29213393263, 12925.54760583375, 13167.473301067947, 3906.1211227473877, 3919.1573811630637, 3939.3500072488005, 3981.820818063194, 3997.520297564311, 49621.0, 59062.40937590612, 60672.69663651698, 65314.3468565313, 82038.0, 13454.461821527226, 13486.797698034537, 13617.591472255848, 13667.0, 13740.450381984609, 25020.0, 25101.748982510308, 25272.494550108895, 25425.74574254271, 25596.616050759254, 9094.136057074567, 9123.498207598514, 9232.630694772268, 9344.486053267136, 9363.485008324607, 4819.6867203631655, 4919.508049195123, 4968.925466118011, 4974.37820272466, 4984.501549845059, 3748.231612519427, 3792.943105853414, 3822.560405553397, 3822.636849499293, 3829.349010668193, 630.1776182082426, 633.2401118657538, 638.0684201066402, 641.9261784894703, 653.1541653558653, 808.3371635259031, 821.4291067708006, 845.5349557743217, 861.1388611388611, 868.3400615532115, 10747.892521074846, 10862.402567858686, 11085.612003579836, 11283.943580282046, 11400.828987565194, 812.0580127052591, 815.1644564321617, 832.3382910586099, 840.7057529864499, 844.995775021121, 5336.226247194213, 5503.147012213113, 5577.553795696334, 5618.101103823368, 5685.0, 81052.0, 81802.0, 83077.0, 83336.0, 83820.0, 47792.76103619529, 59450.70274648599, 71144.0, 71365.0, 72470.0, 62357.0, 62369.37630623636, 63042.36957630457, 63382.366176337644, 63433.36566634367, 11750.412479375826, 11903.345316007702, 12140.089493288215, 12337.938310308391, 12392.81410778857, 41628.1674366517, 41635.0, 42078.0, 42250.0, 42857.0, 49735.50264497309, 51023.48976510336, 51063.489365105874, 51205.48794512007, 51331.48668513267, 15094.54716358511, 15194.544163675107, 15241.6189595261, 15384.153871537173, 15542.30059647296, 15784.684306314039, 15959.122248275991, 16134.67730645357, 16199.43301984425, 17052.48842534726, 15134.394624214909, 15159.317830697866, 15529.45646902353, 16041.358345666044, 16091.275892584628, 14537.0, 14567.635809104857, 15696.372145114068, 15957.760633590273, 16262.10558419251, 14848.62878428048, 15327.157006364758, 15685.686286274438, 16039.198040098181, 16210.27053782559, 10545.841812372973, 10704.35980172315, 10836.458177091272, 10992.835107473555, 11072.224944253825, 12792.296423696785, 12963.933607887184, 13084.214947103204, 13257.602271931857, 13268.336583170996], "value": 7832.168988682397, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 113.0, 112.0, 127.0, 113.0, 113.0, 112.0, 113.0, 111.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 121.0, 154.0, 115.0, 120.0, 114.0, 115.0, 141.0, 115.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 163.0, 163.0, 160.0, 160.0, 160.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 110.0, 76.0, 75.0, 76.0, 76.0, 92.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 82.0, 82.0, 83.0, 94.0, 82.0, 82.0, 96.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 55.0, 56.0, 54.0, 55.0, 55.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 53.0, 56.0, 53.0, 53.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 75.0, 81.0, 74.0, 77.0, 76.0, 79.0, 78.0, 78.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 121.0, 127.0, 120.0, 127.0, 118.0, 119.0, 156.0, 118.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 157.0, 157.0, 156.0, 158.0, 161.0, 158.0, 159.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 60.0, 64.0, 60.0, 60.0, 69.0, 60.0, 61.0], "value": 62.2, "unit": "score"}]}]} 11:44:37 INFO - Return code: 0 11:44:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:37 INFO - # TBPL SUCCESS # 11:44:37 INFO - Running post-action listener: _resource_record_post_action 11:44:37 INFO - [mozharness: 2017-06-06 18:44:37.751740Z] Finished run-tests step (success) 11:44:37 INFO - Running post-run listener: _resource_record_post_run 11:44:37 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326627328; Read time: 4; Write time: 146212 11:44:37 INFO - TinderboxPrint: CPU usage
13.1% 11:44:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 11:44:37 INFO - TinderboxPrint: I/O write bytes / time
326,627,328 / 146,212 11:44:37 INFO - TinderboxPrint: CPU idle
8,248.7 (86.9%) 11:44:37 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 11:44:37 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:37 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 99115008; Read time: 0; Write time: 71256 11:44:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 227512320; Read time: 0; Write time: 74956 11:44:38 INFO - Running post-run listener: _upload_blobber_files 11:44:38 INFO - Blob upload gear active. 11:44:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:38 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 11:44:38 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:38 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:43 INFO - (blobuploader) - INFO - Done attempting. 11:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:43 INFO - (blobuploader) - INFO - Done attempting. 11:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:45 INFO - (blobuploader) - INFO - Done attempting. 11:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:46 INFO - (blobuploader) - INFO - Done attempting. 11:44:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:46 INFO - Return code: 0 11:44:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/168622da9c10db569c203b564916fe563ea45adf3f253702a7b4852f5c07c4e70c3d6aedc04fa0aa369d329b9a6a99166c78017d874bb06dcb9231ded0e4dcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06266ad9e02c48bdb5f60c80778bf7e6ed588ce7bad43f7219c5978a793065a2d41e194a0e27aa39bb78b9cdcae2ebcaa9f5c35acbdfcfbfe66280b3b0bd83d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb5e30d315a5e049fd818f43ad60dff7fdfbdf4d7bc27ab564f4dfa1353350ca793b4c9d15dd023d11195999fd26924fe8d53c9aad50268f4605dd1e5afca215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f09eba07c13226f45e4499f46e9f3011a44595309f2bd48428c57a6075146de7a3e35e3c137a866330e5a6e53bd6daa640f5e2754f1dfaedb73169056559222f"} 11:44:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:46 INFO - Contents: 11:44:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/168622da9c10db569c203b564916fe563ea45adf3f253702a7b4852f5c07c4e70c3d6aedc04fa0aa369d329b9a6a99166c78017d874bb06dcb9231ded0e4dcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06266ad9e02c48bdb5f60c80778bf7e6ed588ce7bad43f7219c5978a793065a2d41e194a0e27aa39bb78b9cdcae2ebcaa9f5c35acbdfcfbfe66280b3b0bd83d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb5e30d315a5e049fd818f43ad60dff7fdfbdf4d7bc27ab564f4dfa1353350ca793b4c9d15dd023d11195999fd26924fe8d53c9aad50268f4605dd1e5afca215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f09eba07c13226f45e4499f46e9f3011a44595309f2bd48428c57a6075146de7a3e35e3c137a866330e5a6e53bd6daa640f5e2754f1dfaedb73169056559222f"} 11:44:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:46 INFO - Copying logs to upload dir... 11:44:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.701654 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-06-06 11:44:46.062330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 11:44:46.067361) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/168622da9c10db569c203b564916fe563ea45adf3f253702a7b4852f5c07c4e70c3d6aedc04fa0aa369d329b9a6a99166c78017d874bb06dcb9231ded0e4dcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06266ad9e02c48bdb5f60c80778bf7e6ed588ce7bad43f7219c5978a793065a2d41e194a0e27aa39bb78b9cdcae2ebcaa9f5c35acbdfcfbfe66280b3b0bd83d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb5e30d315a5e049fd818f43ad60dff7fdfbdf4d7bc27ab564f4dfa1353350ca793b4c9d15dd023d11195999fd26924fe8d53c9aad50268f4605dd1e5afca215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f09eba07c13226f45e4499f46e9f3011a44595309f2bd48428c57a6075146de7a3e35e3c137a866330e5a6e53bd6daa640f5e2754f1dfaedb73169056559222f"} build_url:https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/RvrhZSBBQo-QgUQgAmhEqA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/168622da9c10db569c203b564916fe563ea45adf3f253702a7b4852f5c07c4e70c3d6aedc04fa0aa369d329b9a6a99166c78017d874bb06dcb9231ded0e4dcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06266ad9e02c48bdb5f60c80778bf7e6ed588ce7bad43f7219c5978a793065a2d41e194a0e27aa39bb78b9cdcae2ebcaa9f5c35acbdfcfbfe66280b3b0bd83d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb5e30d315a5e049fd818f43ad60dff7fdfbdf4d7bc27ab564f4dfa1353350ca793b4c9d15dd023d11195999fd26924fe8d53c9aad50268f4605dd1e5afca215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f09eba07c13226f45e4499f46e9f3011a44595309f2bd48428c57a6075146de7a3e35e3c137a866330e5a6e53bd6daa640f5e2754f1dfaedb73169056559222f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 11:44:46.099736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:44:46.100144) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496767483.706088-617198994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 11:44:46.182722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 11:44:46.183049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 11:44:46.183357) ========= ========= Total master_lag: 0.22 =========