builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-074 starttime: 1495092922.0 results: success (0) revision: 0884adb687d1b4cf95820feae19939d931053ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.003866) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.004308) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.004578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.043568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.043946) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 00:35:23-- 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% 222M=0s 2017-05-18 00:35:23 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.206493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.210004) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.259770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.260166) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0884adb687d1b4cf95820feae19939d931053ae7 --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 0884adb687d1b4cf95820feae19939d931053ae7 --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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 00:35:23,731 truncating revision to first 12 chars 2017-05-18 00:35:23,731 Setting DEBUG logging. 2017-05-18 00:35:23,731 attempt 1/10 2017-05-18 00:35:23,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0884adb687d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 00:35:23,987 unpacking tar archive at: mozilla-beta-0884adb687d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.796636) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.799966) ========= script_repo_revision: 0884adb687d1b4cf95820feae19939d931053ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.800337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.800591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 00:35:22.810482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-18 00:35:22.810776) ========= /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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:35:24 INFO - MultiFileLogger online at 20170518 00:35:24 in /builds/slave/test 00:35:24 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 00:35:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:35:24 INFO - {'append_to_log': False, 00:35:24 INFO - 'base_work_dir': '/builds/slave/test', 00:35:24 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 00:35:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:35:24 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 00:35:24 INFO - 'buildbot_json_path': 'buildprops.json', 00:35:24 INFO - 'config_files': ('talos/linux_config.py',), 00:35:24 INFO - 'default_actions': ('clobber', 00:35:24 INFO - 'read-buildbot-config', 00:35:24 INFO - 'download-and-extract', 00:35:24 INFO - 'populate-webroot', 00:35:24 INFO - 'create-virtualenv', 00:35:24 INFO - 'install', 00:35:24 INFO - 'run-tests'), 00:35:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:35:24 INFO - 'download_minidump_stackwalk': True, 00:35:24 INFO - 'download_symbols': 'ondemand', 00:35:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:35:24 INFO - 'tooltool.py': '/tools/tooltool.py', 00:35:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:35:24 INFO - '/tools/misc-python/virtualenv.py')}, 00:35:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:35:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:35:24 INFO - 'gecko_profile': False, 00:35:24 INFO - 'gecko_profile_interval': 0, 00:35:24 INFO - 'installer_path': 'installer.exe', 00:35:24 INFO - 'log_level': 'info', 00:35:24 INFO - 'log_name': 'talos', 00:35:24 INFO - 'log_to_console': True, 00:35:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:35:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:35:24 INFO - 'opt_config_files': (), 00:35:24 INFO - 'pip_index': False, 00:35:24 INFO - 'suite': 'dromaeojs', 00:35:24 INFO - 'system_bits': '32', 00:35:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:35:24 INFO - 'title': 'talos-linux64-ix-074', 00:35:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:35:24 INFO - 'use_talos_json': True, 00:35:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:35:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:35:24 INFO - 'work_dir': 'build'} 00:35:24 INFO - [mozharness: 2017-05-18 07:35:24.382721Z] Running clobber step. 00:35:24 INFO - Running pre-action listener: _resource_record_pre_action 00:35:24 INFO - Running main action method: clobber 00:35:24 INFO - rmtree: /builds/slave/test/build 00:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:35:25 INFO - Running post-action listener: _resource_record_post_action 00:35:25 INFO - [mozharness: 2017-05-18 07:35:25.394750Z] Finished clobber step (success) 00:35:25 INFO - [mozharness: 2017-05-18 07:35:25.394849Z] Running read-buildbot-config step. 00:35:25 INFO - Running pre-action listener: _resource_record_pre_action 00:35:25 INFO - Running main action method: read_buildbot_config 00:35:25 INFO - Using buildbot properties: 00:35:25 INFO - { 00:35:25 INFO - "project": "", 00:35:25 INFO - "product": "firefox", 00:35:25 INFO - "who": "cbook@mozilla.com", 00:35:25 INFO - "installer_path": "public/build/target.tar.bz2", 00:35:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 00:35:25 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 00:35:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 00:35:25 INFO - "stage_platform": "linux64", 00:35:25 INFO - "basedir": "/builds/slave/test", 00:35:25 INFO - "buildnumber": 48, 00:35:25 INFO - "platform": "ubuntu64_hw", 00:35:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:35:25 INFO - "slavebuilddir": "test", 00:35:25 INFO - "taskId": "FyVdUTyyQQC3mOh_lEKFSw", 00:35:25 INFO - "branch": "mozilla-beta", 00:35:25 INFO - "script_repo_revision": "production", 00:35:25 INFO - "revision": "0884adb687d1b4cf95820feae19939d931053ae7", 00:35:25 INFO - "slavename": "talos-linux64-ix-074", 00:35:25 INFO - "repo_path": "releases/mozilla-beta" 00:35:25 INFO - } 00:35:25 INFO - Finding installer, test and symbols from parent task. 00:35:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FyVdUTyyQQC3mOh_lEKFSw'}, attempt #1 00:35:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FyVdUTyyQQC3mOh_lEKFSw'}, attempt #1 00:35:26 INFO - Task dependencies: QiFU9kPdTdWm8pwFhUBZmA 00:35:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA'}, attempt #1 00:35:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 00:35:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/test_packages.json 00:35:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.crashreporter-symbols.zip 00:35:26 INFO - Running post-action listener: _resource_record_post_action 00:35:26 INFO - [mozharness: 2017-05-18 07:35:26.806381Z] Finished read-buildbot-config step (success) 00:35:26 INFO - [mozharness: 2017-05-18 07:35:26.806633Z] Running download-and-extract step. 00:35:26 INFO - Running pre-action listener: _resource_record_pre_action 00:35:26 INFO - Running main action method: download_and_extract 00:35:26 INFO - mkdir: /builds/slave/test/build/tests 00:35: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')]} 00:35:26 INFO - trying https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.test_packages.json 00:35:26 INFO - Downloading https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:35:27 INFO - Downloaded 986 bytes. 00:35:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:35:27 INFO - Using the following test package requirements: 00:35:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:35:27 INFO - u'common': [u'target.common.tests.zip'], 00:35:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:35:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:35:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:35:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:35:27 INFO - u'mozbase': [u'target.common.tests.zip'], 00:35:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:35:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:35:27 INFO - u'web-platform': [u'target.common.tests.zip', 00:35:27 INFO - u'target.web-platform.tests.zip'], 00:35:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:35:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:35:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip 00:35:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:35:27 INFO - Fetch https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip into memory 00:35:30 INFO - Expected file size: 59544730 00:35:30 INFO - Obtained file size: 59544730 00:35:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:35:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip 00:35:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:35:40 INFO - Fetch https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.common.tests.zip into memory 00:35:42 INFO - Expected file size: 59544730 00:35:42 INFO - Obtained file size: 59544730 00:35:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.talos.tests.zip 00:35:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:35:52 INFO - Fetch https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.talos.tests.zip into memory 00:35:53 INFO - Expected file size: 14404449 00:35:53 INFO - Obtained file size: 14404449 00:35:54 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')]} 00:35:54 INFO - trying https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 00:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:35:57 INFO - Downloaded 59759251 bytes. 00:35:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 00:35:57 INFO - mkdir: /builds/slave/test/properties 00:35:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:35:57 INFO - Writing to file /builds/slave/test/properties/build_url 00:35:57 INFO - Contents: 00:35:57 INFO - build_url:https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 00:35:57 INFO - Running post-action listener: _resource_record_post_action 00:35:57 INFO - Running post-action listener: set_extra_try_arguments 00:35:57 INFO - [mozharness: 2017-05-18 07:35:57.314561Z] Finished download-and-extract step (success) 00:35:57 INFO - [mozharness: 2017-05-18 07:35:57.314865Z] Running populate-webroot step. 00:35:57 INFO - Running pre-action listener: _resource_record_pre_action 00:35:57 INFO - Running main action method: populate_webroot 00:35:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:35:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:35:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:35:57 INFO - '--tppagecycles', 00:35:57 INFO - '7'], 00:35:57 INFO - 'tests': ['tsvgm']}}, 00:35:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:35:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:35:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:35:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:35:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:35:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:35:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['damp', 'tps']}, 00:35:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'tests': ['damp', 'tps']}, 00:35:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['dromaeo_dom']}, 00:35:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:35:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['basic_compositor_video']}, 00:35:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:35:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['a11yr', 00:35:57 INFO - 'ts_paint', 00:35:57 INFO - 'tpaint', 00:35:57 INFO - 'sessionrestore', 00:35:57 INFO - 'sessionrestore_no_auto_restore', 00:35:57 INFO - 'tabpaint']}, 00:35:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['tsvgx', 00:35:57 INFO - 'tsvgr_opacity', 00:35:57 INFO - 'tart', 00:35:57 INFO - 'tscrollx', 00:35:57 INFO - 'cart', 00:35:57 INFO - 'tsvg_static']}, 00:35:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:35:57 INFO - 'tsvgr_opacity', 00:35:57 INFO - 'tart', 00:35:57 INFO - 'tscrollx', 00:35:57 INFO - 'cart', 00:35:57 INFO - 'tsvg_static']}, 00:35:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'talos_options': ['--disable-e10s'], 00:35:57 INFO - 'tests': ['tp5o']}, 00:35:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:35:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'talos_options': ['--disable-e10s', 00:35:57 INFO - '--xperf_path', 00:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:35:57 INFO - 'tests': ['tp5n']}, 00:35:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:35:57 INFO - 'talos_options': ['--xperf_path', 00:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:35:57 INFO - 'tests': ['tp5n']}}, 00:35:57 INFO - 'talos.zip': {'path': '', 00:35:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:35:57 INFO - Running post-action listener: _resource_record_post_action 00:35:57 INFO - [mozharness: 2017-05-18 07:35:57.333370Z] Finished populate-webroot step (success) 00:35:57 INFO - [mozharness: 2017-05-18 07:35:57.333460Z] Running create-virtualenv step. 00:35:57 INFO - Running pre-action listener: _resource_record_pre_action 00:35:57 INFO - Running main action method: create_virtualenv 00:35:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:35:57 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 00:35:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:35:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:35:57 INFO - Using real prefix '/usr' 00:35:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:35:59 INFO - Installing pip.................done. 00:35:59 INFO - Return code: 0 00:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:36:00 INFO - Reading from file tmpfile_stdout 00:36:00 INFO - Output received: 00:36:00 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) 00:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36: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')]} 00:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:00 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:00 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 00:36:00 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 00:36:00 INFO - Using env: {'DISPLAY': ':0', 00:36:00 INFO - 'HOME': '/home/cltbld', 00:36:00 INFO - 'LANG': 'en_US.UTF-8', 00:36:00 INFO - 'LANGUAGE': 'en_US:en', 00:36:00 INFO - 'LOGNAME': 'cltbld', 00:36:00 INFO - 'MAIL': '/var/mail/cltbld', 00:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:00 INFO - 'MOZ_NO_REMOTE': '1', 00:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:00 INFO - 'NO_EM_RESTART': '1', 00:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:00 INFO - 'PWD': '/builds/slave/test', 00:36:00 INFO - 'SHELL': '/bin/bash', 00:36:00 INFO - 'SHLVL': '1', 00:36:00 INFO - 'TERM': 'linux', 00:36:00 INFO - 'TMOUT': '86400', 00:36:00 INFO - 'USER': 'cltbld', 00:36:00 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:00 INFO - '_': '/tools/buildbot/bin/python'} 00:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:00 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 00:36:00 INFO - Cleaning up... 00:36:00 INFO - Return code: 0 00:36:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36: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')]} 00:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:00 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:00 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 00:36:00 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 00:36:00 INFO - Using env: {'DISPLAY': ':0', 00:36:00 INFO - 'HOME': '/home/cltbld', 00:36:00 INFO - 'LANG': 'en_US.UTF-8', 00:36:00 INFO - 'LANGUAGE': 'en_US:en', 00:36:00 INFO - 'LOGNAME': 'cltbld', 00:36:00 INFO - 'MAIL': '/var/mail/cltbld', 00:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:00 INFO - 'MOZ_NO_REMOTE': '1', 00:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:00 INFO - 'NO_EM_RESTART': '1', 00:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:00 INFO - 'PWD': '/builds/slave/test', 00:36:00 INFO - 'SHELL': '/bin/bash', 00:36:00 INFO - 'SHLVL': '1', 00:36:00 INFO - 'TERM': 'linux', 00:36:00 INFO - 'TMOUT': '86400', 00:36:00 INFO - 'USER': 'cltbld', 00:36:00 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:00 INFO - '_': '/tools/buildbot/bin/python'} 00:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:00 INFO - Downloading/unpacking psutil>=3.1.1 00:36:00 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 00:36:00 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 00:36:00 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 00:36:00 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 00:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:36:01 INFO - Installing collected packages: psutil 00:36:01 INFO - Running setup.py install for psutil 00:36:01 INFO - building 'psutil._psutil_linux' extension 00:36:01 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 00:36:01 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 00:36:02 INFO - building 'psutil._psutil_posix' extension 00:36:02 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 00:36:02 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 00:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:36:02 INFO - Successfully installed psutil 00:36:02 INFO - Cleaning up... 00:36:02 INFO - Return code: 0 00:36:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36: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')]} 00:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:02 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:02 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 00:36:02 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 00:36:02 INFO - Using env: {'DISPLAY': ':0', 00:36:02 INFO - 'HOME': '/home/cltbld', 00:36:02 INFO - 'LANG': 'en_US.UTF-8', 00:36:02 INFO - 'LANGUAGE': 'en_US:en', 00:36:02 INFO - 'LOGNAME': 'cltbld', 00:36:02 INFO - 'MAIL': '/var/mail/cltbld', 00:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:02 INFO - 'MOZ_NO_REMOTE': '1', 00:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:02 INFO - 'NO_EM_RESTART': '1', 00:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:02 INFO - 'PWD': '/builds/slave/test', 00:36:02 INFO - 'SHELL': '/bin/bash', 00:36:02 INFO - 'SHLVL': '1', 00:36:02 INFO - 'TERM': 'linux', 00:36:02 INFO - 'TMOUT': '86400', 00:36:02 INFO - 'USER': 'cltbld', 00:36:02 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:02 INFO - '_': '/tools/buildbot/bin/python'} 00:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:36:02 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 00:36:02 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 00:36:02 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 00:36:02 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 00:36:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:36:03 INFO - Installing collected packages: mozsystemmonitor 00:36:03 INFO - Running setup.py install for mozsystemmonitor 00:36:03 INFO - Successfully installed mozsystemmonitor 00:36:03 INFO - Cleaning up... 00:36:03 INFO - Return code: 0 00:36:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:36:03 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')]} 00:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:03 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')]} 00:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:03 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:03 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 00:36:03 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 00:36:03 INFO - Using env: {'DISPLAY': ':0', 00:36:03 INFO - 'HOME': '/home/cltbld', 00:36:03 INFO - 'LANG': 'en_US.UTF-8', 00:36:03 INFO - 'LANGUAGE': 'en_US:en', 00:36:03 INFO - 'LOGNAME': 'cltbld', 00:36:03 INFO - 'MAIL': '/var/mail/cltbld', 00:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:03 INFO - 'MOZ_NO_REMOTE': '1', 00:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:03 INFO - 'NO_EM_RESTART': '1', 00:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:03 INFO - 'PWD': '/builds/slave/test', 00:36:03 INFO - 'SHELL': '/bin/bash', 00:36:03 INFO - 'SHLVL': '1', 00:36:03 INFO - 'TERM': 'linux', 00:36:03 INFO - 'TMOUT': '86400', 00:36:03 INFO - 'USER': 'cltbld', 00:36:03 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:03 INFO - '_': '/tools/buildbot/bin/python'} 00:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:04 INFO - Downloading/unpacking jsonschema==2.5.1 00:36:04 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 00:36:04 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 00:36:04 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 00:36:04 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 00:36:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:36:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 INFO - Downloading functools32-3.2.3-2.tar.gz 00:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:36:05 INFO - warning: no files found matching '*.txt' 00:36:05 INFO - no previously-included directories found matching 'build' 00:36:05 INFO - no previously-included directories found matching 'dist' 00:36:05 INFO - no previously-included directories found matching '.git*' 00:36:05 INFO - Installing collected packages: jsonschema, functools32 00:36:05 INFO - Running setup.py install for functools32 00:36:05 INFO - warning: no files found matching '*.txt' 00:36:05 INFO - no previously-included directories found matching 'build' 00:36:05 INFO - no previously-included directories found matching 'dist' 00:36:05 INFO - no previously-included directories found matching '.git*' 00:36:05 INFO - Successfully installed jsonschema functools32 00:36:05 INFO - Cleaning up... 00:36:05 INFO - Return code: 0 00:36:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:36:05 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')]} 00:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:05 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')]} 00:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:05 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:05 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 00:36:05 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 00:36:05 INFO - Using env: {'DISPLAY': ':0', 00:36:05 INFO - 'HOME': '/home/cltbld', 00:36:05 INFO - 'LANG': 'en_US.UTF-8', 00:36:05 INFO - 'LANGUAGE': 'en_US:en', 00:36:05 INFO - 'LOGNAME': 'cltbld', 00:36:05 INFO - 'MAIL': '/var/mail/cltbld', 00:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:05 INFO - 'MOZ_NO_REMOTE': '1', 00:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:05 INFO - 'NO_EM_RESTART': '1', 00:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:05 INFO - 'PWD': '/builds/slave/test', 00:36:05 INFO - 'SHELL': '/bin/bash', 00:36:05 INFO - 'SHLVL': '1', 00:36:05 INFO - 'TERM': 'linux', 00:36:05 INFO - 'TMOUT': '86400', 00:36:05 INFO - 'USER': 'cltbld', 00:36:05 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:05 INFO - '_': '/tools/buildbot/bin/python'} 00:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:36:05 INFO - Cleaning up... 00:36:05 INFO - Return code: 0 00:36:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:36:05 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')]} 00:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:05 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')]} 00:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:05 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:05 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 00:36:05 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 00:36:05 INFO - Using env: {'DISPLAY': ':0', 00:36:05 INFO - 'HOME': '/home/cltbld', 00:36:05 INFO - 'LANG': 'en_US.UTF-8', 00:36:05 INFO - 'LANGUAGE': 'en_US:en', 00:36:05 INFO - 'LOGNAME': 'cltbld', 00:36:05 INFO - 'MAIL': '/var/mail/cltbld', 00:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:05 INFO - 'MOZ_NO_REMOTE': '1', 00:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:05 INFO - 'NO_EM_RESTART': '1', 00:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:05 INFO - 'PWD': '/builds/slave/test', 00:36:05 INFO - 'SHELL': '/bin/bash', 00:36:05 INFO - 'SHLVL': '1', 00:36:05 INFO - 'TERM': 'linux', 00:36:05 INFO - 'TMOUT': '86400', 00:36:05 INFO - 'USER': 'cltbld', 00:36:05 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:05 INFO - '_': '/tools/buildbot/bin/python'} 00:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:05 INFO - Downloading/unpacking blobuploader==1.2.4 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 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 00:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 00:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:36:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:36:07 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 00:36:07 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 00:36:07 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 00:36:07 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 00:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:36:07 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 00:36:07 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 00:36:07 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 00:36:07 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 00:36:07 INFO - Downloading docopt-0.6.1.tar.gz 00:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 00:36:07 INFO - Running setup.py install for blobuploader 00:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:36:07 INFO - Running setup.py install for requests 00:36:08 INFO - Running setup.py install for docopt 00:36:08 INFO - Successfully installed blobuploader requests docopt 00:36:08 INFO - Cleaning up... 00:36:08 INFO - Return code: 0 00:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36:08 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')]} 00:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:08 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')]} 00:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:08 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:08 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 00:36:08 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 00:36:08 INFO - Using env: {'DISPLAY': ':0', 00:36:08 INFO - 'HOME': '/home/cltbld', 00:36:08 INFO - 'LANG': 'en_US.UTF-8', 00:36:08 INFO - 'LANGUAGE': 'en_US:en', 00:36:08 INFO - 'LOGNAME': 'cltbld', 00:36:08 INFO - 'MAIL': '/var/mail/cltbld', 00:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:08 INFO - 'MOZ_NO_REMOTE': '1', 00:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:08 INFO - 'NO_EM_RESTART': '1', 00:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:08 INFO - 'PWD': '/builds/slave/test', 00:36:08 INFO - 'SHELL': '/bin/bash', 00:36:08 INFO - 'SHLVL': '1', 00:36:08 INFO - 'TERM': 'linux', 00:36:08 INFO - 'TMOUT': '86400', 00:36:08 INFO - 'USER': 'cltbld', 00:36:08 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:08 INFO - '_': '/tools/buildbot/bin/python'} 00:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:36:08 INFO - Running setup.py (path:/tmp/pip-1OslSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:36:08 INFO - Running setup.py (path:/tmp/pip-tvzcH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:36:08 INFO - Running setup.py (path:/tmp/pip-3s7ynW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:36:08 INFO - Running setup.py (path:/tmp/pip-htjgSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:36:08 INFO - Running setup.py (path:/tmp/pip-K1CKwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:36:08 INFO - Running setup.py (path:/tmp/pip-DywOgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:36:08 INFO - Running setup.py (path:/tmp/pip-VBoO26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:36:08 INFO - Running setup.py (path:/tmp/pip-mTl1wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:36:08 INFO - Running setup.py (path:/tmp/pip-ntCiFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:36:09 INFO - Running setup.py (path:/tmp/pip-SEMXZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:36:09 INFO - Running setup.py (path:/tmp/pip-TJ2rte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:36:09 INFO - Running setup.py (path:/tmp/pip-GOIXwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:36:09 INFO - Running setup.py (path:/tmp/pip-PekOW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:36:09 INFO - Running setup.py (path:/tmp/pip-sG5E44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:09 INFO - Running setup.py (path:/tmp/pip-3Mbsu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:36:09 INFO - Running setup.py (path:/tmp/pip-yrk1gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:36:09 INFO - Running setup.py (path:/tmp/pip-1BajDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:36:09 INFO - Running setup.py install for manifestparser 00:36:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:36:09 INFO - Running setup.py install for mozcrash 00:36:09 INFO - Running setup.py install for mozdebug 00:36:09 INFO - Running setup.py install for mozdevice 00:36:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozfile 00:36:10 INFO - Running setup.py install for mozhttpd 00:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozinfo 00:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozInstall 00:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozleak 00:36:10 INFO - Running setup.py install for mozlog 00:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for moznetwork 00:36:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozprocess 00:36:10 INFO - Running setup.py install for mozprofile 00:36:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:36:10 INFO - Running setup.py install for mozrunner 00:36:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:36:11 INFO - Running setup.py install for mozscreenshot 00:36:11 INFO - Running setup.py install for moztest 00:36:11 INFO - Running setup.py install for mozversion 00:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:36:11 INFO - Cleaning up... 00:36:11 INFO - Return code: 0 00:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36:11 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')]} 00:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:11 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')]} 00:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:11 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:11 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 00:36:11 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 00:36:11 INFO - Using env: {'DISPLAY': ':0', 00:36:11 INFO - 'HOME': '/home/cltbld', 00:36:11 INFO - 'LANG': 'en_US.UTF-8', 00:36:11 INFO - 'LANGUAGE': 'en_US:en', 00:36:11 INFO - 'LOGNAME': 'cltbld', 00:36:11 INFO - 'MAIL': '/var/mail/cltbld', 00:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:11 INFO - 'MOZ_NO_REMOTE': '1', 00:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:11 INFO - 'NO_EM_RESTART': '1', 00:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:11 INFO - 'PWD': '/builds/slave/test', 00:36:11 INFO - 'SHELL': '/bin/bash', 00:36:11 INFO - 'SHLVL': '1', 00:36:11 INFO - 'TERM': 'linux', 00:36:11 INFO - 'TMOUT': '86400', 00:36:11 INFO - 'USER': 'cltbld', 00:36:11 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:11 INFO - '_': '/tools/buildbot/bin/python'} 00:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:36:11 INFO - Running setup.py (path:/tmp/pip-yPlO1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:36:11 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)) 00:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:36:11 INFO - Running setup.py (path:/tmp/pip-tcPBFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:36:11 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)) 00:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:36:11 INFO - Running setup.py (path:/tmp/pip-dRGXCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:36:11 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)) 00:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:36:11 INFO - Running setup.py (path:/tmp/pip-FrsycV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:36:11 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)) 00:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:36:11 INFO - Running setup.py (path:/tmp/pip-46ic_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:36:12 INFO - Running setup.py (path:/tmp/pip-IvuTjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:36:12 INFO - Running setup.py (path:/tmp/pip-Jq0I5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:36:12 INFO - Running setup.py (path:/tmp/pip-X1Hycm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:36:12 INFO - Running setup.py (path:/tmp/pip-PWcsB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:36:12 INFO - Running setup.py (path:/tmp/pip-cJAv79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:36:12 INFO - Running setup.py (path:/tmp/pip-l8dj9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:36:12 INFO - Running setup.py (path:/tmp/pip-uq_ouL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:36:12 INFO - Running setup.py (path:/tmp/pip-hqYjDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:36:12 INFO - Running setup.py (path:/tmp/pip-MnILKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:12 INFO - Running setup.py (path:/tmp/pip-aEoYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:36:12 INFO - Running setup.py (path:/tmp/pip-ycaALb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:36:12 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)) 00:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:36:12 INFO - Running setup.py (path:/tmp/pip-GNOJf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:36:12 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)) 00:36:12 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)) 00:36:12 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)) 00:36:12 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)) 00:36:12 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)) 00:36:12 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)) 00:36:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:36:12 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 00:36:12 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 00:36:12 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 00:36:12 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 00:36:13 INFO - Downloading blessings-1.6.tar.gz 00:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:36:14 INFO - Installing collected packages: blessings 00:36:14 INFO - Running setup.py install for blessings 00:36:14 INFO - Successfully installed blessings 00:36:14 INFO - Cleaning up... 00:36:14 INFO - Return code: 0 00:36:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:36:14 INFO - Reading from file tmpfile_stdout 00:36:14 INFO - Current package versions: 00:36:14 INFO - argparse == 1.2.1 00:36:14 INFO - blessings == 1.6 00:36:14 INFO - blobuploader == 1.2.4 00:36:14 INFO - docopt == 0.6.1 00:36:14 INFO - functools32 == 3.2.3-2 00:36:14 INFO - jsonschema == 2.5.1 00:36:14 INFO - manifestparser == 1.1 00:36:14 INFO - mozInstall == 1.12 00:36:14 INFO - mozcrash == 1.0 00:36:14 INFO - mozdebug == 0.1 00:36:14 INFO - mozdevice == 0.49 00:36:14 INFO - mozfile == 1.2 00:36:14 INFO - mozhttpd == 0.7 00:36:14 INFO - mozinfo == 0.9 00:36:14 INFO - mozleak == 0.1 00:36:14 INFO - mozlog == 3.4 00:36:14 INFO - moznetwork == 0.27 00:36:14 INFO - mozprocess == 0.25 00:36:14 INFO - mozprofile == 0.28 00:36:14 INFO - mozrunner == 6.13 00:36:14 INFO - mozscreenshot == 0.1 00:36:14 INFO - mozsystemmonitor == 0.3 00:36:14 INFO - moztest == 0.8 00:36:14 INFO - mozversion == 1.4 00:36:14 INFO - psutil == 3.1.1 00:36:14 INFO - requests == 1.2.3 00:36:14 INFO - wsgiref == 0.1.2 00:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:14 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:14 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 00:36:14 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 00:36:14 INFO - Using env: {'DISPLAY': ':0', 00:36:14 INFO - 'HOME': '/home/cltbld', 00:36:14 INFO - 'LANG': 'en_US.UTF-8', 00:36:14 INFO - 'LANGUAGE': 'en_US:en', 00:36:14 INFO - 'LOGNAME': 'cltbld', 00:36:14 INFO - 'MAIL': '/var/mail/cltbld', 00:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:14 INFO - 'MOZ_NO_REMOTE': '1', 00:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:14 INFO - 'NO_EM_RESTART': '1', 00:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:14 INFO - 'PWD': '/builds/slave/test', 00:36:14 INFO - 'SHELL': '/bin/bash', 00:36:14 INFO - 'SHLVL': '1', 00:36:14 INFO - 'TERM': 'linux', 00:36:14 INFO - 'TMOUT': '86400', 00:36:14 INFO - 'USER': 'cltbld', 00:36:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:14 INFO - '_': '/tools/buildbot/bin/python'} 00:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 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)) 00:36:14 INFO - Cleaning up... 00:36:14 INFO - Return code: 0 00:36:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:14 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 0x14c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1760310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', '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 00:36:14 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 00:36:14 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 00:36:14 INFO - Using env: {'DISPLAY': ':0', 00:36:14 INFO - 'HOME': '/home/cltbld', 00:36:14 INFO - 'LANG': 'en_US.UTF-8', 00:36:14 INFO - 'LANGUAGE': 'en_US:en', 00:36:14 INFO - 'LOGNAME': 'cltbld', 00:36:14 INFO - 'MAIL': '/var/mail/cltbld', 00:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:14 INFO - 'MOZ_NO_REMOTE': '1', 00:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:14 INFO - 'NO_EM_RESTART': '1', 00:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:14 INFO - 'PWD': '/builds/slave/test', 00:36:14 INFO - 'SHELL': '/bin/bash', 00:36:14 INFO - 'SHLVL': '1', 00:36:14 INFO - 'TERM': 'linux', 00:36:14 INFO - 'TMOUT': '86400', 00:36:14 INFO - 'USER': 'cltbld', 00:36:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:14 INFO - '_': '/tools/buildbot/bin/python'} 00:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:36:14 INFO - Cleaning up... 00:36:14 INFO - Return code: 0 00:36:14 INFO - Running post-action listener: _resource_record_post_action 00:36:14 INFO - Running post-action listener: _start_resource_monitoring 00:36:14 INFO - Starting resource monitoring. 00:36:14 INFO - [mozharness: 2017-05-18 07:36:14.919814Z] Finished create-virtualenv step (success) 00:36:14 INFO - [mozharness: 2017-05-18 07:36:14.920324Z] Running install step. 00:36:14 INFO - Running pre-action listener: _resource_record_pre_action 00:36:14 INFO - Running main action method: install 00:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:36:15 INFO - Reading from file tmpfile_stdout 00:36:15 INFO - Detecting whether we're running mozinstall >=1.0... 00:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:36:15 INFO - Reading from file tmpfile_stdout 00:36:15 INFO - Output received: 00:36:15 INFO - Usage: mozinstall [options] installer 00:36:15 INFO - Options: 00:36:15 INFO - -h, --help show this help message and exit 00:36:15 INFO - -d DEST, --destination=DEST 00:36:15 INFO - Directory to install application into. [default: 00:36:15 INFO - "/builds/slave/test"] 00:36:15 INFO - --app=APP Application being installed. [default: firefox] 00:36:15 INFO - mkdir: /builds/slave/test/build/application 00:36:15 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'] 00:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:36:29 INFO - Reading from file tmpfile_stdout 00:36:29 INFO - Output received: 00:36:29 INFO - /builds/slave/test/build/application/firefox/firefox 00:36:29 INFO - Running post-action listener: _resource_record_post_action 00:36:29 INFO - [mozharness: 2017-05-18 07:36:29.292519Z] Finished install step (success) 00:36:29 INFO - [mozharness: 2017-05-18 07:36:29.292761Z] Running run-tests step. 00:36:29 INFO - Running pre-action listener: _resource_record_pre_action 00:36:29 INFO - Running main action method: run_tests 00:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:36:29 INFO - Python 2.7.3 00:36:29 INFO - Return code: 0 00:36:29 INFO - grabbing minidump binary from tooltool 00:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:29 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 0x175d400>, '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 0x175e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:36:29 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 00:36:29 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 00:36:29 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 00:36:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:36:29 INFO - Return code: 0 00:36:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:36:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:36:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:36:29 INFO - ENV: RUST_BACKTRACE is now 1 00:36:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:36:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:36:29 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/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 00:36:29 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/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 00:36:29 INFO - Using env: {'DISPLAY': ':0', 00:36:29 INFO - 'HOME': '/home/cltbld', 00:36:29 INFO - 'LANG': 'en_US.UTF-8', 00:36:29 INFO - 'LANGUAGE': 'en_US:en', 00:36:29 INFO - 'LOGNAME': 'cltbld', 00:36:29 INFO - 'MAIL': '/var/mail/cltbld', 00:36:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:36:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:29 INFO - 'MOZ_NO_REMOTE': '1', 00:36:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:29 INFO - 'NO_EM_RESTART': '1', 00:36:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:29 INFO - 'PWD': '/builds/slave/test', 00:36:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:36:29 INFO - 'RUST_BACKTRACE': '1', 00:36:29 INFO - 'SHELL': '/bin/bash', 00:36:29 INFO - 'SHLVL': '1', 00:36:29 INFO - 'TERM': 'linux', 00:36:29 INFO - 'TMOUT': '86400', 00:36:29 INFO - 'USER': 'cltbld', 00:36:29 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491', 00:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:29 INFO - '_': '/tools/buildbot/bin/python'} 00:36:29 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/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 00:36:29 INFO - mozversion application_buildid: 20170518064508 00:36:29 INFO - mozversion application_changeset: 0884adb687d1b4cf95820feae19939d931053ae7 00:36:29 INFO - mozversion application_display_name: Firefox 00:36:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:36:29 INFO - mozversion application_name: Firefox 00:36:29 INFO - mozversion application_remotingname: firefox 00:36:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:36:29 INFO - mozversion application_vendor: Mozilla 00:36:29 INFO - mozversion application_version: 54.0 00:36:29 INFO - mozversion platform_buildid: 20170518064508 00:36:29 INFO - mozversion platform_changeset: 0884adb687d1b4cf95820feae19939d931053ae7 00:36:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:36:29 INFO - mozversion platform_version: 54.0 00:36:29 INFO - using testdate: 1495092989 00:36:29 INFO - actual date: 1495092989 00:36:29 INFO - starting webserver on 'localhost:55693' 00:36:29 INFO - SUITE-START | Running 2 tests 00:36:29 INFO - TEST-START | dromaeo_css 00:36:29 INFO - operating with platform_type : linux_ 00:36:29 INFO - Initialising browser for dromaeo_css test... 00:36:29 INFO - TEST-INFO | started process 26619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGvl95X/profile http://localhost:55693/getInfo.html) 00:36:33 INFO - PROCESS | 26619 | __metrics Screen width/height:1600/1200 00:36:33 INFO - PROCESS | 26619 | colorDepth:24 00:36:33 INFO - PROCESS | 26619 | Browser inner width/height: 1024/697 00:36:33 INFO - PROCESS | 26619 | __metrics 00:36:34 INFO - PROCESS | 26619 | 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" 00:36:34 INFO - PROCESS | 26619 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:36:34 INFO - PROCESS | 26619 | console.error: PushService: 00:36:34 INFO - PROCESS | 26619 | stateChangeProcessEnqueue: Error transitioning state 00:36:34 INFO - PROCESS | 26619 | UnknownError 00:36:35 INFO - TEST-INFO | 26619: exit 0 00:36:35 INFO - Browser initialized. 00:36:35 INFO - Running cycle 1/1 for dromaeo_css test... 00:36:35 INFO - TEST-INFO | started process 26713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGvl95X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:36:47 INFO - PROCESS | 26713 | RSS: Main: 141729792 00:36:47 INFO - PROCESS | 26713 | 00:39:48 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55693/tests/dromaeo/cssquery-ext.html) 00:39:49 INFO - PROCESS | 26713 | RSS: Main: 247513088 00:39:49 INFO - PROCESS | 26713 | 00:42:52 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-ext.html (next: http://localhost:55693/tests/dromaeo/cssquery-jquery.html) 00:42:52 INFO - PROCESS | 26713 | RSS: Main: 217444352 00:42:52 INFO - PROCESS | 26713 | 00:45:54 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55693/tests/dromaeo/cssquery-mootools.html) 00:45:55 INFO - PROCESS | 26713 | RSS: Main: 215363584 00:45:55 INFO - PROCESS | 26713 | 00:48:57 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55693/tests/dromaeo/cssquery-prototype.html) 00:48:57 INFO - PROCESS | 26713 | RSS: Main: 213061632 00:48:57 INFO - PROCESS | 26713 | 00:52:00 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55693/tests/dromaeo/cssquery-yui.html) 00:52:01 INFO - PROCESS | 26713 | RSS: Main: 173793280 00:52:01 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | Cycle 1(1): loaded http://localhost:55693/tests/dromaeo/cssquery-yui.html (next: http://localhost:55693/tests/dromaeo/cssquery-dojo.html) 00:55:03 INFO - PROCESS | 26713 | RSS: Main: 266547200 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | __start_tp_report 00:55:03 INFO - PROCESS | 26713 | _x_x_mozilla_page_load 00:55:03 INFO - PROCESS | 26713 | _x_x_mozilla_page_load_details 00:55:03 INFO - PROCESS | 26713 | |i|pagename|runs| 00:55:03 INFO - PROCESS | 26713 | |0;dojo.html;3352.3127758809446;3366.2257680733433;3393.406153923061;3416.6241713411505;3430.879919202828;5685.204071430003;5771.855703607412;5776.133579963008;5783.971080144599;5793.913091303629;5806.738696758645;5848.093545500444;5872.500837428813;5874.8544033913295;5881.235439392884;5213.3743950725875;5247.868803279929;5261.421243663194;5264.263003179558;5318.547923426513;5121.334226550562;5159.587233021368;5335.813246536372;5350.30446042014;5353.063213937565;5209.895802083956;5229.790808367661;5232.2674825524455;5253.527182553569;5255.500727430888;5308.761105750251;5317.441668624816;5318.149096144637;5319.175527793179;5320.334958130234;5094.516020978038;5175.249588809602;5238.973805130988;5291.232771248186;5302.575793936476;5718.714064296769;5762.481376676119;5800.274965629296;5804.361520232771;5818.8254352369495;6199.058661462523;6269.279032911228;6281.623102613812;6289.496840252768;6289.748410063592;6325.14610527582;6326.114343991845;6335.651539165344;6337.87324253517;6346.841328966767;5725.513331366838;5756.222909907151;5760.539156867399;5780.393058728857;5783.421657834267;6334.1765570475545;6334.9683251584365;6338.176037115146;6339;6339.492840572743;6028.577999540078;6086.117512960596;6088.573799834057;6093.11649810775;6097.725602347905;6034.818955431344;6102.877942441126;6107.816765497042;6140.385961403824;6205.844853878599;6144.064619644798;6162.075688646739;6168.321484636686;6170.568060235741;6182.010878259457;6069.787557435468;6109.5112391008615;6109.816705498843;6112.083187521907;6172.351903050205;4608.423947006624;4692.0381321828945;4699.130660827758;4702.95297047032;4703.74129422885;4213.199492096492;4221.894452638647;4228.492580890313;4231.746095234295;4233.851815186454;6050.45545900871;6050.48570871472;6052.031674932078;6053.667048312385;6087.208662873798;6123.724432400552;6153.938460615336;6266.592671476339;6297.779577714758;6304.621722696653;5956.702164891738;5979.760809567569;6036.909446358308;6078.817635470943;6096.786612468542;5319.228711836762;5321.600879934021;5324.148136298174;5326.733663316896;5330.067238233293;6309.936900630935;6371.585846920028;6379.5215358847345;6427.678616069178;6457.321981192095;6164.845878853064;6182.1345011699295;6194.349593292639;6196.845078872884;6220.595661282002;6522.543421960418;6526.24948130971;6534.771283005072;6535.934640653532;6541.08424820516;5997.190379298739;6159.045347971071;6174.475169610454;6176.166217560572;6181.227346581677;6113.932424433873;6198;6238.282597501164;6247.281562620356;6252.624842509464;6132.41742034506;6167.105769663284;6170.475509581556;6183.165272688309;6184.567080304336;6149.754009839735;6160;6163.938360616516;6178.351273116258;6181.103739957771;5905.586608937333;6009.308929473166;6056.606320589148;6089.573729839046;6091.664958427152;6196.752129914753;6205.47253483459;6206.627602343874;6214.658193799384;6215.627062376272;5836.474717275466;6014.9097763534455;6040.395960403925;6046.28203018645;6069.150318955261 00:55:03 INFO - PROCESS | 26713 | |1;ext.html;787.094840932927;841.8021764885253;865.0225245472615;907.1925985872571;925.4308600210873;32198.678013219862;43735;44396.3340549892;49198;49450;45983.77008114963;46072.308915366295;46080.53919460804;46130.769346153225;46181.76909115458;7672.923270767276;7882.211778822129;9231.261499080074;9368.110029547182;9372.765680857965;10661.893381066206;10970.890291097066;10977.627796525434;10980.505877235544;10987.066099381522;11096.389698566576;11134.888651113506;11143.609973650924;11164.218504704673;11175.050120739746;11040.282381645247;11056.723581910435;11103.666889993314;11104;11109.222354435153;10795.6221532246;10860.294080884718;10866.185036122322;10880;10881.347119172795;44483.77758111221;44563.554364456264;44576.777116114536;44613.33080003803;44632.77683611594;4240.681948853818;4311.137772445523;4358.302671572533;4422.778861056967;4455;30794.53808192879;30935.845320773253;31329.530057049164;31408.37183256345;33188.50217246743;4443.644508439349;4470.083632855257;4509.249487245875;4540.387047748544;4578.816847326103;252242;253319;253395;253643;254428.99999999814;54714.72642636841;54896.725516372964;55608.443915560325;55634.72182639061;55740.442595574335;57467.425325746204;57577.424225757204;57631.13553296704;57677.711611442515;58327;17129.914350428167;17490.47528574145;17491.38780142689;17505.212265448085;17513.649727005642;13440.126391784503;13664;15259.771103433457;15459.458918937784;15495.535133946;14366;14369.06601070927;14416.279186040656;14486.565403037926;14508.274586270643;5459.12653975362;5500.889982200333;5526.778928842801;5528.253685752452;5597.776088956478;1021.667957913681;1030.1912998296302;1035.844623306495;1039.9220058495644;1040.8178568750438;28591.42817143687;28935.56596651052;29138.417231655672;29381.559276610868;29430.558541621464;1101.8292164714483;1103.6892201721053;1106.1869525898458;1121.2599684208383;1125;15600.921995390177;15709.293081811345;15734.449294274646;15800.68398632021;15853.128077955824;310882;311079;311623;311669;312080;57942.13086803701;58066.709666451396;58100;58126.709366453746;58218;1466.4354223623982;1484.3617244584716;1519.574519134644;1523.0480949406622;1528.2740698168282;28866;29758;30110.247243819078;30160.54759178658;30692.53961190539;40159.59840401559;40256;40319.79840100781;40370.39444408395;40378.1924361517;311716;312694;313492;313604;314067;25860.094896678525;26519;29659.406811864075;30131.849340753157;31609;39071.218575628896;39141.804290979504;39227.803860980515;39274;39815.80092099521;28944.855275723487;29197;30216.244593885327;30407.39185216239;30542;28342.85828570844;28723.425531488836;28753.281167970967;29087.41825163527;29497.705022949496;34599.65400345964;34883.12792180216;34931;34940.12649683778;35384.292314153055;28901.7109828899;29104.27239319034;29230.269243268238;29649.110526684235;29990.25024374408;22947.148477138224;24037.51924961526;24089.879550602134;24313;24404.75595244025 00:55:03 INFO - PROCESS | 26713 | |2;jquery.html;464.5493870945182;464.91863923813327;473.8815296175956;484.37757481636083;487.31146577110314;20113.798862011394;20274.89862550687;21874.2344017959;22044.88977555114;22194.778052219473;21517.784822151774;22082.668759968572;22603.54792904145;22655.660165097535;22661.546769064607;6640.56836305641;6657.80159571277;6665.266820649725;6741;6839.62382068986;6681;6784.050232967388;6786.762463313785;6790.6944187511435;6797.728090876359;6521.576097553668;6675;6715.529912906074;6719.966400168017;6727.394534491895;6544.411003009752;6699.76550820719;6768.695408706595;6809.727610895583;6820.079289295931;6584.93415065848;6585.2097748270035;6589.967050164766;6591.143151390289;6591.802245932629;25098.874505627355;25522.489550209077;25690.74309256921;25819.225423237334;26217.868910655325;3602.425395315659;3649;3650.4341827016856;3754.3429899767702;3775.5469343678933;16104.59738506535;16344.67310653792;16613.584660383465;16670.58323541921;17353.132343382906;2301.3326135420707;2371.5612611666897;2386.2841147655636;2425.4906469641396;2591.598302263152;118280;122420.38789806083;123247;124006.37996810049;124230.75769242282;17964.640707186045;18560.535986600175;18705.251789928523;18832.529186770167;18864.245430182913;31224.843875780476;31302.686973129978;31333.529997050064;31333.903313383922;31362.843185783924;10717.303375280582;10884.40135792539;11001.119910407147;11040.944795275973;11378.374189419495;9368.4378937264;9382.812343753087;9390.624375024923;9567.234621230285;9593.520323983774;9344.2524598032;9536.521839114948;9583.904160958302;9734.36726612768;9781.972892846148;3423.400904841643;3807.1053302473897;3815.8473661053804;3858.2283543291455;3885.4754608128105;933.3186773655269;943.3490891285129;948.3029972969862;948.3456415073715;950.3110245072268;18026.45920622357;18692.81307186938;19115.61768764617;19212.135453904608;19220.231190752493;947.8862536495527;958.6069711418285;963.0513943765385;964.9035096490435;978.2467500024941;10073.899261007296;11056.447177641086;11067.833982490269;11179.4969226385;11203.887961120448;799920;805035;811612;812387;845156;79505.60247198727;83743;95495.52252238833;104909.47545262225;109933.45033274783;1183.260462211118;1326.204277433532;1337.571976967361;1341.3829638366265;1358.3887250737207;18470.445886623424;18725.625487489902;18904.621907562047;19085.141168647722;19414.2234310626;48960;49027.019459609895;49606.751966239935;49825.252621209984;49916;62240.37759622346;63690;73243;75099.24900750922;76303;12553.686157846127;13157.473701051851;13199.868001319865;13249.801252981406;13506.189628621922;14149.646258843199;14285.357158927665;14432.639184020483;14667.853321467075;14782.48261310849;11974.161808673658;12258.20321679088;12435.689107772016;13132.540361087316;13142.540011099949;11543.422828858356;11880.405979701154;11891.167618266983;11915.761684766083;12236.082293828176;12280.140390172603;12365.876341236832;12371.876281237073;12454.750904982031;12593.496260149857;12811.359432028548;12863.29251891155;12888.226706397647;13072.869271307545;13086;12093.093018023508;12498.75002499963;12610.369481525704;12810.359482025675;12816.487340506275 00:55:03 INFO - PROCESS | 26713 | |3;mootools.html;1555.2223888055971;1558.8285288618258;1599.7280462321407;1600.5518454832647;1615.1278309712757;10785.245032847693;11540.71148221295;11553.422328883564;11556.768864622703;11557.479913403897;11347.148963827705;11393.886061139387;11550.595729149481;11577.53689852407;11587.362695051768;2473.0849585653245;2519.0553542421594;2525.9747402526014;2543.465872166847;2550.1457011901034;2418.262429958862;2483.056438553347;2516.798656107507;2531.1900191938494;2536.1123606737588;2490.2778194323714;2515.295717199178;2529.9241022769256;2545.3891066144083;2548.388386787167;2362.3739708977137;2443.9389015274583;2449.106076282162;2483.4784695214025;2505.9373515662073;2388.996621419008;2414.408469924862;2416.5046165536023;2426.8786560672074;2429.842060266095;11457.796931322175;11667.708307292301;11668.94165529167;11695.35675537845;11705.063594912386;6007.098935159717;6153.4154255345675;6155.138280640714;6161.907571386433;6168.44483996438;3601.441776524643;3626.7642603230706;3671.3942199537046;3798;3829.7510661807173;1364.8089267502558;1367.787992861108;1416.2140012293173;2291.667708182321;2401.267613377919;15567.532974010797;15933.283002264925;16451;17091.145442727815;17158.656826863516;4765.927666275061;4838;4955.801767929314;4958.578520825698;4986.700797952134;12736.490540378467;12857.807132893015;12859.42132604035;12860.742785144244;12867.48530058806;6115.082737589397;6119.724612392453;6135.263768347827;6142.232220972379;6144.016957286813;5473.644213126134;5566.693831839288;5622.634528755618;5727.828165155052;5738.655680659173;4111.075008123148;4166.91606312724;4182.644475219579;4199.580041995776;4211.7051806373875;1129.282905355089;1133.2747041893194;1152.4353066997112;1153.5501154549731;1155.0874808901042;938.2587755673078;944.4852555357347;965.4689920543673;988.0564061321421;1086.9619563315246;7445.704247844153;7741.148473667892;7783.455158138876;7933.127355990837;7937.3650107991225;1108.4734750993375;1118.3848883114417;1134.9602763903224;1143.2111842828422;1158.8841115888345;4755.95244047562;4771.165046116985;4909.656324057353;4936.136176169156;5026.472220416804;14244.715105698035;14349.282535873164;14753.262336883114;14768.556943291718;14774.40902363915;14339.211343376006;14549.12705237668;14569.053011554428;14597.635059123606;14601.56195314121;9593.088656577474;10922.617708380327;11215.887841121485;11307.660770176908;11311.038561722346;6821.2155602106395;7501.174870764321;7641.579713115832;7648.732294369893;7774.883376749241;12941.741165176833;12947.805782913452;13267.270300133585;13428.865711343153;13707.520236791665;13555.525556605866;13589.79615305791;13729.313534323444;13805.447782088604;14011.929940350234;9779.511024448891;10073.546690399096;10084.294099413264;10099.14157296638;10099.293049486465;10745.946270268598;10959.616413425492;11081;11126.666200014013;11210.159238057342;9241.768955776159;9368.67209647659;9392.859107113536;9506.762330941781;9731.56207970629;9001.369904106912;9084.954575227082;9090.318226132935;9306.906930930603;9389.530523473662;7883.802904927423;7962.601869906597;7973.401994850526;7985.800354991172;8013.63938622775;6541.738330466728;6733.966330168318;6821.556598821061;6874.828129296808;6880.4839637026425;6902;6980.057692211486;7001.50989430735;7001.684924178322;7111.964440177766 00:55:03 INFO - PROCESS | 26713 | |4;prototype.html;422.85200179937004;425.69562762624736;442.80737879022627;452.6605046215336;458.9839355622553;5338.092524270874;5354.705491197988;5377.650452720575;5385.865353366168;5389.865253368668;5143.794248230076;5215.817446389377;5243.947560524393;5282.7358632068335;5316.617679403364;4403.471583409987;4407.625351845081;4480.372747815309;4489.506154323039;4502.212112880233;4465.441819772528;4469.664775141861;4482;4492.191405547001;4506.97746511267;4318.136372725452;4419.558044195587;4440.911181776379;4443.911121777579;4531.342955271483;4395.978020109911;4399;4418.889527761799;4419.226635338819;4448.799804008828;4173.728707634024;4204.411382406465;4204.73857842646;4220.36694495825;4249.32010878258;5065.214891691794;5153.2270159476;5168;5243.2659427680155;5360.758765855546;5115.590752739772;5152.407473140599;5154.613403994716;5193.246979187997;5228.065615722169;5599.300087489064;5637.985162670718;5643.294588176478;5663.32040155184;5685.919675261728;4493.41585593874;4618.314315274934;4662.3705799716945;4669.2062349400685;4688.929666055012;5539.41836107211;5539.806106786243;5706.172604972297;5745.190265066532;5786.913196302059;4759.714417134914;4766.380370551806;4791.754143922605;4797.760111994457;4826.8069277228515;4668.5798278155125;4715.457722361973;4716.080364328923;4882.170031094723;4908.165611845995;5126.359205099363;5150.459201783834;5153.2785410042625;5168.932427029218;5250.868728281824;5525.4474552544425;5581.2186293918885;5605.327360716658;5625.396761922832;5636.436356364413;1612.129450096958;1680.1935071165908;1682.973386234396;1684.0400971446159;1689.9408520701716;1268.5813681485088;1284.991281843748;1295.2346739710786;1295.863934286905;1311.7048664050703;5469.425710300441;5475.589330800206;5488.506034456838;5522.392536820947;5527.369426019334;5670.432956704297;5716.399778023248;5734.455226753452;5746.827595172152;5763;5275.73382388224;5402.621816472888;5443.537299329522;5507.476789704971;5545.9722701387045;2996.0562422837174;3004.444177827109;3013.8794448221824;3026.137550798012;3026.8940587079787;5642.830715078554;5908.691132965553;5929.37741537141;5931.673757943268;5942.405759424109;5761.337446193657;5767.88464230713;5780.624259423124;5794.652320860761;5846.649201047866;5872.853178670482;5940.435658612425;5957.970210148921;5971.611845230133;6007.459328660354;5565.189579262446;5653.840962602739;5682.886342273214;5731.369549349652;5789.884202315846;5438.320209973754;5535.640183388067;5545.279113715191;5643.3792282848035;5656.85857853557;5875.735591898289;5894.8799728053245;5900.940990590039;5943.444318942896;5950.821475355746;4569.81720731167;4751.790417455762;4757.238841785298;4763.404574428197;4805.303231031551;5619.679375346872;5654;5686.886262274814;5704.401037891128;5713.571981714204;5549.5837812165055;5569.248151499496;5593.524550413098;5630.915536267041;5642.605017648725;5348.465153484776;5550.750216240198;5558.610897237155;5575.386707462095;5579.414161512983;5527.778888844562;5528;5531;5535.446455354432;5560.221568980265;5374.973125134506;5578.665280083208;5595.972020139873;5618.606697531133;5640.971795140998;5447.210154527492;5461.8803145355905;5476.780928762805;5479.53423958952;5495.395506494203 00:55:03 INFO - PROCESS | 26713 | |5;yui.html;834.6119054639591;847.9067302596713;900.6593581188433;907.3512438606397;929.9166471061218;17025.489235322944;18024;18827.52931176718;19118.80881191186;19121.330753423634;16978;17324.133793310346;17340.046297453635;17464.912675436604;17465.301387944466;875.4528419737663;893.6872094766828;922.4972390047407;925.3383830561147;927.1609193679731;896.8565029595266;898.0839543665458;902.165496915354;915.5330781301551;916.5554705967601;973.0804389851593;976.8290549153905;977.5991843344231;979.4661909259471;979.9559019844088;960.7406000379929;961.7932144588947;962;962.0908241711585;962.4369743699979;704.211283362632;707.5012116457937;707.6815433055094;709.9325564071456;712.654362634122;18613.7207941881;18693.439196824118;18821.24715011398;19084;19300;16356.1004144772;16656.83343166565;16856.157192140465;16954;17386.391476298268;12171.14801963863;13823.170609763447;14253.429862805475;14331.570052898429;14429.783553246709;4851.199552073904;4880.219164933594;4926;5110.412302585176;5112.718800465973;78613.21386786117;79663.6016819918;80609.59695201545;80841.59579202125;81567.59216203881;12495.187812792139;12495.750084998432;12508.937455312665;12648.557300494622;12705;21865.12539498434;21875.78124218769;21906.561868762856;21906.89046554757;22239.777602224094;8319.084900660922;8463.74608761738;8479.872801907977;8624.827503449897;8692.217700406867;4933.55597996182;5005.624578156653;5021.949780502221;5056.494350564914;5179.741012949337;3623.836927338276;3682.668559829628;3705.6850167735506;3741.3265612190066;3746.269477451871;652.2857471069171;652.7682672651235;655.5411212151513;658.5554750543364;669.4209508774875;644.091830518966;657.7336178847575;660.1451120798578;668.1347654787062;678.6538865178794;10781.353118812896;11501.208235975402;11546.01858841991;11774.293542387484;11889.227200231957;772.2470591173673;775.1628241499168;795.4710117771733;798.6964953317819;800.7357572001225;5303.628745987744;5327.3074500314715;5331.840044798662;5343.7862485500145;5413.2150838128255;82540.58729706313;83237;83359;83526.58236708777;87180.56409718038;76166.61916690381;76209.85685214726;76957;79191;79555.60222198852;65830;66403;67217.66391168012;67571.98642020374;69315.30684693088;9780.462074585967;10221.43782091992;10320.12278956267;10346.896531034594;10375.169986400919;45697.77151114223;45750.313745294516;46730.29904551367;46862.76568617135;47479.287810683556;54812.725936370065;54867.45132548623;54878;55070;56533.434665654466;11161.162912781736;11273.436328183721;11275.32348059119;11334.489947952527;11511.884881151416;13891.305434728021;13895;14022;14119.082259653089;14185.503507377192;13126.278054707083;13320.467181313026;13350;13778;14030.508932187324;13089.803652945024;13164.14433061848;13198.274094924871;13520.526781562598;13737.038407311393;12994.675133121747;13008.739825203633;13014.349282535646;13023.283719395145;13136.60590182296;10349.430781307101;10385.792284154426;10514.211434142317;10679.946600266949;10722.088622467178;10698.197635177548;11279.492422841156;11303.321800691985;11353.545858165911;11484.36835973996 00:55:03 INFO - PROCESS | 26713 | __end_tp_report 00:55:03 INFO - PROCESS | 26713 | __start_cc_report 00:55:03 INFO - PROCESS | 26713 | _x_x_mozilla_cycle_collect,1087 00:55:03 INFO - PROCESS | 26713 | __end_cc_report 00:55:03 INFO - PROCESS | 26713 | __startTimestamp1495094103859__endTimestamp 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | ------- Summary: start ------- 00:55:03 INFO - PROCESS | 26713 | Number of tests: 6 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#0] dojo.html Cycles:165 Average:5783.34 Median:6069.15 stddev:667.96 (11.0%) stddev-sans-first:642.21 00:55:03 INFO - PROCESS | 26713 | Values: 3352.3 3366.2 3393.4 3416.6 3430.9 5685.2 5771.9 5776.1 5784.0 5793.9 5806.7 5848.1 5872.5 5874.9 5881.2 5213.4 5247.9 5261.4 5264.3 5318.5 5121.3 5159.6 5335.8 5350.3 5353.1 5209.9 5229.8 5232.3 5253.5 5255.5 5308.8 5317.4 5318.1 5319.2 5320.3 5094.5 5175.2 5239.0 5291.2 5302.6 5718.7 5762.5 5800.3 5804.4 5818.8 6199.1 6269.3 6281.6 6289.5 6289.7 6325.1 6326.1 6335.7 6337.9 6346.8 5725.5 5756.2 5760.5 5780.4 5783.4 6334.2 6335.0 6338.2 6339.0 6339.5 6028.6 6086.1 6088.6 6093.1 6097.7 6034.8 6102.9 6107.8 6140.4 6205.8 6144.1 6162.1 6168.3 6170.6 6182.0 6069.8 6109.5 6109.8 6112.1 6172.4 4608.4 4692.0 4699.1 4703.0 4703.7 4213.2 4221.9 4228.5 4231.7 4233.9 6050.5 6050.5 6052.0 6053.7 6087.2 6123.7 6153.9 6266.6 6297.8 6304.6 5956.7 5979.8 6036.9 6078.8 6096.8 5319.2 5321.6 5324.1 5326.7 5330.1 6309.9 6371.6 6379.5 6427.7 6457.3 6164.8 6182.1 6194.3 6196.8 6220.6 6522.5 6526.2 6534.8 6535.9 6541.1 5997.2 6159.0 6174.5 6176.2 6181.2 6113.9 6198.0 6238.3 6247.3 6252.6 6132.4 6167.1 6170.5 6183.2 6184.6 6149.8 6160.0 6163.9 6178.4 6181.1 5905.6 6009.3 6056.6 6089.6 6091.7 6196.8 6205.5 6206.6 6214.7 6215.6 5836.5 6014.9 6040.4 6046.3 6069.2 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#1] ext.html Cycles:180 Average:46205.13 Median:30311.82 stddev:76768.12 (253.3%) stddev-sans-first:76907.74 00:55:03 INFO - PROCESS | 26713 | Values: 787.1 841.8 865.0 907.2 925.4 32198.7 43735.0 44396.3 49198.0 49450.0 45983.8 46072.3 46080.5 46130.8 46181.8 7672.9 7882.2 9231.3 9368.1 9372.8 10661.9 10970.9 10977.6 10980.5 10987.1 11096.4 11134.9 11143.6 11164.2 11175.1 11040.3 11056.7 11103.7 11104.0 11109.2 10795.6 10860.3 10866.2 10880.0 10881.3 44483.8 44563.6 44576.8 44613.3 44632.8 4240.7 4311.1 4358.3 4422.8 4455.0 30794.5 30935.8 31329.5 31408.4 33188.5 4443.6 4470.1 4509.2 4540.4 4578.8 252242.0 253319.0 253395.0 253643.0 254429.0 54714.7 54896.7 55608.4 55634.7 55740.4 57467.4 57577.4 57631.1 57677.7 58327.0 17129.9 17490.5 17491.4 17505.2 17513.6 13440.1 13664.0 15259.8 15459.5 15495.5 14366.0 14369.1 14416.3 14486.6 14508.3 5459.1 5500.9 5526.8 5528.3 5597.8 1021.7 1030.2 1035.8 1039.9 1040.8 28591.4 28935.6 29138.4 29381.6 29430.6 1101.8 1103.7 1106.2 1121.3 1125.0 15600.9 15709.3 15734.4 15800.7 15853.1 310882.0 311079.0 311623.0 311669.0 312080.0 57942.1 58066.7 58100.0 58126.7 58218.0 1466.4 1484.4 1519.6 1523.0 1528.3 28866.0 29758.0 30110.2 30160.5 30692.5 40159.6 40256.0 40319.8 40370.4 40378.2 311716.0 312694.0 313492.0 313604.0 314067.0 25860.1 26519.0 29659.4 30131.8 31609.0 39071.2 39141.8 39227.8 39274.0 39815.8 28944.9 29197.0 30216.2 30407.4 30542.0 28342.9 28723.4 28753.3 29087.4 29497.7 34599.7 34883.1 34931.0 34940.1 35384.3 28901.7 29104.3 29230.3 29649.1 29990.3 22947.1 24037.5 24089.9 24313.0 24404.8 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#2] jquery.html Cycles:180 Average:41753.27 Median:13762.18 stddev:133569.51 (970.6%) stddev-sans-first:133908.22 00:55:03 INFO - PROCESS | 26713 | Values: 464.5 464.9 473.9 484.4 487.3 20113.8 20274.9 21874.2 22044.9 22194.8 21517.8 22082.7 22603.5 22655.7 22661.5 6640.6 6657.8 6665.3 6741.0 6839.6 6681.0 6784.1 6786.8 6790.7 6797.7 6521.6 6675.0 6715.5 6720.0 6727.4 6544.4 6699.8 6768.7 6809.7 6820.1 6584.9 6585.2 6590.0 6591.1 6591.8 25098.9 25522.5 25690.7 25819.2 26217.9 3602.4 3649.0 3650.4 3754.3 3775.5 16104.6 16344.7 16613.6 16670.6 17353.1 2301.3 2371.6 2386.3 2425.5 2591.6 118280.0 122420.4 123247.0 124006.4 124230.8 17964.6 18560.5 18705.3 18832.5 18864.2 31224.8 31302.7 31333.5 31333.9 31362.8 10717.3 10884.4 11001.1 11040.9 11378.4 9368.4 9382.8 9390.6 9567.2 9593.5 9344.3 9536.5 9583.9 9734.4 9782.0 3423.4 3807.1 3815.8 3858.2 3885.5 933.3 943.3 948.3 948.3 950.3 18026.5 18692.8 19115.6 19212.1 19220.2 947.9 958.6 963.1 964.9 978.2 10073.9 11056.4 11067.8 11179.5 11203.9 799920.0 805035.0 811612.0 812387.0 845156.0 79505.6 83743.0 95495.5 104909.5 109933.5 1183.3 1326.2 1337.6 1341.4 1358.4 18470.4 18725.6 18904.6 19085.1 19414.2 48960.0 49027.0 49606.8 49825.3 49916.0 62240.4 63690.0 73243.0 75099.2 76303.0 12553.7 13157.5 13199.9 13249.8 13506.2 14149.6 14285.4 14432.6 14667.9 14782.5 11974.2 12258.2 12435.7 13132.5 13142.5 11543.4 11880.4 11891.2 11915.8 12236.1 12280.1 12365.9 12371.9 12454.8 12593.5 12811.4 12863.3 12888.2 13072.9 13086.0 12093.1 12498.8 12610.4 12810.4 12816.5 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#3] mootools.html Cycles:180 Average:7278.04 Median:2486.88 stddev:4513.99 (181.5%) stddev-sans-first:4506.16 00:55:03 INFO - PROCESS | 26713 | Values: 1555.2 1558.8 1599.7 1600.6 1615.1 10785.2 11540.7 11553.4 11556.8 11557.5 11347.1 11393.9 11550.6 11577.5 11587.4 2473.1 2519.1 2526.0 2543.5 2550.1 2418.3 2483.1 2516.8 2531.2 2536.1 2490.3 2515.3 2529.9 2545.4 2548.4 2362.4 2443.9 2449.1 2483.5 2505.9 2389.0 2414.4 2416.5 2426.9 2429.8 11457.8 11667.7 11668.9 11695.4 11705.1 6007.1 6153.4 6155.1 6161.9 6168.4 3601.4 3626.8 3671.4 3798.0 3829.8 1364.8 1367.8 1416.2 2291.7 2401.3 15567.5 15933.3 16451.0 17091.1 17158.7 4765.9 4838.0 4955.8 4958.6 4986.7 12736.5 12857.8 12859.4 12860.7 12867.5 6115.1 6119.7 6135.3 6142.2 6144.0 5473.6 5566.7 5622.6 5727.8 5738.7 4111.1 4166.9 4182.6 4199.6 4211.7 1129.3 1133.3 1152.4 1153.6 1155.1 938.3 944.5 965.5 988.1 1087.0 7445.7 7741.1 7783.5 7933.1 7937.4 1108.5 1118.4 1135.0 1143.2 1158.9 4756.0 4771.2 4909.7 4936.1 5026.5 14244.7 14349.3 14753.3 14768.6 14774.4 14339.2 14549.1 14569.1 14597.6 14601.6 9593.1 10922.6 11215.9 11307.7 11311.0 6821.2 7501.2 7641.6 7648.7 7774.9 12941.7 12947.8 13267.3 13428.9 13707.5 13555.5 13589.8 13729.3 13805.4 14011.9 9779.5 10073.5 10084.3 10099.1 10099.3 10745.9 10959.6 11081.0 11126.7 11210.2 9241.8 9368.7 9392.9 9506.8 9731.6 9001.4 9085.0 9090.3 9306.9 9389.5 7883.8 7962.6 7973.4 7985.8 8013.6 6541.7 6734.0 6821.6 6874.8 6880.5 6902.0 6980.1 7001.5 7001.7 7112.0 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#4] prototype.html Cycles:180 Average:4866.20 Median:5381.76 stddev:1289.14 (24.0%) stddev-sans-first:1248.88 00:55:03 INFO - PROCESS | 26713 | Values: 422.9 425.7 442.8 452.7 459.0 5338.1 5354.7 5377.7 5385.9 5389.9 5143.8 5215.8 5243.9 5282.7 5316.6 4403.5 4407.6 4480.4 4489.5 4502.2 4465.4 4469.7 4482.0 4492.2 4507.0 4318.1 4419.6 4440.9 4443.9 4531.3 4396.0 4399.0 4418.9 4419.2 4448.8 4173.7 4204.4 4204.7 4220.4 4249.3 5065.2 5153.2 5168.0 5243.3 5360.8 5115.6 5152.4 5154.6 5193.2 5228.1 5599.3 5638.0 5643.3 5663.3 5685.9 4493.4 4618.3 4662.4 4669.2 4688.9 5539.4 5539.8 5706.2 5745.2 5786.9 4759.7 4766.4 4791.8 4797.8 4826.8 4668.6 4715.5 4716.1 4882.2 4908.2 5126.4 5150.5 5153.3 5168.9 5250.9 5525.4 5581.2 5605.3 5625.4 5636.4 1612.1 1680.2 1683.0 1684.0 1689.9 1268.6 1285.0 1295.2 1295.9 1311.7 5469.4 5475.6 5488.5 5522.4 5527.4 5670.4 5716.4 5734.5 5746.8 5763.0 5275.7 5402.6 5443.5 5507.5 5546.0 2996.1 3004.4 3013.9 3026.1 3026.9 5642.8 5908.7 5929.4 5931.7 5942.4 5761.3 5767.9 5780.6 5794.7 5846.6 5872.9 5940.4 5958.0 5971.6 6007.5 5565.2 5653.8 5682.9 5731.4 5789.9 5438.3 5535.6 5545.3 5643.4 5656.9 5875.7 5894.9 5900.9 5943.4 5950.8 4569.8 4751.8 4757.2 4763.4 4805.3 5619.7 5654.0 5686.9 5704.4 5713.6 5549.6 5569.2 5593.5 5630.9 5642.6 5348.5 5550.8 5558.6 5575.4 5579.4 5527.8 5528.0 5531.0 5535.4 5560.2 5375.0 5578.7 5596.0 5618.6 5641.0 5447.2 5461.9 5476.8 5479.5 5495.4 00:55:03 INFO - PROCESS | 26713 | 00:55:03 INFO - PROCESS | 26713 | [#5] yui.html Cycles:180 Average:18732.91 Median:4903.11 stddev:23778.87 (485.0%) stddev-sans-first:23807.60 00:55:03 INFO - PROCESS | 26713 | Values: 834.6 847.9 900.7 907.4 929.9 17025.5 18024.0 18827.5 19118.8 19121.3 16978.0 17324.1 17340.0 17464.9 17465.3 875.5 893.7 922.5 925.3 927.2 896.9 898.1 902.2 915.5 916.6 973.1 976.8 977.6 979.5 980.0 960.7 961.8 962.0 962.1 962.4 704.2 707.5 707.7 709.9 712.7 18613.7 18693.4 18821.2 19084.0 19300.0 16356.1 16656.8 16856.2 16954.0 17386.4 12171.1 13823.2 14253.4 14331.6 14429.8 4851.2 4880.2 4926.0 5110.4 5112.7 78613.2 79663.6 80609.6 80841.6 81567.6 12495.2 12495.8 12508.9 12648.6 12705.0 21865.1 21875.8 21906.6 21906.9 22239.8 8319.1 8463.7 8479.9 8624.8 8692.2 4933.6 5005.6 5021.9 5056.5 5179.7 3623.8 3682.7 3705.7 3741.3 3746.3 652.3 652.8 655.5 658.6 669.4 644.1 657.7 660.1 668.1 678.7 10781.4 11501.2 11546.0 11774.3 11889.2 772.2 775.2 795.5 798.7 800.7 5303.6 5327.3 5331.8 5343.8 5413.2 82540.6 83237.0 83359.0 83526.6 87180.6 76166.6 76209.9 76957.0 79191.0 79555.6 65830.0 66403.0 67217.7 67572.0 69315.3 9780.5 10221.4 10320.1 10346.9 10375.2 45697.8 45750.3 46730.3 46862.8 47479.3 54812.7 54867.5 54878.0 55070.0 56533.4 11161.2 11273.4 11275.3 11334.5 11511.9 13891.3 13895.0 14022.0 14119.1 14185.5 13126.3 13320.5 13350.0 13778.0 14030.5 13089.8 13164.1 13198.3 13520.5 13737.0 12994.7 13008.7 13014.3 13023.3 13136.6 10349.4 10385.8 10514.2 10679.9 10722.1 10698.2 11279.5 11303.3 11353.5 11484.4 00:55:03 INFO - PROCESS | 26713 | -------- Summary: end -------- 00:55:03 INFO - PROCESS | 26713 | 00:55:04 INFO - TEST-INFO | 26713: exit 0 00:55:04 INFO - TEST-OK | dromaeo_css | took 1114988ms 00:55:04 INFO - TEST-START | kraken 00:55:04 INFO - operating with platform_type : linux_ 00:55:04 INFO - Initialising browser for kraken test... 00:55:04 INFO - TEST-INFO | started process 27022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_D7bO8/profile http://localhost:55693/getInfo.html) 00:55:08 INFO - PROCESS | 27022 | __metrics Screen width/height:1600/1200 00:55:08 INFO - PROCESS | 27022 | colorDepth:24 00:55:08 INFO - PROCESS | 27022 | Browser inner width/height: 1024/697 00:55:08 INFO - PROCESS | 27022 | __metrics 00:55:09 INFO - PROCESS | 27022 | 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" 00:55:09 INFO - PROCESS | 27022 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:55:10 INFO - TEST-INFO | 27022: exit 0 00:55:10 INFO - Browser initialized. 00:55:10 INFO - Running cycle 1/1 for kraken test... 00:55:10 INFO - TEST-INFO | started process 27113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_D7bO8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:22 INFO - PROCESS | 27113 | RSS: Main: 141144064 00:55:22 INFO - PROCESS | 27113 | 00:55:24 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55693/tests/kraken/driver.html?testName=audio-beat-detection) 00:55:25 INFO - PROCESS | 27113 | RSS: Main: 184090624 00:55:25 INFO - PROCESS | 27113 | 00:55:28 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55693/tests/kraken/driver.html?testName=audio-dft) 00:55:28 INFO - PROCESS | 27113 | RSS: Main: 173846528 00:55:28 INFO - PROCESS | 27113 | 00:55:31 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55693/tests/kraken/driver.html?testName=audio-fft) 00:55:32 INFO - PROCESS | 27113 | RSS: Main: 265433088 00:55:32 INFO - PROCESS | 27113 | 00:55:34 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55693/tests/kraken/driver.html?testName=audio-oscillator) 00:55:34 INFO - PROCESS | 27113 | RSS: Main: 171261952 00:55:34 INFO - PROCESS | 27113 | 00:55:37 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:55:37 INFO - PROCESS | 27113 | RSS: Main: 174039040 00:55:37 INFO - PROCESS | 27113 | 00:55:40 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55693/tests/kraken/driver.html?testName=imaging-darkroom) 00:55:41 INFO - PROCESS | 27113 | RSS: Main: 208932864 00:55:41 INFO - PROCESS | 27113 | 00:55:44 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55693/tests/kraken/driver.html?testName=imaging-desaturate) 00:55:45 INFO - PROCESS | 27113 | RSS: Main: 211468288 00:55:45 INFO - PROCESS | 27113 | 00:55:47 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55693/tests/kraken/driver.html?testName=json-parse-financial) 00:55:48 INFO - PROCESS | 27113 | RSS: Main: 211079168 00:55:48 INFO - PROCESS | 27113 | 00:55:50 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:55:50 INFO - PROCESS | 27113 | RSS: Main: 174141440 00:55:50 INFO - PROCESS | 27113 | 00:55:52 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:55:52 INFO - PROCESS | 27113 | RSS: Main: 180764672 00:55:52 INFO - PROCESS | 27113 | 00:55:54 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:55:55 INFO - PROCESS | 27113 | RSS: Main: 190599168 00:55:55 INFO - PROCESS | 27113 | 00:55:58 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:55:58 INFO - PROCESS | 27113 | RSS: Main: 199774208 00:55:58 INFO - PROCESS | 27113 | 00:56:01 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:56:02 INFO - PROCESS | 27113 | RSS: Main: 196165632 00:56:02 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:55693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55693/tests/kraken/driver.html?testName=ai-astar) 00:56:03 INFO - PROCESS | 27113 | RSS: Main: 245776384 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | __start_tp_report 00:56:03 INFO - PROCESS | 27113 | _x_x_mozilla_page_load 00:56:03 INFO - PROCESS | 27113 | _x_x_mozilla_page_load_details 00:56:03 INFO - PROCESS | 27113 | |i|pagename|runs| 00:56:03 INFO - PROCESS | 27113 | |0;ai-astar;114;113;112;112;111;111;111;112;112;113 00:56:03 INFO - PROCESS | 27113 | |1;audio-beat-detection;144;115;116;150;120;119;114;114;129;114 00:56:03 INFO - PROCESS | 27113 | |2;audio-dft;161;161;162;162;160;160;161;161;160;161 00:56:03 INFO - PROCESS | 27113 | |3;audio-fft;77;75;74;105;76;77;76;75;89;75 00:56:03 INFO - PROCESS | 27113 | |4;audio-oscillator;82;81;119;82;82;82;94;83;82;111 00:56:03 INFO - PROCESS | 27113 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;112;113;112 00:56:03 INFO - PROCESS | 27113 | |6;imaging-darkroom;147;146;146;147;146;146;146;147;146;146 00:56:03 INFO - PROCESS | 27113 | |7;imaging-desaturate;93;94;94;95;94;94;94;94;93;94 00:56:03 INFO - PROCESS | 27113 | |8;json-parse-financial;59;54;57;54;55;55;54;56;55;55 00:56:03 INFO - PROCESS | 27113 | |9;json-stringify-tinderbox;54;54;56;55;53;53;54;54;54;54 00:56:03 INFO - PROCESS | 27113 | |10;stanford-crypto-aes;76;75;79;78;79;79;74;79;74;75 00:56:03 INFO - PROCESS | 27113 | |11;stanford-crypto-ccm;123;129;118;129;118;126;125;120;161;131 00:56:03 INFO - PROCESS | 27113 | |12;stanford-crypto-pbkdf2;161;155;155;158;163;158;161;161;168;163 00:56:03 INFO - PROCESS | 27113 | |13;stanford-crypto-sha256-iterative;65;61;61;59;60;62;59;58;58;61 00:56:03 INFO - PROCESS | 27113 | __end_tp_report 00:56:03 INFO - PROCESS | 27113 | __start_cc_report 00:56:03 INFO - PROCESS | 27113 | _x_x_mozilla_cycle_collect,1703 00:56:03 INFO - PROCESS | 27113 | __end_cc_report 00:56:03 INFO - PROCESS | 27113 | __startTimestamp1495094163960__endTimestamp 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | ------- Summary: start ------- 00:56:03 INFO - PROCESS | 27113 | Number of tests: 14 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:0.99 (0.9%) stddev-sans-first:0.78 00:56:03 INFO - PROCESS | 27113 | Values: 114.0 113.0 112.0 112.0 111.0 111.0 111.0 112.0 112.0 113.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:119.50 stddev:13.27 (11.1%) stddev-sans-first:11.82 00:56:03 INFO - PROCESS | 27113 | Values: 144.0 115.0 116.0 150.0 120.0 119.0 114.0 114.0 129.0 114.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 00:56:03 INFO - PROCESS | 27113 | Values: 161.0 161.0 162.0 162.0 160.0 160.0 161.0 161.0 160.0 161.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#3] audio-fft Cycles:10 Average:79.90 Median:76.00 stddev:9.81 (12.9%) stddev-sans-first:10.35 00:56:03 INFO - PROCESS | 27113 | Values: 77.0 75.0 74.0 105.0 76.0 77.0 76.0 75.0 89.0 75.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:13.93 (17.0%) stddev-sans-first:14.49 00:56:03 INFO - PROCESS | 27113 | Values: 82.0 81.0 119.0 82.0 82.0 82.0 94.0 83.0 82.0 111.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:56:03 INFO - PROCESS | 27113 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 112.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 00:56:03 INFO - PROCESS | 27113 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 00:56:03 INFO - PROCESS | 27113 | Values: 93.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 93.0 94.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.58 (2.9%) stddev-sans-first:1.00 00:56:03 INFO - PROCESS | 27113 | Values: 59.0 54.0 57.0 54.0 55.0 55.0 54.0 56.0 55.0 55.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 00:56:03 INFO - PROCESS | 27113 | Values: 54.0 54.0 56.0 55.0 53.0 53.0 54.0 54.0 54.0 54.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:78.50 stddev:2.20 (2.8%) stddev-sans-first:2.32 00:56:03 INFO - PROCESS | 27113 | Values: 76.0 75.0 79.0 78.0 79.0 79.0 74.0 79.0 74.0 75.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:127.50 stddev:12.48 (9.8%) stddev-sans-first:13.11 00:56:03 INFO - PROCESS | 27113 | Values: 123.0 129.0 118.0 129.0 118.0 126.0 125.0 120.0 161.0 131.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:3.97 (2.5%) stddev-sans-first:4.21 00:56:03 INFO - PROCESS | 27113 | Values: 161.0 155.0 155.0 158.0 163.0 158.0 161.0 161.0 168.0 163.0 00:56:03 INFO - PROCESS | 27113 | 00:56:03 INFO - PROCESS | 27113 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.00 stddev:2.12 (3.5%) stddev-sans-first:1.45 00:56:03 INFO - PROCESS | 27113 | Values: 65.0 61.0 61.0 59.0 60.0 62.0 59.0 58.0 58.0 61.0 00:56:03 INFO - PROCESS | 27113 | -------- Summary: end -------- 00:56:03 INFO - PROCESS | 27113 | 00:56:04 INFO - TEST-INFO | 27113: exit 0 00:56:05 INFO - TEST-OK | kraken | took 60439ms 00:56:05 INFO - SUITE-END | took 1175s 00:56:05 INFO - Completed test suite (00:19:35) 00:56:05 INFO - javascript benchmark 00:56:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7931.557107697595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.3127758809446, 3366.2257680733433, 3393.406153923061, 3416.6241713411505, 3430.879919202828, 5685.204071430003, 5771.855703607412, 5776.133579963008, 5783.971080144599, 5793.913091303629, 5806.738696758645, 5848.093545500444, 5872.500837428813, 5874.8544033913295, 5881.235439392884, 5213.3743950725875, 5247.868803279929, 5261.421243663194, 5264.263003179558, 5318.547923426513, 5121.334226550562, 5159.587233021368, 5335.813246536372, 5350.30446042014, 5353.063213937565, 5209.895802083956, 5229.790808367661, 5232.2674825524455, 5253.527182553569, 5255.500727430888, 5308.761105750251, 5317.441668624816, 5318.149096144637, 5319.175527793179, 5320.334958130234, 5094.516020978038, 5175.249588809602, 5238.973805130988, 5291.232771248186, 5302.575793936476, 5718.714064296769, 5762.481376676119, 5800.274965629296, 5804.361520232771, 5818.8254352369495, 6199.058661462523, 6269.279032911228, 6281.623102613812, 6289.496840252768, 6289.748410063592, 6325.14610527582, 6326.114343991845, 6335.651539165344, 6337.87324253517, 6346.841328966767, 5725.513331366838, 5756.222909907151, 5760.539156867399, 5780.393058728857, 5783.421657834267, 6334.1765570475545, 6334.9683251584365, 6338.176037115146, 6339.0, 6339.492840572743, 6028.577999540078, 6086.117512960596, 6088.573799834057, 6093.11649810775, 6097.725602347905, 6034.818955431344, 6102.877942441126, 6107.816765497042, 6140.385961403824, 6205.844853878599, 6144.064619644798, 6162.075688646739, 6168.321484636686, 6170.568060235741, 6182.010878259457, 6069.787557435468, 6109.5112391008615, 6109.816705498843, 6112.083187521907, 6172.351903050205, 4608.423947006624, 4692.0381321828945, 4699.130660827758, 4702.95297047032, 4703.74129422885, 4213.199492096492, 4221.894452638647, 4228.492580890313, 4231.746095234295, 4233.851815186454, 6050.45545900871, 6050.48570871472, 6052.031674932078, 6053.667048312385, 6087.208662873798, 6123.724432400552, 6153.938460615336, 6266.592671476339, 6297.779577714758, 6304.621722696653, 5956.702164891738, 5979.760809567569, 6036.909446358308, 6078.817635470943, 6096.786612468542, 5319.228711836762, 5321.600879934021, 5324.148136298174, 5326.733663316896, 5330.067238233293, 6309.936900630935, 6371.585846920028, 6379.5215358847345, 6427.678616069178, 6457.321981192095, 6164.845878853064, 6182.1345011699295, 6194.349593292639, 6196.845078872884, 6220.595661282002, 6522.543421960418, 6526.24948130971, 6534.771283005072, 6535.934640653532, 6541.08424820516, 5997.190379298739, 6159.045347971071, 6174.475169610454, 6176.166217560572, 6181.227346581677, 6113.932424433873, 6198.0, 6238.282597501164, 6247.281562620356, 6252.624842509464, 6132.41742034506, 6167.105769663284, 6170.475509581556, 6183.165272688309, 6184.567080304336, 6149.754009839735, 6160.0, 6163.938360616516, 6178.351273116258, 6181.103739957771, 5905.586608937333, 6009.308929473166, 6056.606320589148, 6089.573729839046, 6091.664958427152, 6196.752129914753, 6205.47253483459, 6206.627602343874, 6214.658193799384, 6215.627062376272, 5836.474717275466, 6014.9097763534455, 6040.395960403925, 6046.28203018645, 6069.150318955261], "value": 5737.619437916908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.094840932927, 841.8021764885253, 865.0225245472615, 907.1925985872571, 925.4308600210873, 32198.678013219862, 43735.0, 44396.3340549892, 49198.0, 49450.0, 45983.77008114963, 46072.308915366295, 46080.53919460804, 46130.769346153225, 46181.76909115458, 7672.923270767276, 7882.211778822129, 9231.261499080074, 9368.110029547182, 9372.765680857965, 10661.893381066206, 10970.890291097066, 10977.627796525434, 10980.505877235544, 10987.066099381522, 11096.389698566576, 11134.888651113506, 11143.609973650924, 11164.218504704673, 11175.050120739746, 11040.282381645247, 11056.723581910435, 11103.666889993314, 11104.0, 11109.222354435153, 10795.6221532246, 10860.294080884718, 10866.185036122322, 10880.0, 10881.347119172795, 44483.77758111221, 44563.554364456264, 44576.777116114536, 44613.33080003803, 44632.77683611594, 4240.681948853818, 4311.137772445523, 4358.302671572533, 4422.778861056967, 4455.0, 30794.53808192879, 30935.845320773253, 31329.530057049164, 31408.37183256345, 33188.50217246743, 4443.644508439349, 4470.083632855257, 4509.249487245875, 4540.387047748544, 4578.816847326103, 252242.0, 253319.0, 253395.0, 253643.0, 254428.99999999814, 54714.72642636841, 54896.725516372964, 55608.443915560325, 55634.72182639061, 55740.442595574335, 57467.425325746204, 57577.424225757204, 57631.13553296704, 57677.711611442515, 58327.0, 17129.914350428167, 17490.47528574145, 17491.38780142689, 17505.212265448085, 17513.649727005642, 13440.126391784503, 13664.0, 15259.771103433457, 15459.458918937784, 15495.535133946, 14366.0, 14369.06601070927, 14416.279186040656, 14486.565403037926, 14508.274586270643, 5459.12653975362, 5500.889982200333, 5526.778928842801, 5528.253685752452, 5597.776088956478, 1021.667957913681, 1030.1912998296302, 1035.844623306495, 1039.9220058495644, 1040.8178568750438, 28591.42817143687, 28935.56596651052, 29138.417231655672, 29381.559276610868, 29430.558541621464, 1101.8292164714483, 1103.6892201721053, 1106.1869525898458, 1121.2599684208383, 1125.0, 15600.921995390177, 15709.293081811345, 15734.449294274646, 15800.68398632021, 15853.128077955824, 310882.0, 311079.0, 311623.0, 311669.0, 312080.0, 57942.13086803701, 58066.709666451396, 58100.0, 58126.709366453746, 58218.0, 1466.4354223623982, 1484.3617244584716, 1519.574519134644, 1523.0480949406622, 1528.2740698168282, 28866.0, 29758.0, 30110.247243819078, 30160.54759178658, 30692.53961190539, 40159.59840401559, 40256.0, 40319.79840100781, 40370.39444408395, 40378.1924361517, 311716.0, 312694.0, 313492.0, 313604.0, 314067.0, 25860.094896678525, 26519.0, 29659.406811864075, 30131.849340753157, 31609.0, 39071.218575628896, 39141.804290979504, 39227.803860980515, 39274.0, 39815.80092099521, 28944.855275723487, 29197.0, 30216.244593885327, 30407.39185216239, 30542.0, 28342.85828570844, 28723.425531488836, 28753.281167970967, 29087.41825163527, 29497.705022949496, 34599.65400345964, 34883.12792180216, 34931.0, 34940.12649683778, 35384.292314153055, 28901.7109828899, 29104.27239319034, 29230.269243268238, 29649.110526684235, 29990.25024374408, 22947.148477138224, 24037.51924961526, 24089.879550602134, 24313.0, 24404.75595244025], "value": 19103.086393855323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.5493870945182, 464.91863923813327, 473.8815296175956, 484.37757481636083, 487.31146577110314, 20113.798862011394, 20274.89862550687, 21874.2344017959, 22044.88977555114, 22194.778052219473, 21517.784822151774, 22082.668759968572, 22603.54792904145, 22655.660165097535, 22661.546769064607, 6640.56836305641, 6657.80159571277, 6665.266820649725, 6741.0, 6839.62382068986, 6681.0, 6784.050232967388, 6786.762463313785, 6790.6944187511435, 6797.728090876359, 6521.576097553668, 6675.0, 6715.529912906074, 6719.966400168017, 6727.394534491895, 6544.411003009752, 6699.76550820719, 6768.695408706595, 6809.727610895583, 6820.079289295931, 6584.93415065848, 6585.2097748270035, 6589.967050164766, 6591.143151390289, 6591.802245932629, 25098.874505627355, 25522.489550209077, 25690.74309256921, 25819.225423237334, 26217.868910655325, 3602.425395315659, 3649.0, 3650.4341827016856, 3754.3429899767702, 3775.5469343678933, 16104.59738506535, 16344.67310653792, 16613.584660383465, 16670.58323541921, 17353.132343382906, 2301.3326135420707, 2371.5612611666897, 2386.2841147655636, 2425.4906469641396, 2591.598302263152, 118280.0, 122420.38789806083, 123247.0, 124006.37996810049, 124230.75769242282, 17964.640707186045, 18560.535986600175, 18705.251789928523, 18832.529186770167, 18864.245430182913, 31224.843875780476, 31302.686973129978, 31333.529997050064, 31333.903313383922, 31362.843185783924, 10717.303375280582, 10884.40135792539, 11001.119910407147, 11040.944795275973, 11378.374189419495, 9368.4378937264, 9382.812343753087, 9390.624375024923, 9567.234621230285, 9593.520323983774, 9344.2524598032, 9536.521839114948, 9583.904160958302, 9734.36726612768, 9781.972892846148, 3423.400904841643, 3807.1053302473897, 3815.8473661053804, 3858.2283543291455, 3885.4754608128105, 933.3186773655269, 943.3490891285129, 948.3029972969862, 948.3456415073715, 950.3110245072268, 18026.45920622357, 18692.81307186938, 19115.61768764617, 19212.135453904608, 19220.231190752493, 947.8862536495527, 958.6069711418285, 963.0513943765385, 964.9035096490435, 978.2467500024941, 10073.899261007296, 11056.447177641086, 11067.833982490269, 11179.4969226385, 11203.887961120448, 799920.0, 805035.0, 811612.0, 812387.0, 845156.0, 79505.60247198727, 83743.0, 95495.52252238833, 104909.47545262225, 109933.45033274783, 1183.260462211118, 1326.204277433532, 1337.571976967361, 1341.3829638366265, 1358.3887250737207, 18470.445886623424, 18725.625487489902, 18904.621907562047, 19085.141168647722, 19414.2234310626, 48960.0, 49027.019459609895, 49606.751966239935, 49825.252621209984, 49916.0, 62240.37759622346, 63690.0, 73243.0, 75099.24900750922, 76303.0, 12553.686157846127, 13157.473701051851, 13199.868001319865, 13249.801252981406, 13506.189628621922, 14149.646258843199, 14285.357158927665, 14432.639184020483, 14667.853321467075, 14782.48261310849, 11974.161808673658, 12258.20321679088, 12435.689107772016, 13132.540361087316, 13142.540011099949, 11543.422828858356, 11880.405979701154, 11891.167618266983, 11915.761684766083, 12236.082293828176, 12280.140390172603, 12365.876341236832, 12371.876281237073, 12454.750904982031, 12593.496260149857, 12811.359432028548, 12863.29251891155, 12888.226706397647, 13072.869271307545, 13086.0, 12093.093018023508, 12498.75002499963, 12610.369481525704, 12810.359482025675, 12816.487340506275], "value": 11617.053406700546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.2223888055971, 1558.8285288618258, 1599.7280462321407, 1600.5518454832647, 1615.1278309712757, 10785.245032847693, 11540.71148221295, 11553.422328883564, 11556.768864622703, 11557.479913403897, 11347.148963827705, 11393.886061139387, 11550.595729149481, 11577.53689852407, 11587.362695051768, 2473.0849585653245, 2519.0553542421594, 2525.9747402526014, 2543.465872166847, 2550.1457011901034, 2418.262429958862, 2483.056438553347, 2516.798656107507, 2531.1900191938494, 2536.1123606737588, 2490.2778194323714, 2515.295717199178, 2529.9241022769256, 2545.3891066144083, 2548.388386787167, 2362.3739708977137, 2443.9389015274583, 2449.106076282162, 2483.4784695214025, 2505.9373515662073, 2388.996621419008, 2414.408469924862, 2416.5046165536023, 2426.8786560672074, 2429.842060266095, 11457.796931322175, 11667.708307292301, 11668.94165529167, 11695.35675537845, 11705.063594912386, 6007.098935159717, 6153.4154255345675, 6155.138280640714, 6161.907571386433, 6168.44483996438, 3601.441776524643, 3626.7642603230706, 3671.3942199537046, 3798.0, 3829.7510661807173, 1364.8089267502558, 1367.787992861108, 1416.2140012293173, 2291.667708182321, 2401.267613377919, 15567.532974010797, 15933.283002264925, 16451.0, 17091.145442727815, 17158.656826863516, 4765.927666275061, 4838.0, 4955.801767929314, 4958.578520825698, 4986.700797952134, 12736.490540378467, 12857.807132893015, 12859.42132604035, 12860.742785144244, 12867.48530058806, 6115.082737589397, 6119.724612392453, 6135.263768347827, 6142.232220972379, 6144.016957286813, 5473.644213126134, 5566.693831839288, 5622.634528755618, 5727.828165155052, 5738.655680659173, 4111.075008123148, 4166.91606312724, 4182.644475219579, 4199.580041995776, 4211.7051806373875, 1129.282905355089, 1133.2747041893194, 1152.4353066997112, 1153.5501154549731, 1155.0874808901042, 938.2587755673078, 944.4852555357347, 965.4689920543673, 988.0564061321421, 1086.9619563315246, 7445.704247844153, 7741.148473667892, 7783.455158138876, 7933.127355990837, 7937.3650107991225, 1108.4734750993375, 1118.3848883114417, 1134.9602763903224, 1143.2111842828422, 1158.8841115888345, 4755.95244047562, 4771.165046116985, 4909.656324057353, 4936.136176169156, 5026.472220416804, 14244.715105698035, 14349.282535873164, 14753.262336883114, 14768.556943291718, 14774.40902363915, 14339.211343376006, 14549.12705237668, 14569.053011554428, 14597.635059123606, 14601.56195314121, 9593.088656577474, 10922.617708380327, 11215.887841121485, 11307.660770176908, 11311.038561722346, 6821.2155602106395, 7501.174870764321, 7641.579713115832, 7648.732294369893, 7774.883376749241, 12941.741165176833, 12947.805782913452, 13267.270300133585, 13428.865711343153, 13707.520236791665, 13555.525556605866, 13589.79615305791, 13729.313534323444, 13805.447782088604, 14011.929940350234, 9779.511024448891, 10073.546690399096, 10084.294099413264, 10099.14157296638, 10099.293049486465, 10745.946270268598, 10959.616413425492, 11081.0, 11126.666200014013, 11210.159238057342, 9241.768955776159, 9368.67209647659, 9392.859107113536, 9506.762330941781, 9731.56207970629, 9001.369904106912, 9084.954575227082, 9090.318226132935, 9306.906930930603, 9389.530523473662, 7883.802904927423, 7962.601869906597, 7973.401994850526, 7985.800354991172, 8013.63938622775, 6541.738330466728, 6733.966330168318, 6821.556598821061, 6874.828129296808, 6880.4839637026425, 6902.0, 6980.057692211486, 7001.50989430735, 7001.684924178322, 7111.964440177766], "value": 5578.492154939722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.85200179937004, 425.69562762624736, 442.80737879022627, 452.6605046215336, 458.9839355622553, 5338.092524270874, 5354.705491197988, 5377.650452720575, 5385.865353366168, 5389.865253368668, 5143.794248230076, 5215.817446389377, 5243.947560524393, 5282.7358632068335, 5316.617679403364, 4403.471583409987, 4407.625351845081, 4480.372747815309, 4489.506154323039, 4502.212112880233, 4465.441819772528, 4469.664775141861, 4482.0, 4492.191405547001, 4506.97746511267, 4318.136372725452, 4419.558044195587, 4440.911181776379, 4443.911121777579, 4531.342955271483, 4395.978020109911, 4399.0, 4418.889527761799, 4419.226635338819, 4448.799804008828, 4173.728707634024, 4204.411382406465, 4204.73857842646, 4220.36694495825, 4249.32010878258, 5065.214891691794, 5153.2270159476, 5168.0, 5243.2659427680155, 5360.758765855546, 5115.590752739772, 5152.407473140599, 5154.613403994716, 5193.246979187997, 5228.065615722169, 5599.300087489064, 5637.985162670718, 5643.294588176478, 5663.32040155184, 5685.919675261728, 4493.41585593874, 4618.314315274934, 4662.3705799716945, 4669.2062349400685, 4688.929666055012, 5539.41836107211, 5539.806106786243, 5706.172604972297, 5745.190265066532, 5786.913196302059, 4759.714417134914, 4766.380370551806, 4791.754143922605, 4797.760111994457, 4826.8069277228515, 4668.5798278155125, 4715.457722361973, 4716.080364328923, 4882.170031094723, 4908.165611845995, 5126.359205099363, 5150.459201783834, 5153.2785410042625, 5168.932427029218, 5250.868728281824, 5525.4474552544425, 5581.2186293918885, 5605.327360716658, 5625.396761922832, 5636.436356364413, 1612.129450096958, 1680.1935071165908, 1682.973386234396, 1684.0400971446159, 1689.9408520701716, 1268.5813681485088, 1284.991281843748, 1295.2346739710786, 1295.863934286905, 1311.7048664050703, 5469.425710300441, 5475.589330800206, 5488.506034456838, 5522.392536820947, 5527.369426019334, 5670.432956704297, 5716.399778023248, 5734.455226753452, 5746.827595172152, 5763.0, 5275.73382388224, 5402.621816472888, 5443.537299329522, 5507.476789704971, 5545.9722701387045, 2996.0562422837174, 3004.444177827109, 3013.8794448221824, 3026.137550798012, 3026.8940587079787, 5642.830715078554, 5908.691132965553, 5929.37741537141, 5931.673757943268, 5942.405759424109, 5761.337446193657, 5767.88464230713, 5780.624259423124, 5794.652320860761, 5846.649201047866, 5872.853178670482, 5940.435658612425, 5957.970210148921, 5971.611845230133, 6007.459328660354, 5565.189579262446, 5653.840962602739, 5682.886342273214, 5731.369549349652, 5789.884202315846, 5438.320209973754, 5535.640183388067, 5545.279113715191, 5643.3792282848035, 5656.85857853557, 5875.735591898289, 5894.8799728053245, 5900.940990590039, 5943.444318942896, 5950.821475355746, 4569.81720731167, 4751.790417455762, 4757.238841785298, 4763.404574428197, 4805.303231031551, 5619.679375346872, 5654.0, 5686.886262274814, 5704.401037891128, 5713.571981714204, 5549.5837812165055, 5569.248151499496, 5593.524550413098, 5630.915536267041, 5642.605017648725, 5348.465153484776, 5550.750216240198, 5558.610897237155, 5575.386707462095, 5579.414161512983, 5527.778888844562, 5528.0, 5531.0, 5535.446455354432, 5560.221568980265, 5374.973125134506, 5578.665280083208, 5595.972020139873, 5618.606697531133, 5640.971795140998, 5447.210154527492, 5461.8803145355905, 5476.780928762805, 5479.53423958952, 5495.395506494203], "value": 4495.51946564985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.6119054639591, 847.9067302596713, 900.6593581188433, 907.3512438606397, 929.9166471061218, 17025.489235322944, 18024.0, 18827.52931176718, 19118.80881191186, 19121.330753423634, 16978.0, 17324.133793310346, 17340.046297453635, 17464.912675436604, 17465.301387944466, 875.4528419737663, 893.6872094766828, 922.4972390047407, 925.3383830561147, 927.1609193679731, 896.8565029595266, 898.0839543665458, 902.165496915354, 915.5330781301551, 916.5554705967601, 973.0804389851593, 976.8290549153905, 977.5991843344231, 979.4661909259471, 979.9559019844088, 960.7406000379929, 961.7932144588947, 962.0, 962.0908241711585, 962.4369743699979, 704.211283362632, 707.5012116457937, 707.6815433055094, 709.9325564071456, 712.654362634122, 18613.7207941881, 18693.439196824118, 18821.24715011398, 19084.0, 19300.0, 16356.1004144772, 16656.83343166565, 16856.157192140465, 16954.0, 17386.391476298268, 12171.14801963863, 13823.170609763447, 14253.429862805475, 14331.570052898429, 14429.783553246709, 4851.199552073904, 4880.219164933594, 4926.0, 5110.412302585176, 5112.718800465973, 78613.21386786117, 79663.6016819918, 80609.59695201545, 80841.59579202125, 81567.59216203881, 12495.187812792139, 12495.750084998432, 12508.937455312665, 12648.557300494622, 12705.0, 21865.12539498434, 21875.78124218769, 21906.561868762856, 21906.89046554757, 22239.777602224094, 8319.084900660922, 8463.74608761738, 8479.872801907977, 8624.827503449897, 8692.217700406867, 4933.55597996182, 5005.624578156653, 5021.949780502221, 5056.494350564914, 5179.741012949337, 3623.836927338276, 3682.668559829628, 3705.6850167735506, 3741.3265612190066, 3746.269477451871, 652.2857471069171, 652.7682672651235, 655.5411212151513, 658.5554750543364, 669.4209508774875, 644.091830518966, 657.7336178847575, 660.1451120798578, 668.1347654787062, 678.6538865178794, 10781.353118812896, 11501.208235975402, 11546.01858841991, 11774.293542387484, 11889.227200231957, 772.2470591173673, 775.1628241499168, 795.4710117771733, 798.6964953317819, 800.7357572001225, 5303.628745987744, 5327.3074500314715, 5331.840044798662, 5343.7862485500145, 5413.2150838128255, 82540.58729706313, 83237.0, 83359.0, 83526.58236708777, 87180.56409718038, 76166.61916690381, 76209.85685214726, 76957.0, 79191.0, 79555.60222198852, 65830.0, 66403.0, 67217.66391168012, 67571.98642020374, 69315.30684693088, 9780.462074585967, 10221.43782091992, 10320.12278956267, 10346.896531034594, 10375.169986400919, 45697.77151114223, 45750.313745294516, 46730.29904551367, 46862.76568617135, 47479.287810683556, 54812.725936370065, 54867.45132548623, 54878.0, 55070.0, 56533.434665654466, 11161.162912781736, 11273.436328183721, 11275.32348059119, 11334.489947952527, 11511.884881151416, 13891.305434728021, 13895.0, 14022.0, 14119.082259653089, 14185.503507377192, 13126.278054707083, 13320.467181313026, 13350.0, 13778.0, 14030.508932187324, 13089.803652945024, 13164.14433061848, 13198.274094924871, 13520.526781562598, 13737.038407311393, 12994.675133121747, 13008.739825203633, 13014.349282535646, 13023.283719395145, 13136.60590182296, 10349.430781307101, 10385.792284154426, 10514.211434142317, 10679.946600266949, 10722.088622467178, 10698.197635177548, 11279.492422841156, 11303.321800691985, 11353.545858165911, 11484.36835973996], "value": 7796.242258696912, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 116.0, 150.0, 120.0, 119.0, 114.0, 114.0, 129.0, 114.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 105.0, 76.0, 77.0, 76.0, 75.0, 89.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 119.0, 82.0, 82.0, 82.0, 94.0, 83.0, 82.0, 111.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 57.0, 54.0, 55.0, 55.0, 54.0, 56.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 78.0, 79.0, 79.0, 74.0, 79.0, 74.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 118.0, 129.0, 118.0, 126.0, 125.0, 120.0, 161.0, 131.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 155.0, 158.0, 163.0, 158.0, 161.0, 161.0, 168.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 61.0, 59.0, 60.0, 62.0, 59.0, 58.0, 58.0, 61.0], "value": 60.4, "unit": "score"}]}]} 00:56:05 INFO - Return code: 0 00:56:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:56:05 INFO - # TBPL SUCCESS # 00:56:05 INFO - Running post-action listener: _resource_record_post_action 00:56:05 INFO - [mozharness: 2017-05-18 07:56:05.288187Z] Finished run-tests step (success) 00:56:05 INFO - Running post-run listener: _resource_record_post_run 00:56:05 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 325554176; Read time: 0; Write time: 190416 00:56:05 INFO - TinderboxPrint: CPU usage
13.1% 00:56:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:56:05 INFO - TinderboxPrint: I/O write bytes / time
325,554,176 / 190,416 00:56:05 INFO - TinderboxPrint: CPU idle
8,254.0 (86.9%) 00:56:05 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 00:56:05 INFO - TinderboxPrint: Swap in / out
0 / 0 00:56:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 63700992; Read time: 0; Write time: 28820 00:56:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 226476032; Read time: 0; Write time: 107756 00:56:05 INFO - Running post-run listener: _upload_blobber_files 00:56:05 INFO - Blob upload gear active. 00:56:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:56:05 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 00:56:05 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'] 00:56:05 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 00:56:06 INFO - (blobuploader) - INFO - Open directory for files ... 00:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:10 INFO - (blobuploader) - INFO - Done attempting. 00:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:10 INFO - (blobuploader) - INFO - Done attempting. 00:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:11 INFO - (blobuploader) - INFO - Done attempting. 00:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:12 INFO - (blobuploader) - INFO - Done attempting. 00:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 00:56:12 INFO - Return code: 0 00:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85079f8397c21815b5d2d5e0f3674257c05d2f68763382337f903acd2513a097fa4149697b2fe1862f2ee0a0cbba996faba8fbd892fba5d37d97cdb1c323d734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7620a8a3643570c7602851af2893e3ed9de8c4aa5e321b025414b8cfc4a8a76662fa29fc721ed3a37332f47061c61bd01e61e6dddbcc0f153d1d8dc4aaa4a3cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb980c99e503c8832077d75d1a0dda0dd4e22a0ebfbc386c76fbc0dcdc17ed80558ff032209065a14123050e2242437e172a2df959dcd99a646cf206aa0e6363", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/652dd0aab6a1757bb5699ce90e396078a8e8986ad3b1bd54ca9552ba1fab00ad7555c9956d3f2ed5444206495ded654f17d22d0eb60c1f54d37e50c06f8f57ff"} 00:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:56:12 INFO - Contents: 00:56:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85079f8397c21815b5d2d5e0f3674257c05d2f68763382337f903acd2513a097fa4149697b2fe1862f2ee0a0cbba996faba8fbd892fba5d37d97cdb1c323d734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7620a8a3643570c7602851af2893e3ed9de8c4aa5e321b025414b8cfc4a8a76662fa29fc721ed3a37332f47061c61bd01e61e6dddbcc0f153d1d8dc4aaa4a3cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb980c99e503c8832077d75d1a0dda0dd4e22a0ebfbc386c76fbc0dcdc17ed80558ff032209065a14123050e2242437e172a2df959dcd99a646cf206aa0e6363", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/652dd0aab6a1757bb5699ce90e396078a8e8986ad3b1bd54ca9552ba1fab00ad7555c9956d3f2ed5444206495ded654f17d22d0eb60c1f54d37e50c06f8f57ff"} 00:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 00:56:12 INFO - Copying logs to upload dir... 00:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 00:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.232933 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-18 00:56:11.060914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 00:56:11.068196) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 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/85079f8397c21815b5d2d5e0f3674257c05d2f68763382337f903acd2513a097fa4149697b2fe1862f2ee0a0cbba996faba8fbd892fba5d37d97cdb1c323d734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7620a8a3643570c7602851af2893e3ed9de8c4aa5e321b025414b8cfc4a8a76662fa29fc721ed3a37332f47061c61bd01e61e6dddbcc0f153d1d8dc4aaa4a3cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb980c99e503c8832077d75d1a0dda0dd4e22a0ebfbc386c76fbc0dcdc17ed80558ff032209065a14123050e2242437e172a2df959dcd99a646cf206aa0e6363", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/652dd0aab6a1757bb5699ce90e396078a8e8986ad3b1bd54ca9552ba1fab00ad7555c9956d3f2ed5444206495ded654f17d22d0eb60c1f54d37e50c06f8f57ff"} build_url:https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/QiFU9kPdTdWm8pwFhUBZmA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85079f8397c21815b5d2d5e0f3674257c05d2f68763382337f903acd2513a097fa4149697b2fe1862f2ee0a0cbba996faba8fbd892fba5d37d97cdb1c323d734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7620a8a3643570c7602851af2893e3ed9de8c4aa5e321b025414b8cfc4a8a76662fa29fc721ed3a37332f47061c61bd01e61e6dddbcc0f153d1d8dc4aaa4a3cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bb980c99e503c8832077d75d1a0dda0dd4e22a0ebfbc386c76fbc0dcdc17ed80558ff032209065a14123050e2242437e172a2df959dcd99a646cf206aa0e6363", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/652dd0aab6a1757bb5699ce90e396078a8e8986ad3b1bd54ca9552ba1fab00ad7555c9956d3f2ed5444206495ded654f17d22d0eb60c1f54d37e50c06f8f57ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 00:56:11.096213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 00:56:11.096533) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495085182.631347-312814491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 1.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 00:56:12.477019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 00:56:12.477383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 00:56:12.478016) ========= ========= Total master_lag: 1.46 =========